builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1467525962.28 results: success (0) buildid: 20160701065031 builduid: c767f5fb4f57427c8722dbadfbf73505 revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.279491) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.280631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.281415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.877335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.877653) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:06:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.8M=0s 2016-07-02 23:06:03 (89.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125057 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.023783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.024113) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023382 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.076268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:03.076633) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:06:04,058 truncating revision to first 12 chars 2016-07-02 23:06:04,058 Setting DEBUG logging. 2016-07-02 23:06:04,058 attempt 1/10 2016-07-02 23:06:04,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:06:04,662 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039907 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:04.135034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.135962) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.137230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.138164) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.156667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-02 23:06:04.156971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:06:05 INFO - MultiFileLogger online at 20160702 23:06:05 in /builds/slave/test 23:06:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:06:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:06:05 INFO - {'append_to_log': False, 23:06:05 INFO - 'base_work_dir': '/builds/slave/test', 23:06:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:06:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:06:05 INFO - 'branch': 'Mozilla-Beta', 23:06:05 INFO - 'buildbot_json_path': 'buildprops.json', 23:06:05 INFO - 'config_files': ('talos/linux_config.py',), 23:06:05 INFO - 'default_actions': ('clobber', 23:06:05 INFO - 'read-buildbot-config', 23:06:05 INFO - 'download-and-extract', 23:06:05 INFO - 'populate-webroot', 23:06:05 INFO - 'create-virtualenv', 23:06:05 INFO - 'install', 23:06:05 INFO - 'run-tests'), 23:06:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:06:05 INFO - 'download_minidump_stackwalk': True, 23:06:05 INFO - 'download_symbols': 'ondemand', 23:06:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:06:05 INFO - 'tooltool.py': '/tools/tooltool.py', 23:06:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:06:05 INFO - '/tools/misc-python/virtualenv.py')}, 23:06:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:06:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:06:05 INFO - 'installer_path': 'installer.exe', 23:06:05 INFO - 'log_level': 'info', 23:06:05 INFO - 'log_name': 'talos', 23:06:05 INFO - 'log_to_console': True, 23:06:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:06:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:06:05 INFO - 'opt_config_files': (), 23:06:05 INFO - 'pip_index': False, 23:06:05 INFO - 'sps_profile': False, 23:06:05 INFO - 'sps_profile_interval': 0, 23:06:05 INFO - 'suite': 'dromaeojs-e10s', 23:06:05 INFO - 'system_bits': '32', 23:06:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:06:05 INFO - 'title': 'talos-linux64-ix-020', 23:06:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:06:05 INFO - 'use_talos_json': True, 23:06:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:06:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:06:05 INFO - 'work_dir': 'build'} 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running clobber step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: clobber 23:06:05 INFO - rmtree: /builds/slave/test/build 23:06:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:06:05 INFO - Running post-action listener: _resource_record_post_action 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running read-buildbot-config step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: read_buildbot_config 23:06:05 INFO - Using buildbot properties: 23:06:05 INFO - { 23:06:05 INFO - "project": "", 23:06:05 INFO - "product": "firefox", 23:06:05 INFO - "script_repo_revision": "production", 23:06:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:06:05 INFO - "repository": "", 23:06:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:06:05 INFO - "buildid": "20160701065031", 23:06:05 INFO - "pgo_build": "True", 23:06:05 INFO - "basedir": "/builds/slave/test", 23:06:05 INFO - "buildnumber": 80, 23:06:05 INFO - "slavename": "talos-linux64-ix-020", 23:06:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:06:05 INFO - "platform": "ubuntu64_hw", 23:06:05 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:06:05 INFO - "branch": "mozilla-beta", 23:06:05 INFO - "repo_path": "releases/mozilla-beta", 23:06:05 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:06:05 INFO - "stage_platform": "linux64-pgo", 23:06:05 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 23:06:05 INFO - "slavebuilddir": "test" 23:06:05 INFO - } 23:06:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:06:05 INFO - Running post-action listener: _resource_record_post_action 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running download-and-extract step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: download_and_extract 23:06:05 INFO - mkdir: /builds/slave/test/build/tests 23:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:05 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:06:16 INFO - Downloaded 1327 bytes. 23:06:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:16 INFO - Using the following test package requirements: 23:06:16 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:16 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:06:16 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:06:16 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'jsshell-linux-x86_64.zip'], 23:06:16 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:06:16 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:16 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:06:16 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:06:16 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:06:16 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:16 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:06:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:16 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:06:23 INFO - Downloaded 24236612 bytes. 23:06:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:06:24 INFO - Return code: 0 23:06:24 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:24 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:06:36 INFO - Downloaded 24236612 bytes. 23:06:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:06:38 INFO - Return code: 0 23:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:38 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:06:40 INFO - Downloaded 10840145 bytes. 23:06:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:06:40 INFO - Return code: 0 23:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:40 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:06:42 INFO - Downloaded 56023399 bytes. 23:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:42 INFO - mkdir: /builds/slave/test/properties 23:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 23:06:42 INFO - Contents: 23:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:42 INFO - Running post-action listener: _resource_record_post_action 23:06:42 INFO - Running post-action listener: set_extra_try_arguments 23:06:42 INFO - ##### 23:06:42 INFO - ##### Running populate-webroot step. 23:06:42 INFO - ##### 23:06:42 INFO - Running pre-action listener: _resource_record_pre_action 23:06:42 INFO - Running main action method: populate_webroot 23:06:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:06:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:06:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:06:42 INFO - '--tppagecycles', 23:06:42 INFO - '7'], 23:06:42 INFO - 'tests': ['tsvgm']}}, 23:06:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:06:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:06:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:06:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:06:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['damp', 'tps']}, 23:06:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'tests': ['damp', 'tps']}, 23:06:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['dromaeo_dom']}, 23:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:06:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['a11yr', 23:06:42 INFO - 'ts_paint', 23:06:42 INFO - 'tpaint', 23:06:42 INFO - 'sessionrestore', 23:06:42 INFO - 'sessionrestore_no_auto_restore', 23:06:42 INFO - 'tabpaint']}, 23:06:42 INFO - 'other-e10s': {'tests': ['a11yr', 23:06:42 INFO - 'ts_paint', 23:06:42 INFO - 'tpaint', 23:06:42 INFO - 'sessionrestore', 23:06:42 INFO - 'sessionrestore_no_auto_restore', 23:06:42 INFO - 'tabpaint']}, 23:06:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:06:42 INFO - 'ts_paint', 23:06:42 INFO - 'tpaint', 23:06:42 INFO - 'sessionrestore', 23:06:42 INFO - 'sessionrestore_no_auto_restore', 23:06:42 INFO - 'tabpaint']}, 23:06:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:06:42 INFO - 'ts_paint', 23:06:42 INFO - 'tpaint', 23:06:42 INFO - 'sessionrestore', 23:06:42 INFO - 'sessionrestore_no_auto_restore', 23:06:42 INFO - 'tabpaint']}, 23:06:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['a11yr', 23:06:42 INFO - 'ts_paint', 23:06:42 INFO - 'tpaint', 23:06:42 INFO - 'sessionrestore', 23:06:42 INFO - 'sessionrestore_no_auto_restore', 23:06:42 INFO - 'tabpaint']}, 23:06:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['a11yr', 23:06:42 INFO - 'ts_paint', 23:06:42 INFO - 'tpaint', 23:06:42 INFO - 'sessionrestore', 23:06:42 INFO - 'sessionrestore_no_auto_restore', 23:06:42 INFO - 'tabpaint']}, 23:06:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['tsvgx', 23:06:42 INFO - 'tsvgr_opacity', 23:06:42 INFO - 'tart', 23:06:42 INFO - 'tscrollx', 23:06:42 INFO - 'cart']}, 23:06:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:06:42 INFO - 'tsvgr_opacity', 23:06:42 INFO - 'tart', 23:06:42 INFO - 'tscrollx', 23:06:42 INFO - 'cart']}, 23:06:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'talos_options': ['--disable-e10s'], 23:06:42 INFO - 'tests': ['tp5o']}, 23:06:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'tests': ['tp5o']}, 23:06:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'talos_options': ['--disable-e10s', 23:06:42 INFO - '--xperf_path', 23:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:42 INFO - 'tests': ['tp5n']}, 23:06:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:42 INFO - 'talos_options': ['--xperf_path', 23:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:42 INFO - 'tests': ['tp5n']}}, 23:06:42 INFO - 'talos.zip': {'path': '', 23:06:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:06:42 INFO - Running post-action listener: _resource_record_post_action 23:06:42 INFO - ##### 23:06:42 INFO - ##### Running create-virtualenv step. 23:06:42 INFO - ##### 23:06:42 INFO - Running pre-action listener: _resource_record_pre_action 23:06:42 INFO - Running main action method: create_virtualenv 23:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 23:06:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:06:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:06:43 INFO - Using real prefix '/usr' 23:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:43 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:45 INFO - Installing pip.................done. 23:06:45 INFO - Return code: 0 23:06:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:06:45 INFO - Using env: {'DISPLAY': ':0', 23:06:45 INFO - 'HOME': '/home/cltbld', 23:06:45 INFO - 'LANG': 'en_US.UTF-8', 23:06:45 INFO - 'LANGUAGE': 'en_US:en', 23:06:45 INFO - 'LOGNAME': 'cltbld', 23:06:45 INFO - 'MAIL': '/var/mail/cltbld', 23:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:45 INFO - 'MOZ_NO_REMOTE': '1', 23:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:45 INFO - 'NO_EM_RESTART': '1', 23:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:45 INFO - 'PWD': '/builds/slave/test', 23:06:45 INFO - 'SHELL': '/bin/bash', 23:06:45 INFO - 'SHLVL': '1', 23:06:45 INFO - 'TERM': 'linux', 23:06:45 INFO - 'TMOUT': '86400', 23:06:45 INFO - 'USER': 'cltbld', 23:06:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:45 INFO - '_': '/tools/buildbot/bin/python'} 23:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:06:45 INFO - Cleaning up... 23:06:45 INFO - Return code: 0 23:06:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:06:45 INFO - Using env: {'DISPLAY': ':0', 23:06:45 INFO - 'HOME': '/home/cltbld', 23:06:45 INFO - 'LANG': 'en_US.UTF-8', 23:06:45 INFO - 'LANGUAGE': 'en_US:en', 23:06:45 INFO - 'LOGNAME': 'cltbld', 23:06:45 INFO - 'MAIL': '/var/mail/cltbld', 23:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:45 INFO - 'MOZ_NO_REMOTE': '1', 23:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:45 INFO - 'NO_EM_RESTART': '1', 23:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:45 INFO - 'PWD': '/builds/slave/test', 23:06:45 INFO - 'SHELL': '/bin/bash', 23:06:45 INFO - 'SHLVL': '1', 23:06:45 INFO - 'TERM': 'linux', 23:06:45 INFO - 'TMOUT': '86400', 23:06:45 INFO - 'USER': 'cltbld', 23:06:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:45 INFO - '_': '/tools/buildbot/bin/python'} 23:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:45 INFO - Downloading/unpacking psutil>=0.7.1 23:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:47 INFO - Installing collected packages: psutil 23:06:47 INFO - Running setup.py install for psutil 23:06:47 INFO - building 'psutil._psutil_linux' extension 23:06:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:06:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:06:48 INFO - building 'psutil._psutil_posix' extension 23:06:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:06:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:48 INFO - Successfully installed psutil 23:06:48 INFO - Cleaning up... 23:06:48 INFO - Return code: 0 23:06:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:06:48 INFO - Using env: {'DISPLAY': ':0', 23:06:48 INFO - 'HOME': '/home/cltbld', 23:06:48 INFO - 'LANG': 'en_US.UTF-8', 23:06:48 INFO - 'LANGUAGE': 'en_US:en', 23:06:48 INFO - 'LOGNAME': 'cltbld', 23:06:48 INFO - 'MAIL': '/var/mail/cltbld', 23:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:48 INFO - 'MOZ_NO_REMOTE': '1', 23:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:48 INFO - 'NO_EM_RESTART': '1', 23:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:48 INFO - 'PWD': '/builds/slave/test', 23:06:48 INFO - 'SHELL': '/bin/bash', 23:06:48 INFO - 'SHLVL': '1', 23:06:48 INFO - 'TERM': 'linux', 23:06:48 INFO - 'TMOUT': '86400', 23:06:48 INFO - 'USER': 'cltbld', 23:06:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:48 INFO - '_': '/tools/buildbot/bin/python'} 23:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:06:50 INFO - Installing collected packages: mozsystemmonitor 23:06:50 INFO - Running setup.py install for mozsystemmonitor 23:06:50 INFO - Successfully installed mozsystemmonitor 23:06:50 INFO - Cleaning up... 23:06:50 INFO - Return code: 0 23:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:06:50 INFO - Using env: {'DISPLAY': ':0', 23:06:50 INFO - 'HOME': '/home/cltbld', 23:06:50 INFO - 'LANG': 'en_US.UTF-8', 23:06:50 INFO - 'LANGUAGE': 'en_US:en', 23:06:50 INFO - 'LOGNAME': 'cltbld', 23:06:50 INFO - 'MAIL': '/var/mail/cltbld', 23:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:50 INFO - 'MOZ_NO_REMOTE': '1', 23:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:50 INFO - 'NO_EM_RESTART': '1', 23:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:50 INFO - 'PWD': '/builds/slave/test', 23:06:50 INFO - 'SHELL': '/bin/bash', 23:06:50 INFO - 'SHLVL': '1', 23:06:50 INFO - 'TERM': 'linux', 23:06:50 INFO - 'TMOUT': '86400', 23:06:50 INFO - 'USER': 'cltbld', 23:06:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:50 INFO - '_': '/tools/buildbot/bin/python'} 23:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:53 INFO - Downloading docopt-0.6.1.tar.gz 23:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:53 INFO - Running setup.py install for blobuploader 23:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:53 INFO - Running setup.py install for requests 23:06:54 INFO - Running setup.py install for docopt 23:06:54 INFO - Successfully installed blobuploader requests docopt 23:06:54 INFO - Cleaning up... 23:06:54 INFO - Return code: 0 23:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:06:54 INFO - Using env: {'DISPLAY': ':0', 23:06:54 INFO - 'HOME': '/home/cltbld', 23:06:54 INFO - 'LANG': 'en_US.UTF-8', 23:06:54 INFO - 'LANGUAGE': 'en_US:en', 23:06:54 INFO - 'LOGNAME': 'cltbld', 23:06:54 INFO - 'MAIL': '/var/mail/cltbld', 23:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:54 INFO - 'MOZ_NO_REMOTE': '1', 23:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:54 INFO - 'NO_EM_RESTART': '1', 23:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:54 INFO - 'PWD': '/builds/slave/test', 23:06:54 INFO - 'SHELL': '/bin/bash', 23:06:54 INFO - 'SHLVL': '1', 23:06:54 INFO - 'TERM': 'linux', 23:06:54 INFO - 'TMOUT': '86400', 23:06:54 INFO - 'USER': 'cltbld', 23:06:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:54 INFO - '_': '/tools/buildbot/bin/python'} 23:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:54 INFO - Running setup.py (path:/tmp/pip-7E2MMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:54 INFO - Running setup.py (path:/tmp/pip-JaH2dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:54 INFO - Running setup.py (path:/tmp/pip-r4dElA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:54 INFO - Running setup.py (path:/tmp/pip-GDEvKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:54 INFO - Running setup.py (path:/tmp/pip-w8Fo6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:54 INFO - Running setup.py (path:/tmp/pip-ZBFe9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:54 INFO - Running setup.py (path:/tmp/pip-HRM49F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:54 INFO - Running setup.py (path:/tmp/pip-_zKL3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:55 INFO - Running setup.py (path:/tmp/pip-VF0lfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:55 INFO - Running setup.py (path:/tmp/pip-VTKoRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:55 INFO - Running setup.py (path:/tmp/pip-WzMso_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:55 INFO - Running setup.py (path:/tmp/pip-eskSE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:55 INFO - Running setup.py (path:/tmp/pip-3TzIhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:55 INFO - Running setup.py (path:/tmp/pip-YWV0Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:55 INFO - Running setup.py (path:/tmp/pip-jqZvGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:55 INFO - Running setup.py (path:/tmp/pip-3zwkoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:55 INFO - Running setup.py (path:/tmp/pip-t_aFtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:55 INFO - Running setup.py install for manifestparser 23:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:55 INFO - Running setup.py install for mozcrash 23:06:55 INFO - Running setup.py install for mozdebug 23:06:55 INFO - Running setup.py install for mozdevice 23:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Running setup.py install for mozfile 23:06:56 INFO - Running setup.py install for mozhttpd 23:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Running setup.py install for mozinfo 23:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Running setup.py install for mozInstall 23:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Running setup.py install for mozleak 23:06:56 INFO - Running setup.py install for mozlog 23:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Running setup.py install for moznetwork 23:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:56 INFO - Running setup.py install for mozprocess 23:06:56 INFO - Running setup.py install for mozprofile 23:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:57 INFO - Running setup.py install for mozrunner 23:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:57 INFO - Running setup.py install for mozscreenshot 23:06:57 INFO - Running setup.py install for moztest 23:06:57 INFO - Running setup.py install for mozversion 23:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:57 INFO - Cleaning up... 23:06:57 INFO - Return code: 0 23:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:06:57 INFO - Using env: {'DISPLAY': ':0', 23:06:57 INFO - 'HOME': '/home/cltbld', 23:06:57 INFO - 'LANG': 'en_US.UTF-8', 23:06:57 INFO - 'LANGUAGE': 'en_US:en', 23:06:57 INFO - 'LOGNAME': 'cltbld', 23:06:57 INFO - 'MAIL': '/var/mail/cltbld', 23:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:57 INFO - 'MOZ_NO_REMOTE': '1', 23:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:57 INFO - 'NO_EM_RESTART': '1', 23:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:57 INFO - 'PWD': '/builds/slave/test', 23:06:57 INFO - 'SHELL': '/bin/bash', 23:06:57 INFO - 'SHLVL': '1', 23:06:57 INFO - 'TERM': 'linux', 23:06:57 INFO - 'TMOUT': '86400', 23:06:57 INFO - 'USER': 'cltbld', 23:06:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:57 INFO - '_': '/tools/buildbot/bin/python'} 23:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:57 INFO - Running setup.py (path:/tmp/pip-EcRejg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:57 INFO - Running setup.py (path:/tmp/pip-v4xYIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:57 INFO - Running setup.py (path:/tmp/pip-cP0RIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:57 INFO - Running setup.py (path:/tmp/pip-jE2fJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:57 INFO - Running setup.py (path:/tmp/pip-ccMSyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:58 INFO - Running setup.py (path:/tmp/pip-6eHu4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:58 INFO - Running setup.py (path:/tmp/pip-XwULlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:58 INFO - Running setup.py (path:/tmp/pip-rrfdFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:58 INFO - Running setup.py (path:/tmp/pip-cj4AMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:58 INFO - Running setup.py (path:/tmp/pip-pQHyc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:58 INFO - Running setup.py (path:/tmp/pip-wUrLPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:58 INFO - Running setup.py (path:/tmp/pip-zINE23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:58 INFO - Running setup.py (path:/tmp/pip-K_uHoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:58 INFO - Running setup.py (path:/tmp/pip-rONpWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:58 INFO - Running setup.py (path:/tmp/pip-0TBVuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:58 INFO - Running setup.py (path:/tmp/pip-Zd8jH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:58 INFO - Running setup.py (path:/tmp/pip-NqJlXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:00 INFO - Downloading blessings-1.6.tar.gz 23:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:07:00 INFO - Installing collected packages: blessings 23:07:00 INFO - Running setup.py install for blessings 23:07:00 INFO - Successfully installed blessings 23:07:00 INFO - Cleaning up... 23:07:01 INFO - Return code: 0 23:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:07:01 INFO - Reading from file tmpfile_stdout 23:07:01 INFO - Current package versions: 23:07:01 INFO - argparse == 1.2.1 23:07:01 INFO - blessings == 1.6 23:07:01 INFO - blobuploader == 1.2.4 23:07:01 INFO - docopt == 0.6.1 23:07:01 INFO - manifestparser == 1.1 23:07:01 INFO - mozInstall == 1.12 23:07:01 INFO - mozcrash == 0.17 23:07:01 INFO - mozdebug == 0.1 23:07:01 INFO - mozdevice == 0.48 23:07:01 INFO - mozfile == 1.2 23:07:01 INFO - mozhttpd == 0.7 23:07:01 INFO - mozinfo == 0.9 23:07:01 INFO - mozleak == 0.1 23:07:01 INFO - mozlog == 3.1 23:07:01 INFO - moznetwork == 0.27 23:07:01 INFO - mozprocess == 0.22 23:07:01 INFO - mozprofile == 0.28 23:07:01 INFO - mozrunner == 6.11 23:07:01 INFO - mozscreenshot == 0.1 23:07:01 INFO - mozsystemmonitor == 0.0 23:07:01 INFO - moztest == 0.7 23:07:01 INFO - mozversion == 1.4 23:07:01 INFO - psutil == 3.1.1 23:07:01 INFO - requests == 1.2.3 23:07:01 INFO - wsgiref == 0.1.2 23:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:07:01 INFO - Using env: {'DISPLAY': ':0', 23:07:01 INFO - 'HOME': '/home/cltbld', 23:07:01 INFO - 'LANG': 'en_US.UTF-8', 23:07:01 INFO - 'LANGUAGE': 'en_US:en', 23:07:01 INFO - 'LOGNAME': 'cltbld', 23:07:01 INFO - 'MAIL': '/var/mail/cltbld', 23:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:01 INFO - 'MOZ_NO_REMOTE': '1', 23:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:01 INFO - 'NO_EM_RESTART': '1', 23:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:01 INFO - 'PWD': '/builds/slave/test', 23:07:01 INFO - 'SHELL': '/bin/bash', 23:07:01 INFO - 'SHLVL': '1', 23:07:01 INFO - 'TERM': 'linux', 23:07:01 INFO - 'TMOUT': '86400', 23:07:01 INFO - 'USER': 'cltbld', 23:07:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:01 INFO - '_': '/tools/buildbot/bin/python'} 23:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:07:01 INFO - Cleaning up... 23:07:01 INFO - Return code: 0 23:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:07:01 INFO - Using env: {'DISPLAY': ':0', 23:07:01 INFO - 'HOME': '/home/cltbld', 23:07:01 INFO - 'LANG': 'en_US.UTF-8', 23:07:01 INFO - 'LANGUAGE': 'en_US:en', 23:07:01 INFO - 'LOGNAME': 'cltbld', 23:07:01 INFO - 'MAIL': '/var/mail/cltbld', 23:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:01 INFO - 'MOZ_NO_REMOTE': '1', 23:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:01 INFO - 'NO_EM_RESTART': '1', 23:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:01 INFO - 'PWD': '/builds/slave/test', 23:07:01 INFO - 'SHELL': '/bin/bash', 23:07:01 INFO - 'SHLVL': '1', 23:07:01 INFO - 'TERM': 'linux', 23:07:01 INFO - 'TMOUT': '86400', 23:07:01 INFO - 'USER': 'cltbld', 23:07:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:01 INFO - '_': '/tools/buildbot/bin/python'} 23:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:01 INFO - Downloading/unpacking jsonschema 23:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:07:03 INFO - Downloading/unpacking functools32 (from jsonschema) 23:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:07:03 INFO - warning: no files found matching '*.txt' 23:07:03 INFO - no previously-included directories found matching 'build' 23:07:03 INFO - no previously-included directories found matching 'dist' 23:07:03 INFO - no previously-included directories found matching '.git*' 23:07:03 INFO - Installing collected packages: jsonschema, functools32 23:07:03 INFO - Running setup.py install for functools32 23:07:04 INFO - warning: no files found matching '*.txt' 23:07:04 INFO - no previously-included directories found matching 'build' 23:07:04 INFO - no previously-included directories found matching 'dist' 23:07:04 INFO - no previously-included directories found matching '.git*' 23:07:04 INFO - Successfully installed jsonschema functools32 23:07:04 INFO - Cleaning up... 23:07:04 INFO - Return code: 0 23:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5fc8fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:07:04 INFO - Using env: {'DISPLAY': ':0', 23:07:04 INFO - 'HOME': '/home/cltbld', 23:07:04 INFO - 'LANG': 'en_US.UTF-8', 23:07:04 INFO - 'LANGUAGE': 'en_US:en', 23:07:04 INFO - 'LOGNAME': 'cltbld', 23:07:04 INFO - 'MAIL': '/var/mail/cltbld', 23:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:04 INFO - 'MOZ_NO_REMOTE': '1', 23:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:04 INFO - 'NO_EM_RESTART': '1', 23:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:04 INFO - 'PWD': '/builds/slave/test', 23:07:04 INFO - 'SHELL': '/bin/bash', 23:07:04 INFO - 'SHLVL': '1', 23:07:04 INFO - 'TERM': 'linux', 23:07:04 INFO - 'TMOUT': '86400', 23:07:04 INFO - 'USER': 'cltbld', 23:07:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:04 INFO - '_': '/tools/buildbot/bin/python'} 23:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:04 INFO - Downloading/unpacking flake8 23:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:07:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:07:06 INFO - no previously-included directories found matching 'docs/_build' 23:07:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:07:06 INFO - Running setup.py install for pep8 23:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:07:07 INFO - no previously-included directories found matching 'docs/_build' 23:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:07:07 INFO - Cleaning up... 23:07:07 INFO - Return code: 0 23:07:07 INFO - Running post-action listener: _resource_record_post_action 23:07:07 INFO - Running post-action listener: _start_resource_monitoring 23:07:07 INFO - Starting resource monitoring. 23:07:07 INFO - ##### 23:07:07 INFO - ##### Running install step. 23:07:07 INFO - ##### 23:07:07 INFO - Running pre-action listener: _resource_record_pre_action 23:07:07 INFO - Running main action method: install 23:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:07:07 INFO - Reading from file tmpfile_stdout 23:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 23:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:07:07 INFO - Reading from file tmpfile_stdout 23:07:07 INFO - Output received: 23:07:07 INFO - Usage: mozinstall [options] installer 23:07:07 INFO - Options: 23:07:07 INFO - -h, --help show this help message and exit 23:07:07 INFO - -d DEST, --destination=DEST 23:07:07 INFO - Directory to install application into. [default: 23:07:07 INFO - "/builds/slave/test"] 23:07:07 INFO - --app=APP Application being installed. [default: firefox] 23:07:07 INFO - mkdir: /builds/slave/test/build/application 23:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:07:23 INFO - Reading from file tmpfile_stdout 23:07:23 INFO - Output received: 23:07:23 INFO - /builds/slave/test/build/application/firefox/firefox 23:07:23 INFO - Running post-action listener: _resource_record_post_action 23:07:23 INFO - ##### 23:07:23 INFO - ##### Running run-tests step. 23:07:23 INFO - ##### 23:07:23 INFO - Running pre-action listener: _resource_record_pre_action 23:07:23 INFO - Running main action method: run_tests 23:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:07:23 INFO - Python 2.7.3 23:07:23 INFO - Return code: 0 23:07:23 INFO - grabbing minidump binary from tooltool 23:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddb410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:07:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:07:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:07:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:07:23 INFO - Return code: 0 23:07:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:07:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:07:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:07:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:07:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:07:24 INFO - Return code: 0 23:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:07:24 INFO - Using env: {'DISPLAY': ':0', 23:07:24 INFO - 'HOME': '/home/cltbld', 23:07:24 INFO - 'LANG': 'en_US.UTF-8', 23:07:24 INFO - 'LANGUAGE': 'en_US:en', 23:07:24 INFO - 'LOGNAME': 'cltbld', 23:07:24 INFO - 'MAIL': '/var/mail/cltbld', 23:07:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:07:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:24 INFO - 'MOZ_NO_REMOTE': '1', 23:07:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:24 INFO - 'NO_EM_RESTART': '1', 23:07:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:24 INFO - 'PWD': '/builds/slave/test', 23:07:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:07:24 INFO - 'SHELL': '/bin/bash', 23:07:24 INFO - 'SHLVL': '1', 23:07:24 INFO - 'TERM': 'linux', 23:07:24 INFO - 'TMOUT': '86400', 23:07:24 INFO - 'USER': 'cltbld', 23:07:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473', 23:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:24 INFO - '_': '/tools/buildbot/bin/python'} 23:07:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:07:24 INFO - mozversion application_buildid: 20160701065031 23:07:24 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:24 INFO - mozversion application_display_name: Firefox 23:07:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:07:24 INFO - mozversion application_name: Firefox 23:07:24 INFO - mozversion application_remotingname: firefox 23:07:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:24 INFO - mozversion application_vendor: Mozilla 23:07:24 INFO - mozversion application_version: 48.0 23:07:24 INFO - mozversion platform_buildid: 20160701065031 23:07:24 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:24 INFO - mozversion platform_version: 48.0 23:07:24 INFO - using testdate: 1467526044 23:07:24 INFO - actual date: 1467526044 23:07:24 INFO - starting webserver on 'localhost:59437' 23:07:24 INFO - SUITE-START | Running 2 tests 23:07:24 INFO - TEST-START | dromaeo_css 23:07:24 INFO - operating with platform_type : linux_ 23:07:24 INFO - Initialising browser for dromaeo_css test... 23:07:24 INFO - TEST-INFO | started process 19878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIVX10j/profile http://localhost:59437/getInfo.html) 23:07:29 INFO - PROCESS | 19878 | 23:07:29 INFO - PROCESS | 19878 | (process:19957): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:07:30 INFO - PROCESS | 19878 | __metrics Screen width/height:1600/1200 23:07:30 INFO - PROCESS | 19878 | colorDepth:24 23:07:30 INFO - PROCESS | 19878 | Browser inner width/height: 1024/697 23:07:30 INFO - PROCESS | 19878 | __metrics 23:07:30 ERROR - PROCESS | 19878 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:07:31 INFO - TEST-INFO | 19878: exit 0 23:07:31 INFO - Browser initialized. 23:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:31 INFO - TEST-INFO | started process 20007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIVX10j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:33 INFO - PROCESS | 20007 | 23:07:33 INFO - PROCESS | 20007 | (process:20073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:07:43 INFO - PROCESS | 20007 | RSS: Main: 151203840 23:07:43 INFO - PROCESS | 20007 | 23:08:33 INFO - PROCESS | 20007 | 1467526113231 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:10:40 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:59437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59437/tests/dromaeo/cssquery-ext.html) 23:10:41 INFO - PROCESS | 20007 | RSS: Main: 154562560 23:10:41 INFO - PROCESS | 20007 | 23:13:43 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:59437/tests/dromaeo/cssquery-ext.html (next: http://localhost:59437/tests/dromaeo/cssquery-jquery.html) 23:13:44 INFO - PROCESS | 20007 | RSS: Main: 152666112 23:13:44 INFO - PROCESS | 20007 | 23:16:45 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:59437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59437/tests/dromaeo/cssquery-mootools.html) 23:16:46 INFO - PROCESS | 20007 | RSS: Main: 152346624 23:16:46 INFO - PROCESS | 20007 | 23:19:47 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:59437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59437/tests/dromaeo/cssquery-prototype.html) 23:19:48 INFO - PROCESS | 20007 | RSS: Main: 154124288 23:19:48 INFO - PROCESS | 20007 | 23:22:50 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:59437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59437/tests/dromaeo/cssquery-yui.html) 23:22:51 INFO - PROCESS | 20007 | RSS: Main: 152424448 23:22:51 INFO - PROCESS | 20007 | 23:25:53 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:59437/tests/dromaeo/cssquery-yui.html (next: http://localhost:59437/tests/dromaeo/cssquery-dojo.html) 23:25:54 INFO - PROCESS | 20007 | RSS: Main: 156233728 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | __start_tp_report 23:25:54 INFO - PROCESS | 20007 | _x_x_mozilla_page_load 23:25:54 INFO - PROCESS | 20007 | _x_x_mozilla_page_load_details 23:25:54 INFO - PROCESS | 20007 | |i|pagename|runs| 23:25:54 INFO - PROCESS | 20007 | |0;dojo.html;3285.2936618627;3330.2839889423776;3435.3988052090876;3436.776609520379;3442.2943296624194;5665.065264231397;5665.291838520185;5679.062954612489;5683.0622947213715;5683.971580142103;5659.462351076651;5679.432056794319;5689.3172819261645;5698.8290351289525;5715.685637289947;5106.66806657567;5123.666961647481;5163.7676304566385;5183.092958732207;5198.558122559587;5097.464766199551;5144.588432925376;5153.768080436389;5293.735313234342;5329.014132385501;5150.33045704058;5179.715115668637;5186.4813518648025;5189.948100518985;5208.609354298424;5215.973920130394;5240.633155679104;5243.501867322599;5249.186376111708;5278.023565640369;4965.751712414401;4991.6256280778725;5149.0989076911765;5161.329027226437;5194.740262986836;5447.373552041527;5466.890662186734;5569.972150139223;5588.245586845765;5621.8594535136535;6048.727807248684;6066.302375226861;6080.878382432371;6084.939150608481;6125.78559750411;5996.670183139926;6020.8494787630225;6104.96947515264;6107.938920610782;6138.1099740537375;5555.972220138914;5557.249771280865;5566.443355664442;5567.66594004361;5602.411746766572;6078.966575682145;6087.239095113111;6096.939030609726;6103.572749907553;6111.083337499322;5752.913706294409;5828.067509198508;5873.911891321633;5878.882422351529;5886.676232807236;6029.276486821609;6038.63768173911;6040.577159598786;6041.486473649789;6041.969790151021;5970.880582388415;5975.073863551156;6012.188354572077;6015.518758499309;6019.578629495893;5854.0048191806645;5901.557383196277;6013.5189184865985;6015.759369625253;6041.9395806041375;4614.215583350839;4621.930671039937;4628.722276663411;4631.096936097429;4655.930161047587;4056.290149223933;4155.771432571238;4158.500979882433;4163.791810409467;4187.350960601112;5673;5787.681677507693;5818.854528636818;5851.795187168429;5908.20239267702;6026.849328766728;6028.4272994065495;6034.547408944347;6035.426634469718;6036.607620504653;5673.659580425187;5758.481736643638;5775.971120144456;5783.624064435799;5792.189093526909;5184.040952423814;5246.737663116905;5263.052650522866;5272.05103081449;5294.708791016531;6272.40412160844;6284.528660350492;6284.874302514016;6294.622322660655;6300.21247344082;5941.643501389931;6037.45662890342;6101.237345331833;6111.144439778345;6118.663473509;6118.847028824315;6169.84575385619;6177.289611694712;6220.315765265726;6295.622262664255;6003.039513677791;6011.519078473799;6024.7288872001745;6036.33600303975;6063.939360606338;6124.234470691164;6132.724027418688;6142.508599312134;6143.877122457615;6149.600275982047;5743.942560574341;5846.619969701956;5859.736311866061;5894.322152952465;5911.497522710618;5859.531237500904;5863.912041319469;5877.4122587740885;5890.4993075587345;5902.911456328073;5687.687177205294;5797;5812.680302583399;5823.359430462561;5837.153612726046;5914.319853216935;5953.523718102628;5961.046232602763;5971.0744834550715;6012.7294271757;5819.592628516132;5832.562557808266;5832.679202643725;5832.970835145967;5842 23:25:54 INFO - PROCESS | 20007 | |1;ext.html;664.9900251496225;670.842352047269;680.3672584496417;736.5507040705171;776.5806464509166;37976.62023379765;39108.99999999996;39496;39605.20789584214;39632.80183599085;39833.800830995875;40591.39112913309;40654;40972.180556388856;40980;8793.428427152214;8979.191872731453;9010.54947252638;9013.684521041765;9015.909840901573;8896.555172241395;8992.730218093468;9194.264458843276;9196.632134714604;9214.170724634781;9179.449233046005;9236.122568355995;9241.676541321056;9252.028537003618;9253.722388328328;9189.586468608928;9227.26181905446;9270.30472714549;9273.582688778954;9279.489628070454;8951.686690965786;9086.182243598108;9107.590158442887;9120.817583648357;9126;41260.1747965039;41644;42207.788961055;42307.153856922996;42382.57617423817;3744.4944932434046;3831.501904752364;3967.3255546557157;4057.6753859691153;4331.631811296043;31715.682843171733;32083.51874721881;32462.513062304086;32561.348773024405;32571.34857302841;3768.4724138620613;3832.6550610445192;3848.230353929225;3895.3962135868987;3985.123272879962;253912;257904;258589;259748;343448.2827585871;39760.2047959045;66205.00692489617;66677;66702.33297667059;66758.66620666865;37674.81162594169;37708;37741.86774396773;37815.05462363463;37930.810345948645;16652.167391630614;16981;17012.404565840137;17017.744733829004;17066.57333566646;13683.726325473435;13696.383662735201;13799.793003104962;13814.861851381558;13866.029377943649;9235.861462078074;9310.813783724288;9421.340506164503;9493.0981556752;9575.952120239353;3608.404613238786;3618.203995121069;3643.216708407705;3707.3882809336696;3713.4801127842125;1046.6493724602192;1120.7702421003676;1155.2548606149155;1157.3634501024403;1255.5354518828092;33002;33071.50392744111;33209.3358132836;33311.66688333134;33549.49675754866;1207.2635692227734;1254.3226657604973;1284.7494738525897;1286.1897004886862;1287.2083668543778;17605.911970440065;17699.91150044267;17726.29094836218;17734.20196091179;17848;493794;550634;571350;582630;843263;55838.72080639571;56643.433565663814;56774.43225567774;56817.43182568204;56938.43061569414;1518.4154100671321;1535.6314484523634;1540.537838648401;1563.3277690592927;1571.1986886687644;33218.83390583032;33944.15139621529;33949.66050339564;34338.141546461535;34730;54064.729676351366;54495.455045450624;54618.18072728833;54709.45290547043;54730.179047313526;451583;453013;454238;454870;455038;30326.393472130876;31094.067177984696;31318.843405782824;31413.842930786115;31506;49421.752891235315;51115;51201.23198151956;51684.741576291875;51748.74125629348;39942.600573993885;40570.59429405786;40614.79692601518;40951.795241024796;41183.176336473705;41722.791386042874;41941.161176775684;42556.36165457583;43098.1380372397;43998.78000609976;43597.910052248946;44169.77915110404;44361;44735.77632111819;44872.77563612161;36855.44716829196;37227;37385.2522949534;38085.80957095197;38143.80928095453;27887;27971;28040.29899252535;28143.43713125767;28389.574156387258 23:25:54 INFO - PROCESS | 20007 | |2;jquery.html;429.3152421887091;438.0844035964833;439.63071020342903;444.42668957045413;450.7160488891998;18727.15727792249;18822.341218057387;19367;19555.90222048888;19593.314234001813;18924.810751892477;19177;19766.30817921373;19818.207271709114;19965.80034199661;4915.901681966358;5058.291839142523;5061.291419201315;5065.594752419797;5066.797328106872;5238.292830467895;5416.4312747161575;5423.918641220384;5505.174223866432;5544.279243698314;5529.115341545354;5531.529819965308;5545.390007099216;5551.278333816598;5562.471565201299;5402.864928376783;5519.3100862392;5524.033294173523;5530.976769297673;5919.881602367928;5340.412554618989;5367.570594352443;5369.81205657804;5370.570354371641;5396.163594642837;23699.170529031573;23818.76181238183;23882.76117238823;24017.87991060051;24317.27048188557;2357.9174728884577;2399.928002159938;2432.391902024494;3075.3403993293414;3221.597300337458;14290.642733931734;14532.927335363256;14613.488527901472;14820.40718371264;14865.554033379016;2097.968530472044;2135.4768081820052;2148.0977989244557;2149.8065174134404;2162.8918554072234;76276.23723762747;82298;84015.57992210062;84025.57987210025;86955.56522217412;11110.888891111146;11552.422378881023;11624.825627615592;11646.94176529112;11766.352850593299;15764.76352854708;15956.76064859028;16042.43851465193;16048.03711777297;16078.517644470685;8324.583770811436;8824;8832.91167088321;8837.29301655866;9019.819603608023;8920.509371984474;8995.775105622412;9022.323325750594;9027.593758280893;9056.184943355129;4713.952860471351;4877.487863774323;4905.2151655734915;4941.888075183055;4992.850214493571;1944.8444124470009;1952.1313015707874;1990.36789832339;2005.2881227164146;2017.273781438681;974.1670871404847;1038.200585549138;1039.0544604410102;1102.4377567440663;1114.6321713834416;19493.90253048754;20109.798902010793;20399.796002040086;20454.897725511575;20531;1068.6420049283577;1095.39205740813;1112.1769890281296;1146.696125526736;1151.2114201771813;10588.417637029883;11461.369624670557;11492.25300355491;11515;11564.479598418091;517447;522524;532798;539707;544616;92165.53917230506;93644.53177734067;93733;95944;96300.51849740847;1072.6406653771073;1078.231700011981;1121.1087185687236;1124.8087825069758;1134.28540019787;17402.95582265068;17539.56151096233;17791.377301794375;17836.643267134325;18034.36879709204;40418;41012.58987410088;41033.794831025654;41473.585264146976;41771.582284176766;57716.71141644433;59619;59682;60283;60721.39278607334;9434.103760142776;9501.904980950101;9517.809643807224;9539.14147726708;9621.807563848824;9521;9630.181434578139;9752.317337786571;9988.101070903364;10175.847362289423;8517.063123056334;8703.56482175876;8805.823883522422;9059.637614495346;9324.906750932403;8926.241269492166;8976.730698079067;9049.185573298435;9238.445693258158;9465.858012129962;6290.528210384148;8327.833443331221;9051.728448146567;9154.679586214717;9420.62317507292;12974.156679816158;13236;13603.115797473132;13861.514846980308;14133.15201087938;13456.46174153023;13504.324783760576;13652.453901843815;13734.175949442666;13764.724705506034 23:25:54 INFO - PROCESS | 20007 | |3;mootools.html;1546.1341648676741;1552.3169805285675;1779.1282271686869;1858.758361413016;1872.1949561688486;7481.812954676136;8273.751787446372;8390.077091519935;8460.238578527931;8578.313734901216;8125.796855078626;8273.29676977456;8365.623546940387;8420.410571260014;8469.322454203664;2317.351141680328;2335.8481698689616;2341.800946919514;2354.7645235476402;2355.5524450354465;2292.6331786914097;2357.163207061494;2400.4478969836946;2409.0604664180983;2417.9758202417925;2311.895964681585;2330.137848995874;2331.708536432946;2336.696229490164;2349.3539276698957;2334.7548507406646;2351.43565544269;2353.5881220786378;2355.3758254062686;2406.7232268289195;2363.7754413330877;2366.8343215974887;2370.5258948210253;2383.15398033699;2390.163442795008;8635.222829945335;8644.135586441369;8666.436681615674;8679.262262707678;8682.782930426727;5106.361704786902;5187.766550505198;5209.6874187548865;5210.322658054429;5231.659942103751;3338.8163650999186;3355.1108956126645;3383.678550537695;3405.4210784166753;3487.1630808606005;1055.176961969665;1092.5247517329988;1107.6787731557838;1111.9444027798659;1114.186643750059;11835.822462663067;11887.583934562248;11929.582464613784;11935.522579096825;11935.985441237504;4147.52303485097;4230.513490948519;4266.658667306608;4293.2701440755145;4293.3989241506215;9417.387869788441;9506.47714375716;9530.571124299424;9543.47510886908;9590.280728945358;5134;5144;5146.665466744649;5147.459516750687;5158.3552055993005;4623.445186577632;4756.881077973009;4768.47546769855;4786.473487916326;4816.349792778;3743.7192210584317;3784.0918179637238;3843.6348546888003;3871.438641397038;3921.3333733265413;1151.343734071588;1152.0438036429744;1169.3802284789076;1172.554429316854;1198.053537705203;1017.013496907998;1069.6630561373142;1078.5308390850005;1085.3216739537788;1096.3915027160003;6201.317855035943;6274.749010039547;6298.653574053471;6349.777757778455;6380.585261958051;421.4521122540746;432.8485030239391;440.1505095166296;440.29772512841964;447.03663604931427;4288.699791014599;4335.414719012956;4344.543822898613;4468.3074123510905;4469.977650111794;10263.178945684327;10373.222008349405;10391.220658450646;10497.790044199226;10521.316114452537;10256.58973641046;10303.587856485807;10314.1748660107;10327.793444131075;10349.172066234683;7623.580703061385;8026.197380261927;8095.271425571609;8137.918620813834;8222.917770822216;6137.140800288053;6161.753529858755;6169.9691501544;6224.470919971672;6277.843053923689;8728.389012769045;8755.649774009224;8776.692815751418;8806.647734090564;8839;8706.695265665672;8984;9044.41211321262;9059.36584439083;9077.500737459239;6833.384995350442;7420.183779784327;7551.282628150317;7594.430417718582;7595.620218989139;8219.260266576037;8304.750857474286;8309;8318.209770071833;8363.121872203574;7381.889271661037;7630.542167469969;7642.7325043623205;7650.579218143055;7652.081750190013;7374;7411.4811963162065;7476.439267054884;7527.209642987407;7555.773326800205;7114.537555058904;7147.142342918883;7230.710771569289;7265.564066156047;7265.673044713107;5377.784888604569;5399.4060653327315;5474.972625136849;5485.286912701324;5576.749046292845;5408.891822163613;5414.810481633124;5452.890942181213;5476.72616369172;5554.083576210041 23:25:54 INFO - PROCESS | 20007 | |4;prototype.html;366.0701817383845;368.2542850727277;369.95560532736073;370.5960503051673;374.88378602633185;6487.383698548636;6496.577722448038;6511.934880651192;6564.737410503574;6569.211694596649;6543.770968016121;6593.604383736979;6607.33926607339;6621.635810030446;6626.536142470029;5034.320366750497;5048.9495105048845;5053.696778193302;5058.873528161807;5060.190369540875;5059.949400505985;5078.060558796616;5078.21287700407;5084.542391184793;5089.949100509003;5009.073321435528;5009.472111006142;5017.9247311290355;5020.171671674169;5046.646734728571;4696.178168820443;4810.230363141881;5014.774335154927;5022.397312322526;5038.345015148026;4181.958180418187;4187.560306167839;4201.033762234672;4212.747235165869;4212.7682977436225;6242.344553821828;6244.750209991595;6255.061740738925;6260.467860231885;6261.279952805395;5480.287562616834;5583.609147359686;5588.413216612238;5641.407652196502;5652.09566469367;6870.141232345957;6880.931190688079;6881.243063263087;6889.069975553286;6909.689063992132;4618.099470603233;4623.260278355447;4628.09752098341;4628.305754136873;4638.536146385368;7173.461990350745;7239.167495738005;7252.347288744038;7262.128544574632;7265.6367181641235;4655.86032419028;4835.44392394872;4878.926816097762;4883.413990321184;4911.091448082045;4774.116788394158;4810.855674329776;4815.3499277597775;4819.518048195152;4828.493008234085;5615.326160860641;5632.014397480424;5665.631733937281;5678.829635110953;5686.545076393879;6973.476989225727;6981.511294209458;6985.441164706811;6988.301169882971;7004.2995700430565;1725.55998220453;1747.161362545985;1747.9912600436917;1752.1239380309846;1753.587906841891;1094.9069329106956;1114.7547539541288;1135.7103938495632;1137.4881303413497;1151.1711567671264;6743.089682892844;6746.595204287759;6770.052192693027;6774.525783195129;6791.72833086671;7044.87282034872;7112.395446387115;7122.465815063891;7138.214796372395;7138.714451421989;6746.460283177334;6750.594964302158;6764.5603035802515;6766.898496522556;6774.390304872585;3824.9808750956067;3843.404272337792;3869.9226015479535;3871;3874.670652994471;7363;7575.053118360205;7576.772696819105;7580.848383032308;7586.165521792598;7380.188179300273;7440.627968601549;7441.144268409094;7444.851102978018;7444.962775186198;7614.390848732088;7617.885731714029;7619.390448763975;7623.656935437919;7623.733169339157;7156.606386648576;7163.3552980232025;7272.781816545512;7288.927110729037;7291.890621640574;7107.82230444243;7145.928540714526;7165.749198778018;7166.104236970379;7182.640867956686;7545.245475452411;7575.0909890813455;7577.469577129548;7578;7586.658600362886;4885.316055752269;4935.309056732132;4940;4943.480934501969;4946.653734238713;6993.510454268152;7259;7265.418766498562;7266.527675701062;7273.272672732684;7001.159860816734;7035.859282814417;7038.964805176146;7046.718131274692;7048.224695283618;6978.651067446709;7024.894626580707;7034.437245020284;7035.683394247373;7039.296070392919;6886.414654754402;6887.345702158287;6901.75843845463;6920.515563910478;6935.2717964615;6996.510244282851;7049.365557099885;7060.964695176492;7071.116110486189;7079.716811327695;6704.994250862214;6890.552114112566;6893.75871844483;6894.24163342022;6910.378065974087 23:25:54 INFO - PROCESS | 20007 | |5;yui.html;833.9332853371731;834.1950018232401;856.0113069404839;860.8407444622743;904.5251243097374;15890.920545397272;16219.18904054797;16393.344266229353;16412.343506259764;16435.753463698053;14938.775918361207;15000.399984000627;15036.323365448554;15122.773158402606;15124;914.2777206007246;920.4431319051978;946.2004606107828;948.9478078705669;949.060430174126;920.1764420843341;925.9166674999249;925.9675911343104;928.6888892221114;929.586334081334;982.7493989032787;985.9852102218473;986.7187851462298;988.4761076629397;990.782027953849;964.599691128181;972.863799068131;972.9659461918834;975.0201047946769;983.105374109564;719.7696737044148;722.0937723157456;723.8154270661;724.8296650287231;725.5936675461759;16089.758653620205;16205.189740513046;16235.269412876449;16259.187040647921;16289;14198.077124986843;14524.854751452456;14884;15020.324085416183;15164.696706065928;11675.708107297301;11776.175667703264;11880.287182769061;11977.341246231454;12000;4091.3044782387065;4107.404426358161;4152.480939882515;4175.812088455997;4177.832886684529;56696;57500;59057.704711476596;59397.703011484664;59496;11373.431328433546;11432.59985900506;11505.194636375541;11717.414129293671;11876.287422754662;20746.377608671763;21104.577908441745;21174.47063823386;21234.893825530773;21377.251796187058;8794.296456283482;8814.427062240933;8894.4663320201;8946.642134314685;8960.820783584291;4790.233562630032;4879.731614761151;4927.605791536668;4981.37732783402;5039.168537191323;3616.0598244456105;3669.7247706422127;3670.50448189491;3674.41209406499;3676.4117741161285;614.0604874541958;629.1726379810534;640.1134428816123;646.5086534234016;650.5673726971605;731.5098883747902;768.1511929318135;791.6437603078638;836.4646626159263;841.6465084664455;9291.21024712907;9698.612055517842;9775.78073238649;9955.203583713286;10074.143697785623;719.3274288540232;782.4561929459085;816.0900595835719;821.7292946493524;831.1356189562907;4511.278195488706;4535.9773201133785;4697.201475749131;4734.810607575727;4889.071076495455;64108.35891641024;64241;64592.677036614514;64687.353126469076;64724.67637661781;56313;57493.425065749645;57608;60339;60612.39387606156;53230;53523.19715204197;53661.73169134207;54091.72954135204;54434.45565544373;8753.956230218808;8817.206451419403;8912.509811960144;9277.860832087388;9356.574219293;38719.22561548697;38824.223515530095;39108;39604.40593391159;41070.38394424026;44821;45418.77290613526;47695.52304476911;48696.513034870615;50153.24770128378;11610.303381797119;11768.94115529417;11958.402079896145;12058.397080145782;12126.696832578904;13286.867131328563;13296.268705220918;13429.328533573087;13491.797623035858;13575.185488870698;12440.688982775502;12544.435500402322;12562.054179890172;12807.679808004874;12937.353132343156;12434.37828108609;12549.93725031369;12594.87405125937;13042.217466952014;13090;11904.285742855456;12061.396930153633;12135.393230338272;12147.453364598437;12469;9651.276154288596;10031.899681003097;10167.593296268067;10242.48787560604;10455.111315538265;9878.584448052363;10264.58941642326;10334.793304134026;10370.585176592851;10371.222158338003 23:25:54 INFO - PROCESS | 20007 | __end_tp_report 23:25:54 INFO - PROCESS | 20007 | __start_cc_report 23:25:54 INFO - PROCESS | 20007 | _x_x_mozilla_cycle_collect,325 23:25:54 INFO - PROCESS | 20007 | __end_cc_report 23:25:54 INFO - PROCESS | 20007 | __startTimestamp1467527154155__endTimestamp 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | ------- Summary: start ------- 23:25:54 INFO - PROCESS | 20007 | Number of tests: 6 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | [#0] dojo.html Cycles:165 Average:5620.85 Median:5832.68 stddev:615.97 (10.6%) stddev-sans-first:589.98 23:25:54 INFO - PROCESS | 20007 | Values: 3285.3 3330.3 3435.4 3436.8 3442.3 5665.1 5665.3 5679.1 5683.1 5684.0 5659.5 5679.4 5689.3 5698.8 5715.7 5106.7 5123.7 5163.8 5183.1 5198.6 5097.5 5144.6 5153.8 5293.7 5329.0 5150.3 5179.7 5186.5 5189.9 5208.6 5216.0 5240.6 5243.5 5249.2 5278.0 4965.8 4991.6 5149.1 5161.3 5194.7 5447.4 5466.9 5570.0 5588.2 5621.9 6048.7 6066.3 6080.9 6084.9 6125.8 5996.7 6020.8 6105.0 6107.9 6138.1 5556.0 5557.2 5566.4 5567.7 5602.4 6079.0 6087.2 6096.9 6103.6 6111.1 5752.9 5828.1 5873.9 5878.9 5886.7 6029.3 6038.6 6040.6 6041.5 6042.0 5970.9 5975.1 6012.2 6015.5 6019.6 5854.0 5901.6 6013.5 6015.8 6041.9 4614.2 4621.9 4628.7 4631.1 4655.9 4056.3 4155.8 4158.5 4163.8 4187.4 5673.0 5787.7 5818.9 5851.8 5908.2 6026.8 6028.4 6034.5 6035.4 6036.6 5673.7 5758.5 5776.0 5783.6 5792.2 5184.0 5246.7 5263.1 5272.1 5294.7 6272.4 6284.5 6284.9 6294.6 6300.2 5941.6 6037.5 6101.2 6111.1 6118.7 6118.8 6169.8 6177.3 6220.3 6295.6 6003.0 6011.5 6024.7 6036.3 6063.9 6124.2 6132.7 6142.5 6143.9 6149.6 5743.9 5846.6 5859.7 5894.3 5911.5 5859.5 5863.9 5877.4 5890.5 5902.9 5687.7 5797.0 5812.7 5823.4 5837.2 5914.3 5953.5 5961.0 5971.1 6012.7 5819.6 5832.6 5832.7 5833.0 5842.0 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | [#1] ext.html Cycles:180 Average:60091.55 Median:22000.14 stddev:126140.50 (573.4%) stddev-sans-first:126415.45 23:25:54 INFO - PROCESS | 20007 | Values: 665.0 670.8 680.4 736.6 776.6 37976.6 39109.0 39496.0 39605.2 39632.8 39833.8 40591.4 40654.0 40972.2 40980.0 8793.4 8979.2 9010.5 9013.7 9015.9 8896.6 8992.7 9194.3 9196.6 9214.2 9179.4 9236.1 9241.7 9252.0 9253.7 9189.6 9227.3 9270.3 9273.6 9279.5 8951.7 9086.2 9107.6 9120.8 9126.0 41260.2 41644.0 42207.8 42307.2 42382.6 3744.5 3831.5 3967.3 4057.7 4331.6 31715.7 32083.5 32462.5 32561.3 32571.3 3768.5 3832.7 3848.2 3895.4 3985.1 253912.0 257904.0 258589.0 259748.0 343448.3 39760.2 66205.0 66677.0 66702.3 66758.7 37674.8 37708.0 37741.9 37815.1 37930.8 16652.2 16981.0 17012.4 17017.7 17066.6 13683.7 13696.4 13799.8 13814.9 13866.0 9235.9 9310.8 9421.3 9493.1 9576.0 3608.4 3618.2 3643.2 3707.4 3713.5 1046.6 1120.8 1155.3 1157.4 1255.5 33002.0 33071.5 33209.3 33311.7 33549.5 1207.3 1254.3 1284.7 1286.2 1287.2 17605.9 17699.9 17726.3 17734.2 17848.0 493794.0 550634.0 571350.0 582630.0 843263.0 55838.7 56643.4 56774.4 56817.4 56938.4 1518.4 1535.6 1540.5 1563.3 1571.2 33218.8 33944.2 33949.7 34338.1 34730.0 54064.7 54495.5 54618.2 54709.5 54730.2 451583.0 453013.0 454238.0 454870.0 455038.0 30326.4 31094.1 31318.8 31413.8 31506.0 49421.8 51115.0 51201.2 51684.7 51748.7 39942.6 40570.6 40614.8 40951.8 41183.2 41722.8 41941.2 42556.4 43098.1 43998.8 43597.9 44169.8 44361.0 44735.8 44872.8 36855.4 37227.0 37385.3 38085.8 38143.8 27887.0 27971.0 28040.3 28143.4 28389.6 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | [#2] jquery.html Cycles:180 Average:30456.66 Median:433.70 stddev:87491.16 (20173.2%) stddev-sans-first:87707.54 23:25:54 INFO - PROCESS | 20007 | Values: 429.3 438.1 439.6 444.4 450.7 18727.2 18822.3 19367.0 19555.9 19593.3 18924.8 19177.0 19766.3 19818.2 19965.8 4915.9 5058.3 5061.3 5065.6 5066.8 5238.3 5416.4 5423.9 5505.2 5544.3 5529.1 5531.5 5545.4 5551.3 5562.5 5402.9 5519.3 5524.0 5531.0 5919.9 5340.4 5367.6 5369.8 5370.6 5396.2 23699.2 23818.8 23882.8 24017.9 24317.3 2357.9 2399.9 2432.4 3075.3 3221.6 14290.6 14532.9 14613.5 14820.4 14865.6 2098.0 2135.5 2148.1 2149.8 2162.9 76276.2 82298.0 84015.6 84025.6 86955.6 11110.9 11552.4 11624.8 11646.9 11766.4 15764.8 15956.8 16042.4 16048.0 16078.5 8324.6 8824.0 8832.9 8837.3 9019.8 8920.5 8995.8 9022.3 9027.6 9056.2 4714.0 4877.5 4905.2 4941.9 4992.9 1944.8 1952.1 1990.4 2005.3 2017.3 974.2 1038.2 1039.1 1102.4 1114.6 19493.9 20109.8 20399.8 20454.9 20531.0 1068.6 1095.4 1112.2 1146.7 1151.2 10588.4 11461.4 11492.3 11515.0 11564.5 517447.0 522524.0 532798.0 539707.0 544616.0 92165.5 93644.5 93733.0 95944.0 96300.5 1072.6 1078.2 1121.1 1124.8 1134.3 17403.0 17539.6 17791.4 17836.6 18034.4 40418.0 41012.6 41033.8 41473.6 41771.6 57716.7 59619.0 59682.0 60283.0 60721.4 9434.1 9501.9 9517.8 9539.1 9621.8 9521.0 9630.2 9752.3 9988.1 10175.8 8517.1 8703.6 8805.8 9059.6 9324.9 8926.2 8976.7 9049.2 9238.4 9465.9 6290.5 8327.8 9051.7 9154.7 9420.6 12974.2 13236.0 13603.1 13861.5 14133.2 13456.5 13504.3 13652.5 13734.2 13764.7 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | [#3] mootools.html Cycles:180 Average:5631.98 Median:5120.18 stddev:3084.26 (60.2%) stddev-sans-first:3077.63 23:25:54 INFO - PROCESS | 20007 | Values: 1546.1 1552.3 1779.1 1858.8 1872.2 7481.8 8273.8 8390.1 8460.2 8578.3 8125.8 8273.3 8365.6 8420.4 8469.3 2317.4 2335.8 2341.8 2354.8 2355.6 2292.6 2357.2 2400.4 2409.1 2418.0 2311.9 2330.1 2331.7 2336.7 2349.4 2334.8 2351.4 2353.6 2355.4 2406.7 2363.8 2366.8 2370.5 2383.2 2390.2 8635.2 8644.1 8666.4 8679.3 8682.8 5106.4 5187.8 5209.7 5210.3 5231.7 3338.8 3355.1 3383.7 3405.4 3487.2 1055.2 1092.5 1107.7 1111.9 1114.2 11835.8 11887.6 11929.6 11935.5 11936.0 4147.5 4230.5 4266.7 4293.3 4293.4 9417.4 9506.5 9530.6 9543.5 9590.3 5134.0 5144.0 5146.7 5147.5 5158.4 4623.4 4756.9 4768.5 4786.5 4816.3 3743.7 3784.1 3843.6 3871.4 3921.3 1151.3 1152.0 1169.4 1172.6 1198.1 1017.0 1069.7 1078.5 1085.3 1096.4 6201.3 6274.7 6298.7 6349.8 6380.6 421.5 432.8 440.2 440.3 447.0 4288.7 4335.4 4344.5 4468.3 4470.0 10263.2 10373.2 10391.2 10497.8 10521.3 10256.6 10303.6 10314.2 10327.8 10349.2 7623.6 8026.2 8095.3 8137.9 8222.9 6137.1 6161.8 6170.0 6224.5 6277.8 8728.4 8755.6 8776.7 8806.6 8839.0 8706.7 8984.0 9044.4 9059.4 9077.5 6833.4 7420.2 7551.3 7594.4 7595.6 8219.3 8304.8 8309.0 8318.2 8363.1 7381.9 7630.5 7642.7 7650.6 7652.1 7374.0 7411.5 7476.4 7527.2 7555.8 7114.5 7147.1 7230.7 7265.6 7265.7 5377.8 5399.4 5475.0 5485.3 5576.7 5408.9 5414.8 5452.9 5476.7 5554.1 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | [#4] prototype.html Cycles:180 Average:5821.32 Median:6724.04 stddev:1794.48 (26.7%) stddev-sans-first:1752.18 23:25:54 INFO - PROCESS | 20007 | Values: 366.1 368.3 370.0 370.6 374.9 6487.4 6496.6 6511.9 6564.7 6569.2 6543.8 6593.6 6607.3 6621.6 6626.5 5034.3 5048.9 5053.7 5058.9 5060.2 5059.9 5078.1 5078.2 5084.5 5089.9 5009.1 5009.5 5017.9 5020.2 5046.6 4696.2 4810.2 5014.8 5022.4 5038.3 4182.0 4187.6 4201.0 4212.7 4212.8 6242.3 6244.8 6255.1 6260.5 6261.3 5480.3 5583.6 5588.4 5641.4 5652.1 6870.1 6880.9 6881.2 6889.1 6909.7 4618.1 4623.3 4628.1 4628.3 4638.5 7173.5 7239.2 7252.3 7262.1 7265.6 4655.9 4835.4 4878.9 4883.4 4911.1 4774.1 4810.9 4815.3 4819.5 4828.5 5615.3 5632.0 5665.6 5678.8 5686.5 6973.5 6981.5 6985.4 6988.3 7004.3 1725.6 1747.2 1748.0 1752.1 1753.6 1094.9 1114.8 1135.7 1137.5 1151.2 6743.1 6746.6 6770.1 6774.5 6791.7 7044.9 7112.4 7122.5 7138.2 7138.7 6746.5 6750.6 6764.6 6766.9 6774.4 3825.0 3843.4 3869.9 3871.0 3874.7 7363.0 7575.1 7576.8 7580.8 7586.2 7380.2 7440.6 7441.1 7444.9 7445.0 7614.4 7617.9 7619.4 7623.7 7623.7 7156.6 7163.4 7272.8 7288.9 7291.9 7107.8 7145.9 7165.7 7166.1 7182.6 7545.2 7575.1 7577.5 7578.0 7586.7 4885.3 4935.3 4940.0 4943.5 4946.7 6993.5 7259.0 7265.4 7266.5 7273.3 7001.2 7035.9 7039.0 7046.7 7048.2 6978.7 7024.9 7034.4 7035.7 7039.3 6886.4 6887.3 6901.8 6920.5 6935.3 6996.5 7049.4 7061.0 7071.1 7079.7 6705.0 6890.6 6893.8 6894.2 6910.4 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - PROCESS | 20007 | [#5] yui.html Cycles:180 Average:15687.60 Median:26242.88 stddev:18204.22 (69.4%) stddev-sans-first:18221.11 23:25:54 INFO - PROCESS | 20007 | Values: 833.9 834.2 856.0 860.8 904.5 15890.9 16219.2 16393.3 16412.3 16435.8 14938.8 15000.4 15036.3 15122.8 15124.0 914.3 920.4 946.2 948.9 949.1 920.2 925.9 926.0 928.7 929.6 982.7 986.0 986.7 988.5 990.8 964.6 972.9 973.0 975.0 983.1 719.8 722.1 723.8 724.8 725.6 16089.8 16205.2 16235.3 16259.2 16289.0 14198.1 14524.9 14884.0 15020.3 15164.7 11675.7 11776.2 11880.3 11977.3 12000.0 4091.3 4107.4 4152.5 4175.8 4177.8 56696.0 57500.0 59057.7 59397.7 59496.0 11373.4 11432.6 11505.2 11717.4 11876.3 20746.4 21104.6 21174.5 21234.9 21377.3 8794.3 8814.4 8894.5 8946.6 8960.8 4790.2 4879.7 4927.6 4981.4 5039.2 3616.1 3669.7 3670.5 3674.4 3676.4 614.1 629.2 640.1 646.5 650.6 731.5 768.2 791.6 836.5 841.6 9291.2 9698.6 9775.8 9955.2 10074.1 719.3 782.5 816.1 821.7 831.1 4511.3 4536.0 4697.2 4734.8 4889.1 64108.4 64241.0 64592.7 64687.4 64724.7 56313.0 57493.4 57608.0 60339.0 60612.4 53230.0 53523.2 53661.7 54091.7 54434.5 8754.0 8817.2 8912.5 9277.9 9356.6 38719.2 38824.2 39108.0 39604.4 41070.4 44821.0 45418.8 47695.5 48696.5 50153.2 11610.3 11768.9 11958.4 12058.4 12126.7 13286.9 13296.3 13429.3 13491.8 13575.2 12440.7 12544.4 12562.1 12807.7 12937.4 12434.4 12549.9 12594.9 13042.2 13090.0 11904.3 12061.4 12135.4 12147.5 12469.0 9651.3 10031.9 10167.6 10242.5 10455.1 9878.6 10264.6 10334.8 10370.6 10371.2 23:25:54 INFO - PROCESS | 20007 | -------- Summary: end -------- 23:25:54 INFO - PROCESS | 20007 | 23:25:54 INFO - TEST-INFO | 20007: exit 0 23:25:54 INFO - TEST-OK | dromaeo_css | took 1110115ms 23:25:54 INFO - TEST-START | kraken 23:25:54 INFO - operating with platform_type : linux_ 23:25:54 INFO - Initialising browser for kraken test... 23:25:54 INFO - TEST-INFO | started process 20250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiSg9_A/profile http://localhost:59437/getInfo.html) 23:25:58 INFO - PROCESS | 20250 | 23:25:58 INFO - PROCESS | 20250 | (process:20327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:59 INFO - PROCESS | 20250 | __metrics Screen width/height:1600/1200 23:25:59 INFO - PROCESS | 20250 | colorDepth:24 23:25:59 INFO - PROCESS | 20250 | Browser inner width/height: 1024/697 23:25:59 INFO - PROCESS | 20250 | __metrics 23:26:00 ERROR - PROCESS | 20250 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:26:01 INFO - TEST-INFO | 20250: exit 0 23:26:01 INFO - Browser initialized. 23:26:01 INFO - Running cycle 1/1 for kraken test... 23:26:01 INFO - TEST-INFO | started process 20378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiSg9_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:26:03 INFO - PROCESS | 20378 | 23:26:03 INFO - PROCESS | 20378 | (process:20446): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:26:13 INFO - PROCESS | 20378 | RSS: Main: 150814720 23:26:13 INFO - PROCESS | 20378 | 23:26:15 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59437/tests/kraken/driver.html?testName=audio-beat-detection) 23:26:16 INFO - PROCESS | 20378 | RSS: Main: 156598272 23:26:16 INFO - PROCESS | 20378 | 23:26:18 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59437/tests/kraken/driver.html?testName=audio-dft) 23:26:19 INFO - PROCESS | 20378 | RSS: Main: 156430336 23:26:19 INFO - PROCESS | 20378 | 23:26:22 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59437/tests/kraken/driver.html?testName=audio-fft) 23:26:23 INFO - PROCESS | 20378 | RSS: Main: 156086272 23:26:23 INFO - PROCESS | 20378 | 23:26:25 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59437/tests/kraken/driver.html?testName=audio-oscillator) 23:26:25 INFO - PROCESS | 20378 | RSS: Main: 155955200 23:26:25 INFO - PROCESS | 20378 | 23:26:27 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:28 INFO - PROCESS | 20378 | RSS: Main: 156434432 23:26:28 INFO - PROCESS | 20378 | 23:26:31 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59437/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:32 INFO - PROCESS | 20378 | RSS: Main: 156499968 23:26:32 INFO - PROCESS | 20378 | 23:26:35 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59437/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:36 INFO - PROCESS | 20378 | RSS: Main: 156639232 23:26:36 INFO - PROCESS | 20378 | 23:26:38 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59437/tests/kraken/driver.html?testName=json-parse-financial) 23:26:39 INFO - PROCESS | 20378 | RSS: Main: 156983296 23:26:39 INFO - PROCESS | 20378 | 23:26:41 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:41 INFO - PROCESS | 20378 | RSS: Main: 156811264 23:26:41 INFO - PROCESS | 20378 | 23:26:43 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:44 INFO - PROCESS | 20378 | RSS: Main: 156856320 23:26:44 INFO - PROCESS | 20378 | 23:26:45 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:46 INFO - PROCESS | 20378 | RSS: Main: 157110272 23:26:46 INFO - PROCESS | 20378 | 23:26:49 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:49 INFO - PROCESS | 20378 | RSS: Main: 157466624 23:26:49 INFO - PROCESS | 20378 | 23:26:52 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:53 INFO - PROCESS | 20378 | RSS: Main: 157462528 23:26:53 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | Cycle 1(1): loaded http://localhost:59437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59437/tests/kraken/driver.html?testName=ai-astar) 23:26:54 INFO - PROCESS | 20378 | RSS: Main: 158928896 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | __start_tp_report 23:26:54 INFO - PROCESS | 20378 | _x_x_mozilla_page_load 23:26:54 INFO - PROCESS | 20378 | _x_x_mozilla_page_load_details 23:26:54 INFO - PROCESS | 20378 | |i|pagename|runs| 23:26:54 INFO - PROCESS | 20378 | |0;ai-astar;107;112;104;109;111;112;102;109;110;110 23:26:54 INFO - PROCESS | 20378 | |1;audio-beat-detection;158;126;158;173;130;156;153;128;187;131 23:26:54 INFO - PROCESS | 20378 | |2;audio-dft;164;163;172;166;166;168;166;165;162;162 23:26:54 INFO - PROCESS | 20378 | |3;audio-fft;76;74;78;181;74;78;77;77;156;77 23:26:54 INFO - PROCESS | 20378 | |4;audio-oscillator;91;92;150;94;92;92;138;93;92;150 23:26:54 INFO - PROCESS | 20378 | |5;imaging-gaussian-blur;118;118;117;118;119;122;117;118;118;117 23:26:54 INFO - PROCESS | 20378 | |6;imaging-darkroom;148;146;147;147;147;147;147;147;147;146 23:26:54 INFO - PROCESS | 20378 | |7;imaging-desaturate;95;95;97;97;94;95;95;95;95;100 23:26:54 INFO - PROCESS | 20378 | |8;json-parse-financial;54;55;57;52;54;54;55;75;54;53 23:26:54 INFO - PROCESS | 20378 | |9;json-stringify-tinderbox;56;56;56;56;56;56;56;57;56;56 23:26:54 INFO - PROCESS | 20378 | |10;stanford-crypto-aes;73;75;73;73;74;75;74;75;74;75 23:26:54 INFO - PROCESS | 20378 | |11;stanford-crypto-ccm;116;120;118;114;116;118;117;112;142;131 23:26:54 INFO - PROCESS | 20378 | |12;stanford-crypto-pbkdf2;159;163;164;163;162;162;161;162;162;159 23:26:54 INFO - PROCESS | 20378 | |13;stanford-crypto-sha256-iterative;67;68;67;65;70;70;73;64;65;67 23:26:54 INFO - PROCESS | 20378 | __end_tp_report 23:26:54 INFO - PROCESS | 20378 | __start_cc_report 23:26:54 INFO - PROCESS | 20378 | _x_x_mozilla_cycle_collect,840 23:26:54 INFO - PROCESS | 20378 | __end_cc_report 23:26:54 INFO - PROCESS | 20378 | __startTimestamp1467527214954__endTimestamp 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | ------- Summary: start ------- 23:26:54 INFO - PROCESS | 20378 | Number of tests: 14 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.34 (3.0%) stddev-sans-first:3.49 23:26:54 INFO - PROCESS | 20378 | Values: 107.0 112.0 104.0 109.0 111.0 112.0 102.0 109.0 110.0 110.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:157.00 stddev:20.80 (13.2%) stddev-sans-first:21.85 23:26:54 INFO - PROCESS | 20378 | Values: 158.0 126.0 158.0 173.0 130.0 156.0 153.0 128.0 187.0 131.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:3.03 (1.8%) stddev-sans-first:3.17 23:26:54 INFO - PROCESS | 20378 | Values: 164.0 163.0 172.0 166.0 166.0 168.0 166.0 165.0 162.0 162.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:39.31 (51.1%) stddev-sans-first:41.10 23:26:54 INFO - PROCESS | 20378 | Values: 76.0 74.0 78.0 181.0 74.0 78.0 77.0 77.0 156.0 77.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:92.00 stddev:26.16 (28.4%) stddev-sans-first:26.98 23:26:54 INFO - PROCESS | 20378 | Values: 91.0 92.0 150.0 94.0 92.0 92.0 138.0 93.0 92.0 150.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 23:26:54 INFO - PROCESS | 20378 | Values: 118.0 118.0 117.0 118.0 119.0 122.0 117.0 118.0 118.0 117.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 23:26:54 INFO - PROCESS | 20378 | Values: 148.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.75 (1.8%) stddev-sans-first:1.83 23:26:54 INFO - PROCESS | 20378 | Values: 95.0 95.0 97.0 97.0 94.0 95.0 95.0 95.0 95.0 100.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:54.50 stddev:6.70 (12.3%) stddev-sans-first:7.06 23:26:54 INFO - PROCESS | 20378 | Values: 54.0 55.0 57.0 52.0 54.0 54.0 55.0 75.0 54.0 53.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 23:26:54 INFO - PROCESS | 20378 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 56.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.50 stddev:0.88 (1.2%) stddev-sans-first:0.83 23:26:54 INFO - PROCESS | 20378 | Values: 73.0 75.0 73.0 73.0 74.0 75.0 74.0 75.0 74.0 75.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:118.00 stddev:9.14 (7.7%) stddev-sans-first:9.56 23:26:54 INFO - PROCESS | 20378 | Values: 116.0 120.0 118.0 114.0 116.0 118.0 117.0 112.0 142.0 131.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.64 (1.0%) stddev-sans-first:1.41 23:26:54 INFO - PROCESS | 20378 | Values: 159.0 163.0 164.0 163.0 162.0 162.0 161.0 162.0 162.0 159.0 23:26:54 INFO - PROCESS | 20378 | 23:26:54 INFO - PROCESS | 20378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.76 (4.1%) stddev-sans-first:2.92 23:26:54 INFO - PROCESS | 20378 | Values: 67.0 68.0 67.0 65.0 70.0 70.0 73.0 64.0 65.0 67.0 23:26:54 INFO - PROCESS | 20378 | -------- Summary: end -------- 23:26:54 INFO - PROCESS | 20378 | 23:26:55 INFO - TEST-INFO | 20378: exit 0 23:26:55 INFO - TEST-OK | kraken | took 61062ms 23:26:55 INFO - SUITE-END | took 1171s 23:26:56 INFO - Completed test suite (00:19:31) 23:26:56 INFO - javascript benchmark 23:26:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.2936618627, 3330.2839889423776, 3435.3988052090876, 3436.776609520379, 3442.2943296624194, 5665.065264231397, 5665.291838520185, 5679.062954612489, 5683.0622947213715, 5683.971580142103, 5659.462351076651, 5679.432056794319, 5689.3172819261645, 5698.8290351289525, 5715.685637289947, 5106.66806657567, 5123.666961647481, 5163.7676304566385, 5183.092958732207, 5198.558122559587, 5097.464766199551, 5144.588432925376, 5153.768080436389, 5293.735313234342, 5329.014132385501, 5150.33045704058, 5179.715115668637, 5186.4813518648025, 5189.948100518985, 5208.609354298424, 5215.973920130394, 5240.633155679104, 5243.501867322599, 5249.186376111708, 5278.023565640369, 4965.751712414401, 4991.6256280778725, 5149.0989076911765, 5161.329027226437, 5194.740262986836, 5447.373552041527, 5466.890662186734, 5569.972150139223, 5588.245586845765, 5621.8594535136535, 6048.727807248684, 6066.302375226861, 6080.878382432371, 6084.939150608481, 6125.78559750411, 5996.670183139926, 6020.8494787630225, 6104.96947515264, 6107.938920610782, 6138.1099740537375, 5555.972220138914, 5557.249771280865, 5566.443355664442, 5567.66594004361, 5602.411746766572, 6078.966575682145, 6087.239095113111, 6096.939030609726, 6103.572749907553, 6111.083337499322, 5752.913706294409, 5828.067509198508, 5873.911891321633, 5878.882422351529, 5886.676232807236, 6029.276486821609, 6038.63768173911, 6040.577159598786, 6041.486473649789, 6041.969790151021, 5970.880582388415, 5975.073863551156, 6012.188354572077, 6015.518758499309, 6019.578629495893, 5854.0048191806645, 5901.557383196277, 6013.5189184865985, 6015.759369625253, 6041.9395806041375, 4614.215583350839, 4621.930671039937, 4628.722276663411, 4631.096936097429, 4655.930161047587, 4056.290149223933, 4155.771432571238, 4158.500979882433, 4163.791810409467, 4187.350960601112, 5673.0, 5787.681677507693, 5818.854528636818, 5851.795187168429, 5908.20239267702, 6026.849328766728, 6028.4272994065495, 6034.547408944347, 6035.426634469718, 6036.607620504653, 5673.659580425187, 5758.481736643638, 5775.971120144456, 5783.624064435799, 5792.189093526909, 5184.040952423814, 5246.737663116905, 5263.052650522866, 5272.05103081449, 5294.708791016531, 6272.40412160844, 6284.528660350492, 6284.874302514016, 6294.622322660655, 6300.21247344082, 5941.643501389931, 6037.45662890342, 6101.237345331833, 6111.144439778345, 6118.663473509, 6118.847028824315, 6169.84575385619, 6177.289611694712, 6220.315765265726, 6295.622262664255, 6003.039513677791, 6011.519078473799, 6024.7288872001745, 6036.33600303975, 6063.939360606338, 6124.234470691164, 6132.724027418688, 6142.508599312134, 6143.877122457615, 6149.600275982047, 5743.942560574341, 5846.619969701956, 5859.736311866061, 5894.322152952465, 5911.497522710618, 5859.531237500904, 5863.912041319469, 5877.4122587740885, 5890.4993075587345, 5902.911456328073, 5687.687177205294, 5797.0, 5812.680302583399, 5823.359430462561, 5837.153612726046, 5914.319853216935, 5953.523718102628, 5961.046232602763, 5971.0744834550715, 6012.7294271757, 5819.592628516132, 5832.562557808266, 5832.679202643725, 5832.970835145967, 5842.0], "value": 5581.099760308973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.9900251496225, 670.842352047269, 680.3672584496417, 736.5507040705171, 776.5806464509166, 37976.62023379765, 39108.99999999996, 39496.0, 39605.20789584214, 39632.80183599085, 39833.800830995875, 40591.39112913309, 40654.0, 40972.180556388856, 40980.0, 8793.428427152214, 8979.191872731453, 9010.54947252638, 9013.684521041765, 9015.909840901573, 8896.555172241395, 8992.730218093468, 9194.264458843276, 9196.632134714604, 9214.170724634781, 9179.449233046005, 9236.122568355995, 9241.676541321056, 9252.028537003618, 9253.722388328328, 9189.586468608928, 9227.26181905446, 9270.30472714549, 9273.582688778954, 9279.489628070454, 8951.686690965786, 9086.182243598108, 9107.590158442887, 9120.817583648357, 9126.0, 41260.1747965039, 41644.0, 42207.788961055, 42307.153856922996, 42382.57617423817, 3744.4944932434046, 3831.501904752364, 3967.3255546557157, 4057.6753859691153, 4331.631811296043, 31715.682843171733, 32083.51874721881, 32462.513062304086, 32561.348773024405, 32571.34857302841, 3768.4724138620613, 3832.6550610445192, 3848.230353929225, 3895.3962135868987, 3985.123272879962, 253912.0, 257904.0, 258589.0, 259748.0, 343448.2827585871, 39760.2047959045, 66205.00692489617, 66677.0, 66702.33297667059, 66758.66620666865, 37674.81162594169, 37708.0, 37741.86774396773, 37815.05462363463, 37930.810345948645, 16652.167391630614, 16981.0, 17012.404565840137, 17017.744733829004, 17066.57333566646, 13683.726325473435, 13696.383662735201, 13799.793003104962, 13814.861851381558, 13866.029377943649, 9235.861462078074, 9310.813783724288, 9421.340506164503, 9493.0981556752, 9575.952120239353, 3608.404613238786, 3618.203995121069, 3643.216708407705, 3707.3882809336696, 3713.4801127842125, 1046.6493724602192, 1120.7702421003676, 1155.2548606149155, 1157.3634501024403, 1255.5354518828092, 33002.0, 33071.50392744111, 33209.3358132836, 33311.66688333134, 33549.49675754866, 1207.2635692227734, 1254.3226657604973, 1284.7494738525897, 1286.1897004886862, 1287.2083668543778, 17605.911970440065, 17699.91150044267, 17726.29094836218, 17734.20196091179, 17848.0, 493794.0, 550634.0, 571350.0, 582630.0, 843263.0, 55838.72080639571, 56643.433565663814, 56774.43225567774, 56817.43182568204, 56938.43061569414, 1518.4154100671321, 1535.6314484523634, 1540.537838648401, 1563.3277690592927, 1571.1986886687644, 33218.83390583032, 33944.15139621529, 33949.66050339564, 34338.141546461535, 34730.0, 54064.729676351366, 54495.455045450624, 54618.18072728833, 54709.45290547043, 54730.179047313526, 451583.0, 453013.0, 454238.0, 454870.0, 455038.0, 30326.393472130876, 31094.067177984696, 31318.843405782824, 31413.842930786115, 31506.0, 49421.752891235315, 51115.0, 51201.23198151956, 51684.741576291875, 51748.74125629348, 39942.600573993885, 40570.59429405786, 40614.79692601518, 40951.795241024796, 41183.176336473705, 41722.791386042874, 41941.161176775684, 42556.36165457583, 43098.1380372397, 43998.78000609976, 43597.910052248946, 44169.77915110404, 44361.0, 44735.77632111819, 44872.77563612161, 36855.44716829196, 37227.0, 37385.2522949534, 38085.80957095197, 38143.80928095453, 27887.0, 27971.0, 28040.29899252535, 28143.43713125767, 28389.574156387258], "value": 19665.073276953513, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.3152421887091, 438.0844035964833, 439.63071020342903, 444.42668957045413, 450.7160488891998, 18727.15727792249, 18822.341218057387, 19367.0, 19555.90222048888, 19593.314234001813, 18924.810751892477, 19177.0, 19766.30817921373, 19818.207271709114, 19965.80034199661, 4915.901681966358, 5058.291839142523, 5061.291419201315, 5065.594752419797, 5066.797328106872, 5238.292830467895, 5416.4312747161575, 5423.918641220384, 5505.174223866432, 5544.279243698314, 5529.115341545354, 5531.529819965308, 5545.390007099216, 5551.278333816598, 5562.471565201299, 5402.864928376783, 5519.3100862392, 5524.033294173523, 5530.976769297673, 5919.881602367928, 5340.412554618989, 5367.570594352443, 5369.81205657804, 5370.570354371641, 5396.163594642837, 23699.170529031573, 23818.76181238183, 23882.76117238823, 24017.87991060051, 24317.27048188557, 2357.9174728884577, 2399.928002159938, 2432.391902024494, 3075.3403993293414, 3221.597300337458, 14290.642733931734, 14532.927335363256, 14613.488527901472, 14820.40718371264, 14865.554033379016, 2097.968530472044, 2135.4768081820052, 2148.0977989244557, 2149.8065174134404, 2162.8918554072234, 76276.23723762747, 82298.0, 84015.57992210062, 84025.57987210025, 86955.56522217412, 11110.888891111146, 11552.422378881023, 11624.825627615592, 11646.94176529112, 11766.352850593299, 15764.76352854708, 15956.76064859028, 16042.43851465193, 16048.03711777297, 16078.517644470685, 8324.583770811436, 8824.0, 8832.91167088321, 8837.29301655866, 9019.819603608023, 8920.509371984474, 8995.775105622412, 9022.323325750594, 9027.593758280893, 9056.184943355129, 4713.952860471351, 4877.487863774323, 4905.2151655734915, 4941.888075183055, 4992.850214493571, 1944.8444124470009, 1952.1313015707874, 1990.36789832339, 2005.2881227164146, 2017.273781438681, 974.1670871404847, 1038.200585549138, 1039.0544604410102, 1102.4377567440663, 1114.6321713834416, 19493.90253048754, 20109.798902010793, 20399.796002040086, 20454.897725511575, 20531.0, 1068.6420049283577, 1095.39205740813, 1112.1769890281296, 1146.696125526736, 1151.2114201771813, 10588.417637029883, 11461.369624670557, 11492.25300355491, 11515.0, 11564.479598418091, 517447.0, 522524.0, 532798.0, 539707.0, 544616.0, 92165.53917230506, 93644.53177734067, 93733.0, 95944.0, 96300.51849740847, 1072.6406653771073, 1078.231700011981, 1121.1087185687236, 1124.8087825069758, 1134.28540019787, 17402.95582265068, 17539.56151096233, 17791.377301794375, 17836.643267134325, 18034.36879709204, 40418.0, 41012.58987410088, 41033.794831025654, 41473.585264146976, 41771.582284176766, 57716.71141644433, 59619.0, 59682.0, 60283.0, 60721.39278607334, 9434.103760142776, 9501.904980950101, 9517.809643807224, 9539.14147726708, 9621.807563848824, 9521.0, 9630.181434578139, 9752.317337786571, 9988.101070903364, 10175.847362289423, 8517.063123056334, 8703.56482175876, 8805.823883522422, 9059.637614495346, 9324.906750932403, 8926.241269492166, 8976.730698079067, 9049.185573298435, 9238.445693258158, 9465.858012129962, 6290.528210384148, 8327.833443331221, 9051.728448146567, 9154.679586214717, 9420.62317507292, 12974.156679816158, 13236.0, 13603.115797473132, 13861.514846980308, 14133.15201087938, 13456.46174153023, 13504.324783760576, 13652.453901843815, 13734.175949442666, 13764.724705506034], "value": 9460.95699637338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1546.1341648676741, 1552.3169805285675, 1779.1282271686869, 1858.758361413016, 1872.1949561688486, 7481.812954676136, 8273.751787446372, 8390.077091519935, 8460.238578527931, 8578.313734901216, 8125.796855078626, 8273.29676977456, 8365.623546940387, 8420.410571260014, 8469.322454203664, 2317.351141680328, 2335.8481698689616, 2341.800946919514, 2354.7645235476402, 2355.5524450354465, 2292.6331786914097, 2357.163207061494, 2400.4478969836946, 2409.0604664180983, 2417.9758202417925, 2311.895964681585, 2330.137848995874, 2331.708536432946, 2336.696229490164, 2349.3539276698957, 2334.7548507406646, 2351.43565544269, 2353.5881220786378, 2355.3758254062686, 2406.7232268289195, 2363.7754413330877, 2366.8343215974887, 2370.5258948210253, 2383.15398033699, 2390.163442795008, 8635.222829945335, 8644.135586441369, 8666.436681615674, 8679.262262707678, 8682.782930426727, 5106.361704786902, 5187.766550505198, 5209.6874187548865, 5210.322658054429, 5231.659942103751, 3338.8163650999186, 3355.1108956126645, 3383.678550537695, 3405.4210784166753, 3487.1630808606005, 1055.176961969665, 1092.5247517329988, 1107.6787731557838, 1111.9444027798659, 1114.186643750059, 11835.822462663067, 11887.583934562248, 11929.582464613784, 11935.522579096825, 11935.985441237504, 4147.52303485097, 4230.513490948519, 4266.658667306608, 4293.2701440755145, 4293.3989241506215, 9417.387869788441, 9506.47714375716, 9530.571124299424, 9543.47510886908, 9590.280728945358, 5134.0, 5144.0, 5146.665466744649, 5147.459516750687, 5158.3552055993005, 4623.445186577632, 4756.881077973009, 4768.47546769855, 4786.473487916326, 4816.349792778, 3743.7192210584317, 3784.0918179637238, 3843.6348546888003, 3871.438641397038, 3921.3333733265413, 1151.343734071588, 1152.0438036429744, 1169.3802284789076, 1172.554429316854, 1198.053537705203, 1017.013496907998, 1069.6630561373142, 1078.5308390850005, 1085.3216739537788, 1096.3915027160003, 6201.317855035943, 6274.749010039547, 6298.653574053471, 6349.777757778455, 6380.585261958051, 421.4521122540746, 432.8485030239391, 440.1505095166296, 440.29772512841964, 447.03663604931427, 4288.699791014599, 4335.414719012956, 4344.543822898613, 4468.3074123510905, 4469.977650111794, 10263.178945684327, 10373.222008349405, 10391.220658450646, 10497.790044199226, 10521.316114452537, 10256.58973641046, 10303.587856485807, 10314.1748660107, 10327.793444131075, 10349.172066234683, 7623.580703061385, 8026.197380261927, 8095.271425571609, 8137.918620813834, 8222.917770822216, 6137.140800288053, 6161.753529858755, 6169.9691501544, 6224.470919971672, 6277.843053923689, 8728.389012769045, 8755.649774009224, 8776.692815751418, 8806.647734090564, 8839.0, 8706.695265665672, 8984.0, 9044.41211321262, 9059.36584439083, 9077.500737459239, 6833.384995350442, 7420.183779784327, 7551.282628150317, 7594.430417718582, 7595.620218989139, 8219.260266576037, 8304.750857474286, 8309.0, 8318.209770071833, 8363.121872203574, 7381.889271661037, 7630.542167469969, 7642.7325043623205, 7650.579218143055, 7652.081750190013, 7374.0, 7411.4811963162065, 7476.439267054884, 7527.209642987407, 7555.773326800205, 7114.537555058904, 7147.142342918883, 7230.710771569289, 7265.564066156047, 7265.673044713107, 5377.784888604569, 5399.4060653327315, 5474.972625136849, 5485.286912701324, 5576.749046292845, 5408.891822163613, 5414.810481633124, 5452.890942181213, 5476.72616369172, 5554.083576210041], "value": 4492.156573040137, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.0701817383845, 368.2542850727277, 369.95560532736073, 370.5960503051673, 374.88378602633185, 6487.383698548636, 6496.577722448038, 6511.934880651192, 6564.737410503574, 6569.211694596649, 6543.770968016121, 6593.604383736979, 6607.33926607339, 6621.635810030446, 6626.536142470029, 5034.320366750497, 5048.9495105048845, 5053.696778193302, 5058.873528161807, 5060.190369540875, 5059.949400505985, 5078.060558796616, 5078.21287700407, 5084.542391184793, 5089.949100509003, 5009.073321435528, 5009.472111006142, 5017.9247311290355, 5020.171671674169, 5046.646734728571, 4696.178168820443, 4810.230363141881, 5014.774335154927, 5022.397312322526, 5038.345015148026, 4181.958180418187, 4187.560306167839, 4201.033762234672, 4212.747235165869, 4212.7682977436225, 6242.344553821828, 6244.750209991595, 6255.061740738925, 6260.467860231885, 6261.279952805395, 5480.287562616834, 5583.609147359686, 5588.413216612238, 5641.407652196502, 5652.09566469367, 6870.141232345957, 6880.931190688079, 6881.243063263087, 6889.069975553286, 6909.689063992132, 4618.099470603233, 4623.260278355447, 4628.09752098341, 4628.305754136873, 4638.536146385368, 7173.461990350745, 7239.167495738005, 7252.347288744038, 7262.128544574632, 7265.6367181641235, 4655.86032419028, 4835.44392394872, 4878.926816097762, 4883.413990321184, 4911.091448082045, 4774.116788394158, 4810.855674329776, 4815.3499277597775, 4819.518048195152, 4828.493008234085, 5615.326160860641, 5632.014397480424, 5665.631733937281, 5678.829635110953, 5686.545076393879, 6973.476989225727, 6981.511294209458, 6985.441164706811, 6988.301169882971, 7004.2995700430565, 1725.55998220453, 1747.161362545985, 1747.9912600436917, 1752.1239380309846, 1753.587906841891, 1094.9069329106956, 1114.7547539541288, 1135.7103938495632, 1137.4881303413497, 1151.1711567671264, 6743.089682892844, 6746.595204287759, 6770.052192693027, 6774.525783195129, 6791.72833086671, 7044.87282034872, 7112.395446387115, 7122.465815063891, 7138.214796372395, 7138.714451421989, 6746.460283177334, 6750.594964302158, 6764.5603035802515, 6766.898496522556, 6774.390304872585, 3824.9808750956067, 3843.404272337792, 3869.9226015479535, 3871.0, 3874.670652994471, 7363.0, 7575.053118360205, 7576.772696819105, 7580.848383032308, 7586.165521792598, 7380.188179300273, 7440.627968601549, 7441.144268409094, 7444.851102978018, 7444.962775186198, 7614.390848732088, 7617.885731714029, 7619.390448763975, 7623.656935437919, 7623.733169339157, 7156.606386648576, 7163.3552980232025, 7272.781816545512, 7288.927110729037, 7291.890621640574, 7107.82230444243, 7145.928540714526, 7165.749198778018, 7166.104236970379, 7182.640867956686, 7545.245475452411, 7575.0909890813455, 7577.469577129548, 7578.0, 7586.658600362886, 4885.316055752269, 4935.309056732132, 4940.0, 4943.480934501969, 4946.653734238713, 6993.510454268152, 7259.0, 7265.418766498562, 7266.527675701062, 7273.272672732684, 7001.159860816734, 7035.859282814417, 7038.964805176146, 7046.718131274692, 7048.224695283618, 6978.651067446709, 7024.894626580707, 7034.437245020284, 7035.683394247373, 7039.296070392919, 6886.414654754402, 6887.345702158287, 6901.75843845463, 6920.515563910478, 6935.2717964615, 6996.510244282851, 7049.365557099885, 7060.964695176492, 7071.116110486189, 7079.716811327695, 6704.994250862214, 6890.552114112566, 6893.75871844483, 6894.24163342022, 6910.378065974087], "value": 5235.134294087289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.9332853371731, 834.1950018232401, 856.0113069404839, 860.8407444622743, 904.5251243097374, 15890.920545397272, 16219.18904054797, 16393.344266229353, 16412.343506259764, 16435.753463698053, 14938.775918361207, 15000.399984000627, 15036.323365448554, 15122.773158402606, 15124.0, 914.2777206007246, 920.4431319051978, 946.2004606107828, 948.9478078705669, 949.060430174126, 920.1764420843341, 925.9166674999249, 925.9675911343104, 928.6888892221114, 929.586334081334, 982.7493989032787, 985.9852102218473, 986.7187851462298, 988.4761076629397, 990.782027953849, 964.599691128181, 972.863799068131, 972.9659461918834, 975.0201047946769, 983.105374109564, 719.7696737044148, 722.0937723157456, 723.8154270661, 724.8296650287231, 725.5936675461759, 16089.758653620205, 16205.189740513046, 16235.269412876449, 16259.187040647921, 16289.0, 14198.077124986843, 14524.854751452456, 14884.0, 15020.324085416183, 15164.696706065928, 11675.708107297301, 11776.175667703264, 11880.287182769061, 11977.341246231454, 12000.0, 4091.3044782387065, 4107.404426358161, 4152.480939882515, 4175.812088455997, 4177.832886684529, 56696.0, 57500.0, 59057.704711476596, 59397.703011484664, 59496.0, 11373.431328433546, 11432.59985900506, 11505.194636375541, 11717.414129293671, 11876.287422754662, 20746.377608671763, 21104.577908441745, 21174.47063823386, 21234.893825530773, 21377.251796187058, 8794.296456283482, 8814.427062240933, 8894.4663320201, 8946.642134314685, 8960.820783584291, 4790.233562630032, 4879.731614761151, 4927.605791536668, 4981.37732783402, 5039.168537191323, 3616.0598244456105, 3669.7247706422127, 3670.50448189491, 3674.41209406499, 3676.4117741161285, 614.0604874541958, 629.1726379810534, 640.1134428816123, 646.5086534234016, 650.5673726971605, 731.5098883747902, 768.1511929318135, 791.6437603078638, 836.4646626159263, 841.6465084664455, 9291.21024712907, 9698.612055517842, 9775.78073238649, 9955.203583713286, 10074.143697785623, 719.3274288540232, 782.4561929459085, 816.0900595835719, 821.7292946493524, 831.1356189562907, 4511.278195488706, 4535.9773201133785, 4697.201475749131, 4734.810607575727, 4889.071076495455, 64108.35891641024, 64241.0, 64592.677036614514, 64687.353126469076, 64724.67637661781, 56313.0, 57493.425065749645, 57608.0, 60339.0, 60612.39387606156, 53230.0, 53523.19715204197, 53661.73169134207, 54091.72954135204, 54434.45565544373, 8753.956230218808, 8817.206451419403, 8912.509811960144, 9277.860832087388, 9356.574219293, 38719.22561548697, 38824.223515530095, 39108.0, 39604.40593391159, 41070.38394424026, 44821.0, 45418.77290613526, 47695.52304476911, 48696.513034870615, 50153.24770128378, 11610.303381797119, 11768.94115529417, 11958.402079896145, 12058.397080145782, 12126.696832578904, 13286.867131328563, 13296.268705220918, 13429.328533573087, 13491.797623035858, 13575.185488870698, 12440.688982775502, 12544.435500402322, 12562.054179890172, 12807.679808004874, 12937.353132343156, 12434.37828108609, 12549.93725031369, 12594.87405125937, 13042.217466952014, 13090.0, 11904.285742855456, 12061.396930153633, 12135.393230338272, 12147.453364598437, 12469.0, 9651.276154288596, 10031.899681003097, 10167.593296268067, 10242.48787560604, 10455.111315538265, 9878.584448052363, 10264.58941642326, 10334.793304134026, 10370.585176592851, 10371.222158338003], "value": 7190.00284237758, "unit": "score"}], "name": "dromaeo_css", "value": 7483.13020282797, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 104.0, 109.0, 111.0, 112.0, 102.0, 109.0, 110.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 158.0, 173.0, 130.0, 156.0, 153.0, 128.0, 187.0, 131.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 172.0, 166.0, 166.0, 168.0, 166.0, 165.0, 162.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 78.0, 181.0, 74.0, 78.0, 77.0, 77.0, 156.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 150.0, 94.0, 92.0, 92.0, 138.0, 93.0, 92.0, 150.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 122.0, 117.0, 118.0, 118.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 100.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 52.0, 54.0, 54.0, 55.0, 75.0, 54.0, 53.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 73.0, 74.0, 75.0, 74.0, 75.0, 74.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 118.0, 114.0, 116.0, 118.0, 117.0, 112.0, 142.0, 131.0], "value": 120.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 164.0, 163.0, 162.0, 162.0, 161.0, 162.0, 162.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 70.0, 70.0, 73.0, 64.0, 65.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1524.2999999999997, "alertThreshold": 2.0}]} 23:26:56 INFO - Return code: 0 23:26:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:56 ERROR - # TBPL SUCCESS # 23:26:56 INFO - Running post-action listener: _resource_record_post_action 23:26:56 INFO - Running post-run listener: _resource_record_post_run 23:26:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 467623936; Read time: 20; Write time: 1459900 23:26:57 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 249548800; Read time: 0; Write time: 1098000 23:26:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218075136; Read time: 20; Write time: 361900 23:26:57 INFO - Running post-run listener: _upload_blobber_files 23:26:57 INFO - Blob upload gear active. 23:26:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:26:57 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:58 INFO - (blobuploader) - INFO - Done attempting. 23:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:59 INFO - (blobuploader) - INFO - Done attempting. 23:26:59 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:59 INFO - Return code: 0 23:26:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5639b79b9fc391ea2eb3ca2f90890e81a589ca1350f5d408814be75e2762d200f05e65428176d77ace17a5c49cea12ce2221c39de31b02e56cdd14226befa3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c908aadd2c81ae0db456d8ccb1ee067dc243a13cff2c13c7fee4c867a3fc2dcb9de029ed394a46105bfdfc125c0b112394f7d590f78b53f1022f71e2399cd81b"} 23:26:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:59 INFO - Contents: 23:26:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5639b79b9fc391ea2eb3ca2f90890e81a589ca1350f5d408814be75e2762d200f05e65428176d77ace17a5c49cea12ce2221c39de31b02e56cdd14226befa3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c908aadd2c81ae0db456d8ccb1ee067dc243a13cff2c13c7fee4c867a3fc2dcb9de029ed394a46105bfdfc125c0b112394f7d590f78b53f1022f71e2399cd81b"} 23:26:59 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:59 INFO - Copying logs to upload dir... 23:26:59 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.368398 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-02 23:26:58.547769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:58.550926) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5639b79b9fc391ea2eb3ca2f90890e81a589ca1350f5d408814be75e2762d200f05e65428176d77ace17a5c49cea12ce2221c39de31b02e56cdd14226befa3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c908aadd2c81ae0db456d8ccb1ee067dc243a13cff2c13c7fee4c867a3fc2dcb9de029ed394a46105bfdfc125c0b112394f7d590f78b53f1022f71e2399cd81b"} build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5639b79b9fc391ea2eb3ca2f90890e81a589ca1350f5d408814be75e2762d200f05e65428176d77ace17a5c49cea12ce2221c39de31b02e56cdd14226befa3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c908aadd2c81ae0db456d8ccb1ee067dc243a13cff2c13c7fee4c867a3fc2dcb9de029ed394a46105bfdfc125c0b112394f7d590f78b53f1022f71e2399cd81b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:58.579678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:58.580323) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1467520061.876225-631040473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:58.664658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:58.665368) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:58.665990) ========= ========= Total master_lag: 0.19 =========