builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1466481145.58 results: success (0) buildid: 20160620192300 builduid: a3e87aecdd354a059635760aa42ae4b1 revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.583855) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.584313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.584657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.650328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.650718) ========= 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=52faae308a556c440401f8e5000001e8-1466480104.673564-505014766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 20:52:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-20 20:52:26 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167265 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.845299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.845627) ========= 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=52faae308a556c440401f8e5000001e8-1466480104.673564-505014766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.895958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:25.896266) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --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=52faae308a556c440401f8e5000001e8-1466480104.673564-505014766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 20:52:26,373 truncating revision to first 12 chars 2016-06-20 20:52:26,373 Setting DEBUG logging. 2016-06-20 20:52:26,373 attempt 1/10 2016-06-20 20:52:26,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027db1e33f89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 20:52:26,707 unpacking tar archive at: fx-team-027db1e33f89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:26.589187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:26.589482) ========= script_repo_revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:26.589888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:26.590165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 20:52:26.607913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-20 20:52:26.608185) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=52faae308a556c440401f8e5000001e8-1466480104.673564-505014766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:52:27 INFO - MultiFileLogger online at 20160620 20:52:27 in /builds/slave/test 20:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:52:27 INFO - {'append_to_log': False, 20:52:27 INFO - 'base_work_dir': '/builds/slave/test', 20:52:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:52:27 INFO - 'branch': 'Fx-Team-Non-PGO', 20:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:52:27 INFO - 'config_files': ('talos/linux_config.py',), 20:52:27 INFO - 'default_actions': ('clobber', 20:52:27 INFO - 'read-buildbot-config', 20:52:27 INFO - 'download-and-extract', 20:52:27 INFO - 'populate-webroot', 20:52:27 INFO - 'create-virtualenv', 20:52:27 INFO - 'install', 20:52:27 INFO - 'run-tests'), 20:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:52:27 INFO - 'download_minidump_stackwalk': True, 20:52:27 INFO - 'download_symbols': 'ondemand', 20:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 20:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 20:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:52:27 INFO - 'installer_path': 'installer.exe', 20:52:27 INFO - 'log_level': 'info', 20:52:27 INFO - 'log_name': 'talos', 20:52:27 INFO - 'log_to_console': True, 20:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:52:27 INFO - 'opt_config_files': (), 20:52:27 INFO - 'pip_index': False, 20:52:27 INFO - 'sps_profile': False, 20:52:27 INFO - 'sps_profile_interval': 0, 20:52:27 INFO - 'suite': 'dromaeojs-e10s', 20:52:27 INFO - 'system_bits': '32', 20:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:52:27 INFO - 'title': 'talos-linux64-ix-056', 20:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:52:27 INFO - 'use_talos_json': True, 20:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:52:27 INFO - 'work_dir': 'build'} 20:52:27 INFO - ##### 20:52:27 INFO - ##### Running clobber step. 20:52:27 INFO - ##### 20:52:27 INFO - Running pre-action listener: _resource_record_pre_action 20:52:27 INFO - Running main action method: clobber 20:52:27 INFO - rmtree: /builds/slave/test/build 20:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:52:28 INFO - Running post-action listener: _resource_record_post_action 20:52:28 INFO - ##### 20:52:28 INFO - ##### Finished clobber step (success) 20:52:28 INFO - ##### 20:52:28 INFO - ##### 20:52:28 INFO - ##### Running read-buildbot-config step. 20:52:28 INFO - ##### 20:52:28 INFO - Running pre-action listener: _resource_record_pre_action 20:52:28 INFO - Running main action method: read_buildbot_config 20:52:28 INFO - Using buildbot properties: 20:52:28 INFO - { 20:52:28 INFO - "project": "", 20:52:28 INFO - "product": "firefox", 20:52:28 INFO - "script_repo_revision": "production", 20:52:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:52:28 INFO - "repository": "", 20:52:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 20:52:28 INFO - "buildid": "20160620192300", 20:52:28 INFO - "pgo_build": "False", 20:52:28 INFO - "basedir": "/builds/slave/test", 20:52:28 INFO - "buildnumber": 1374, 20:52:28 INFO - "slavename": "talos-linux64-ix-056", 20:52:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:52:28 INFO - "platform": "ubuntu64_hw", 20:52:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:52:28 INFO - "branch": "fx-team", 20:52:28 INFO - "repo_path": "integration/fx-team", 20:52:28 INFO - "revision": "027db1e33f89606c4996feae0203e5f3bb5db43d", 20:52:28 INFO - "stage_platform": "linux64", 20:52:28 INFO - "builduid": "a3e87aecdd354a059635760aa42ae4b1", 20:52:28 INFO - "slavebuilddir": "test" 20:52:28 INFO - } 20:52:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:52:28 INFO - Running post-action listener: _resource_record_post_action 20:52:28 INFO - ##### 20:52:28 INFO - ##### Finished read-buildbot-config step (success) 20:52:28 INFO - ##### 20:52:28 INFO - ##### 20:52:28 INFO - ##### Running download-and-extract step. 20:52:28 INFO - ##### 20:52:28 INFO - Running pre-action listener: _resource_record_pre_action 20:52:28 INFO - Running main action method: download_and_extract 20:52:28 INFO - mkdir: /builds/slave/test/build/tests 20:52:28 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')]} 20:52:28 INFO - https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:52:39 INFO - Downloaded 1361 bytes. 20:52:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:52:39 INFO - Using the following test package requirements: 20:52:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:52:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:52:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:52:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'jsshell-linux-x86_64.zip'], 20:52:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:52:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:52:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:52:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:52:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:52:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:52:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:52:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:52:39 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')]} 20:52:39 INFO - https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:52:47 INFO - Downloaded 22654960 bytes. 20:52:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:52:48 INFO - Return code: 0 20:52:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:52: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')]} 20:52:48 INFO - https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:52:49 INFO - Downloaded 22654960 bytes. 20:52:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:52:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:52:51 INFO - Return code: 0 20:52:51 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')]} 20:52:51 INFO - https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:52:52 INFO - Downloaded 14405384 bytes. 20:52:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:52:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:52:53 INFO - Return code: 0 20:52:53 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')]} 20:52:53 INFO - https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:52:54 INFO - Downloaded 56231287 bytes. 20:52:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:52:54 INFO - mkdir: /builds/slave/test/properties 20:52:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:52:54 INFO - Writing to file /builds/slave/test/properties/build_url 20:52:54 INFO - Contents: 20:52:54 INFO - build_url:https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:52:55 INFO - Running post-action listener: _resource_record_post_action 20:52:55 INFO - Running post-action listener: set_extra_try_arguments 20:52:55 INFO - ##### 20:52:55 INFO - ##### Finished download-and-extract step (success) 20:52:55 INFO - ##### 20:52:55 INFO - ##### 20:52:55 INFO - ##### Running populate-webroot step. 20:52:55 INFO - ##### 20:52:55 INFO - Running pre-action listener: _resource_record_pre_action 20:52:55 INFO - Running main action method: populate_webroot 20:52:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:52:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:52:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:52:55 INFO - '--tppagecycles', 20:52:55 INFO - '7'], 20:52:55 INFO - 'tests': ['tsvgm']}}, 20:52:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:52:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:52:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:52:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:52:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:52:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:52:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['damp', 'tps']}, 20:52:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'tests': ['damp', 'tps']}, 20:52:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['dromaeo_dom']}, 20:52:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:52:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['basic_compositor_video']}, 20:52:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:52:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['a11yr', 20:52:55 INFO - 'ts_paint', 20:52:55 INFO - 'tpaint', 20:52:55 INFO - 'sessionrestore', 20:52:55 INFO - 'sessionrestore_no_auto_restore', 20:52:55 INFO - 'tabpaint']}, 20:52:55 INFO - 'other-e10s': {'tests': ['a11yr', 20:52:55 INFO - 'ts_paint', 20:52:55 INFO - 'tpaint', 20:52:55 INFO - 'sessionrestore', 20:52:55 INFO - 'sessionrestore_no_auto_restore', 20:52:55 INFO - 'tabpaint']}, 20:52:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:52:55 INFO - 'ts_paint', 20:52:55 INFO - 'tpaint', 20:52:55 INFO - 'sessionrestore', 20:52:55 INFO - 'sessionrestore_no_auto_restore', 20:52:55 INFO - 'tabpaint']}, 20:52:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:52:55 INFO - 'ts_paint', 20:52:55 INFO - 'tpaint', 20:52:55 INFO - 'sessionrestore', 20:52:55 INFO - 'sessionrestore_no_auto_restore', 20:52:55 INFO - 'tabpaint']}, 20:52:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['a11yr', 20:52:55 INFO - 'ts_paint', 20:52:55 INFO - 'tpaint', 20:52:55 INFO - 'sessionrestore', 20:52:55 INFO - 'sessionrestore_no_auto_restore', 20:52:55 INFO - 'tabpaint']}, 20:52:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['a11yr', 20:52:55 INFO - 'ts_paint', 20:52:55 INFO - 'tpaint', 20:52:55 INFO - 'sessionrestore', 20:52:55 INFO - 'sessionrestore_no_auto_restore', 20:52:55 INFO - 'tabpaint']}, 20:52:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['tsvgx', 20:52:55 INFO - 'tsvgr_opacity', 20:52:55 INFO - 'tart', 20:52:55 INFO - 'tscrollx', 20:52:55 INFO - 'cart']}, 20:52:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:52:55 INFO - 'tsvgr_opacity', 20:52:55 INFO - 'tart', 20:52:55 INFO - 'tscrollx', 20:52:55 INFO - 'cart']}, 20:52:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'talos_options': ['--disable-e10s'], 20:52:55 INFO - 'tests': ['tp5o']}, 20:52:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'tests': ['tp5o']}, 20:52:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'talos_options': ['--disable-e10s', 20:52:55 INFO - '--xperf_path', 20:52:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:52:55 INFO - 'tests': ['tp5n']}, 20:52:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:52:55 INFO - 'talos_options': ['--xperf_path', 20:52:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:52:55 INFO - 'tests': ['tp5n']}}, 20:52:55 INFO - 'talos.zip': {'path': '', 20:52:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:52:55 INFO - Running post-action listener: _resource_record_post_action 20:52:55 INFO - ##### 20:52:55 INFO - ##### Finished populate-webroot step (success) 20:52:55 INFO - ##### 20:52:55 INFO - ##### 20:52:55 INFO - ##### Running create-virtualenv step. 20:52:55 INFO - ##### 20:52:55 INFO - Running pre-action listener: _resource_record_pre_action 20:52:55 INFO - Running main action method: create_virtualenv 20:52:55 INFO - Creating virtualenv /builds/slave/test/build/venv 20:52:55 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 20:52:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:52:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:52:55 INFO - Using real prefix '/usr' 20:52:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 20:52:57 INFO - Installing pip.................done. 20:52:57 INFO - Return code: 0 20:52:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:52: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')]} 20:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52: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')]} 20:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:57 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:52:57 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 20:52:57 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 20:52:57 INFO - Using env: {'DISPLAY': ':0', 20:52:57 INFO - 'HOME': '/home/cltbld', 20:52:57 INFO - 'LANG': 'en_US.UTF-8', 20:52:57 INFO - 'LANGUAGE': 'en_US:en', 20:52:57 INFO - 'LOGNAME': 'cltbld', 20:52:57 INFO - 'MAIL': '/var/mail/cltbld', 20:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:57 INFO - 'MOZ_NO_REMOTE': '1', 20:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:52:57 INFO - 'NO_EM_RESTART': '1', 20:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:52:57 INFO - 'PWD': '/builds/slave/test', 20:52:57 INFO - 'SHELL': '/bin/bash', 20:52:57 INFO - 'SHLVL': '1', 20:52:57 INFO - 'TERM': 'linux', 20:52:57 INFO - 'TMOUT': '86400', 20:52:57 INFO - 'USER': 'cltbld', 20:52:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:57 INFO - '_': '/tools/buildbot/bin/python'} 20:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:52:58 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 20:52:58 INFO - Cleaning up... 20:52:58 INFO - Return code: 0 20:52:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:52:58 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')]} 20:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:58 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')]} 20:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:58 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:52:58 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>=3.1.1'] in /builds/slave/test/build 20:52:58 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>=3.1.1 20:52:58 INFO - Using env: {'DISPLAY': ':0', 20:52:58 INFO - 'HOME': '/home/cltbld', 20:52:58 INFO - 'LANG': 'en_US.UTF-8', 20:52:58 INFO - 'LANGUAGE': 'en_US:en', 20:52:58 INFO - 'LOGNAME': 'cltbld', 20:52:58 INFO - 'MAIL': '/var/mail/cltbld', 20:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:58 INFO - 'MOZ_NO_REMOTE': '1', 20:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:52:58 INFO - 'NO_EM_RESTART': '1', 20:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:52:58 INFO - 'PWD': '/builds/slave/test', 20:52:58 INFO - 'SHELL': '/bin/bash', 20:52:58 INFO - 'SHLVL': '1', 20:52:58 INFO - 'TERM': 'linux', 20:52:58 INFO - 'TMOUT': '86400', 20:52:58 INFO - 'USER': 'cltbld', 20:52:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:58 INFO - '_': '/tools/buildbot/bin/python'} 20:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:52:58 INFO - Downloading/unpacking psutil>=3.1.1 20:52: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 20:52: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 20:52: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 20:52: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 20:52: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 20:52: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 20:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:53:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:00 INFO - Installing collected packages: psutil 20:53:00 INFO - Running setup.py install for psutil 20:53:00 INFO - building 'psutil._psutil_linux' extension 20:53:00 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 20:53:00 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 20:53:00 INFO - building 'psutil._psutil_posix' extension 20:53:00 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 20:53:00 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 20:53:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:00 INFO - Successfully installed psutil 20:53:00 INFO - Cleaning up... 20:53:00 INFO - Return code: 0 20:53:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:53:00 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')]} 20:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:00 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')]} 20:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:00 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:00 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.3'] in /builds/slave/test/build 20:53:00 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.3 20:53:00 INFO - Using env: {'DISPLAY': ':0', 20:53:00 INFO - 'HOME': '/home/cltbld', 20:53:00 INFO - 'LANG': 'en_US.UTF-8', 20:53:00 INFO - 'LANGUAGE': 'en_US:en', 20:53:00 INFO - 'LOGNAME': 'cltbld', 20:53:00 INFO - 'MAIL': '/var/mail/cltbld', 20:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:00 INFO - 'MOZ_NO_REMOTE': '1', 20:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:00 INFO - 'NO_EM_RESTART': '1', 20:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:00 INFO - 'PWD': '/builds/slave/test', 20:53:00 INFO - 'SHELL': '/bin/bash', 20:53:00 INFO - 'SHLVL': '1', 20:53:00 INFO - 'TERM': 'linux', 20:53:00 INFO - 'TMOUT': '86400', 20:53:00 INFO - 'USER': 'cltbld', 20:53:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:00 INFO - '_': '/tools/buildbot/bin/python'} 20:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:53:03 INFO - Installing collected packages: mozsystemmonitor 20:53:03 INFO - Running setup.py install for mozsystemmonitor 20:53:03 INFO - Successfully installed mozsystemmonitor 20:53:03 INFO - Cleaning up... 20:53:03 INFO - Return code: 0 20:53:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:53:03 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')]} 20:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:03 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')]} 20:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:03 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:03 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==2.5.1'] in /builds/slave/test/build 20:53:03 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==2.5.1 20:53:03 INFO - Using env: {'DISPLAY': ':0', 20:53:03 INFO - 'HOME': '/home/cltbld', 20:53:03 INFO - 'LANG': 'en_US.UTF-8', 20:53:03 INFO - 'LANGUAGE': 'en_US:en', 20:53:03 INFO - 'LOGNAME': 'cltbld', 20:53:03 INFO - 'MAIL': '/var/mail/cltbld', 20:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:03 INFO - 'MOZ_NO_REMOTE': '1', 20:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:03 INFO - 'NO_EM_RESTART': '1', 20:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:03 INFO - 'PWD': '/builds/slave/test', 20:53:03 INFO - 'SHELL': '/bin/bash', 20:53:03 INFO - 'SHLVL': '1', 20:53:03 INFO - 'TERM': 'linux', 20:53:03 INFO - 'TMOUT': '86400', 20:53:03 INFO - 'USER': 'cltbld', 20:53:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:03 INFO - '_': '/tools/buildbot/bin/python'} 20:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:03 INFO - Downloading/unpacking jsonschema==2.5.1 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:53:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 INFO - Downloading functools32-3.2.3-2.tar.gz 20:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:53:05 INFO - warning: no files found matching '*.txt' 20:53:05 INFO - no previously-included directories found matching 'build' 20:53:05 INFO - no previously-included directories found matching 'dist' 20:53:05 INFO - no previously-included directories found matching '.git*' 20:53:05 INFO - Installing collected packages: jsonschema, functools32 20:53:05 INFO - Running setup.py install for functools32 20:53:05 INFO - warning: no files found matching '*.txt' 20:53:05 INFO - no previously-included directories found matching 'build' 20:53:05 INFO - no previously-included directories found matching 'dist' 20:53:05 INFO - no previously-included directories found matching '.git*' 20:53:05 INFO - Successfully installed jsonschema functools32 20:53:05 INFO - Cleaning up... 20:53:05 INFO - Return code: 0 20:53:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:05 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:05 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 20:53:05 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 20:53:05 INFO - Using env: {'DISPLAY': ':0', 20:53:05 INFO - 'HOME': '/home/cltbld', 20:53:05 INFO - 'LANG': 'en_US.UTF-8', 20:53:05 INFO - 'LANGUAGE': 'en_US:en', 20:53:05 INFO - 'LOGNAME': 'cltbld', 20:53:05 INFO - 'MAIL': '/var/mail/cltbld', 20:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:05 INFO - 'MOZ_NO_REMOTE': '1', 20:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:05 INFO - 'NO_EM_RESTART': '1', 20:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:05 INFO - 'PWD': '/builds/slave/test', 20:53:05 INFO - 'SHELL': '/bin/bash', 20:53:05 INFO - 'SHLVL': '1', 20:53:05 INFO - 'TERM': 'linux', 20:53:05 INFO - 'TMOUT': '86400', 20:53:05 INFO - 'USER': 'cltbld', 20:53:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:05 INFO - '_': '/tools/buildbot/bin/python'} 20:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 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 20:53:05 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 20:53:07 INFO - Downloading blobuploader-1.2.4.tar.gz 20:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:53:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:53:07 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 20:53:07 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 20:53:07 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 20:53:07 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 20:53:07 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 20:53:07 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 20:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:53:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:53:08 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 20:53:08 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 20:53:08 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 20:53:08 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 20:53:08 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 20:53:08 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 20:53:08 INFO - Downloading docopt-0.6.1.tar.gz 20:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:53:08 INFO - Installing collected packages: blobuploader, requests, docopt 20:53:08 INFO - Running setup.py install for blobuploader 20:53:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:53:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:53:08 INFO - Running setup.py install for requests 20:53:09 INFO - Running setup.py install for docopt 20:53:09 INFO - Successfully installed blobuploader requests docopt 20:53:09 INFO - Cleaning up... 20:53:09 INFO - Return code: 0 20:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:09 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')]} 20:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:09 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')]} 20:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:09 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:09 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 20:53:09 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 20:53:09 INFO - Using env: {'DISPLAY': ':0', 20:53:09 INFO - 'HOME': '/home/cltbld', 20:53:09 INFO - 'LANG': 'en_US.UTF-8', 20:53:09 INFO - 'LANGUAGE': 'en_US:en', 20:53:09 INFO - 'LOGNAME': 'cltbld', 20:53:09 INFO - 'MAIL': '/var/mail/cltbld', 20:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:09 INFO - 'MOZ_NO_REMOTE': '1', 20:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:09 INFO - 'NO_EM_RESTART': '1', 20:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:09 INFO - 'PWD': '/builds/slave/test', 20:53:09 INFO - 'SHELL': '/bin/bash', 20:53:09 INFO - 'SHLVL': '1', 20:53:09 INFO - 'TERM': 'linux', 20:53:09 INFO - 'TMOUT': '86400', 20:53:09 INFO - 'USER': 'cltbld', 20:53:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:09 INFO - '_': '/tools/buildbot/bin/python'} 20:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:09 INFO - Running setup.py (path:/tmp/pip-X7ffiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:09 INFO - Running setup.py (path:/tmp/pip-EG2C8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:09 INFO - Running setup.py (path:/tmp/pip-R8lSKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:09 INFO - Running setup.py (path:/tmp/pip-sPk5rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:09 INFO - Running setup.py (path:/tmp/pip-5NteyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:09 INFO - Running setup.py (path:/tmp/pip-p8P3xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:09 INFO - Running setup.py (path:/tmp/pip-fxdjWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:09 INFO - Running setup.py (path:/tmp/pip-zazoRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:10 INFO - Running setup.py (path:/tmp/pip-YH6Ew4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:10 INFO - Running setup.py (path:/tmp/pip-xEVnc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:10 INFO - Running setup.py (path:/tmp/pip-M8M58F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:10 INFO - Running setup.py (path:/tmp/pip-uHIatl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:10 INFO - Running setup.py (path:/tmp/pip-v9FkVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:10 INFO - Running setup.py (path:/tmp/pip-6Xo1pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:10 INFO - Running setup.py (path:/tmp/pip-q1ILj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:10 INFO - Running setup.py (path:/tmp/pip-ooPCFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:10 INFO - Running setup.py (path:/tmp/pip-mjMzCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:53:10 INFO - Running setup.py install for manifestparser 20:53:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:53:10 INFO - Running setup.py install for mozcrash 20:53:10 INFO - Running setup.py install for mozdebug 20:53:10 INFO - Running setup.py install for mozdevice 20:53:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Running setup.py install for mozfile 20:53:11 INFO - Running setup.py install for mozhttpd 20:53:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Running setup.py install for mozinfo 20:53:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Running setup.py install for mozInstall 20:53:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Running setup.py install for mozleak 20:53:11 INFO - Running setup.py install for mozlog 20:53:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Running setup.py install for moznetwork 20:53:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:53:11 INFO - Running setup.py install for mozprocess 20:53:11 INFO - Running setup.py install for mozprofile 20:53:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:53:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:53:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:53:12 INFO - Running setup.py install for mozrunner 20:53:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:53:12 INFO - Running setup.py install for mozscreenshot 20:53:12 INFO - Running setup.py install for moztest 20:53:12 INFO - Running setup.py install for mozversion 20:53:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:53:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:53:12 INFO - Cleaning up... 20:53:12 INFO - Return code: 0 20:53:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:12 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')]} 20:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:12 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')]} 20:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:12 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:12 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 20:53:12 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 20:53:12 INFO - Using env: {'DISPLAY': ':0', 20:53:12 INFO - 'HOME': '/home/cltbld', 20:53:12 INFO - 'LANG': 'en_US.UTF-8', 20:53:12 INFO - 'LANGUAGE': 'en_US:en', 20:53:12 INFO - 'LOGNAME': 'cltbld', 20:53:12 INFO - 'MAIL': '/var/mail/cltbld', 20:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:12 INFO - 'MOZ_NO_REMOTE': '1', 20:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:12 INFO - 'NO_EM_RESTART': '1', 20:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:12 INFO - 'PWD': '/builds/slave/test', 20:53:12 INFO - 'SHELL': '/bin/bash', 20:53:12 INFO - 'SHLVL': '1', 20:53:12 INFO - 'TERM': 'linux', 20:53:12 INFO - 'TMOUT': '86400', 20:53:12 INFO - 'USER': 'cltbld', 20:53:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:12 INFO - '_': '/tools/buildbot/bin/python'} 20:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:12 INFO - Running setup.py (path:/tmp/pip-QSd5pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:12 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)) 20:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:12 INFO - Running setup.py (path:/tmp/pip-RPa3mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:12 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)) 20:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:12 INFO - Running setup.py (path:/tmp/pip-utT3IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:12 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)) 20:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:12 INFO - Running setup.py (path:/tmp/pip-NDGy2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:13 INFO - Running setup.py (path:/tmp/pip-uWEYFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:13 INFO - Running setup.py (path:/tmp/pip-I_KEwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:13 INFO - Running setup.py (path:/tmp/pip-4XpI37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:13 INFO - Running setup.py (path:/tmp/pip-gF3VIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:13 INFO - Running setup.py (path:/tmp/pip-2fy3nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:13 INFO - Running setup.py (path:/tmp/pip-Ye9AIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:13 INFO - Running setup.py (path:/tmp/pip-Ul4tO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:13 INFO - Running setup.py (path:/tmp/pip-hn9ScP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:13 INFO - Running setup.py (path:/tmp/pip-3rmEkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:13 INFO - Running setup.py (path:/tmp/pip-Mbvy_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:13 INFO - Running setup.py (path:/tmp/pip-gx8WgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:13 INFO - Running setup.py (path:/tmp/pip-PGwABi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:13 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)) 20:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:13 INFO - Running setup.py (path:/tmp/pip-AsLxuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:13 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)) 20:53:13 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)) 20:53:13 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)) 20:53:13 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)) 20:53:13 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)) 20:53:13 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)) 20:53:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:53:13 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 20:53:13 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 20:53:14 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 20:53:14 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 20:53:14 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 20:53:14 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 20:53:15 INFO - Downloading blessings-1.6.tar.gz 20:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:53:16 INFO - Installing collected packages: blessings 20:53:16 INFO - Running setup.py install for blessings 20:53:16 INFO - Successfully installed blessings 20:53:16 INFO - Cleaning up... 20:53:16 INFO - Return code: 0 20:53:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:53:16 INFO - Reading from file tmpfile_stdout 20:53:16 INFO - Current package versions: 20:53:16 INFO - argparse == 1.2.1 20:53:16 INFO - blessings == 1.6 20:53:16 INFO - blobuploader == 1.2.4 20:53:16 INFO - docopt == 0.6.1 20:53:16 INFO - functools32 == 3.2.3-2 20:53:16 INFO - jsonschema == 2.5.1 20:53:16 INFO - manifestparser == 1.1 20:53:16 INFO - mozInstall == 1.12 20:53:16 INFO - mozcrash == 0.17 20:53:16 INFO - mozdebug == 0.1 20:53:16 INFO - mozdevice == 0.48 20:53:16 INFO - mozfile == 1.2 20:53:16 INFO - mozhttpd == 0.7 20:53:16 INFO - mozinfo == 0.9 20:53:16 INFO - mozleak == 0.1 20:53:16 INFO - mozlog == 3.2 20:53:16 INFO - moznetwork == 0.27 20:53:16 INFO - mozprocess == 0.22 20:53:16 INFO - mozprofile == 0.28 20:53:16 INFO - mozrunner == 6.11 20:53:16 INFO - mozscreenshot == 0.1 20:53:16 INFO - mozsystemmonitor == 0.3 20:53:16 INFO - moztest == 0.7 20:53:16 INFO - mozversion == 1.4 20:53:16 INFO - psutil == 3.1.1 20:53:16 INFO - requests == 1.2.3 20:53:16 INFO - wsgiref == 0.1.2 20:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:16 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:16 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 20:53:16 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 20:53:16 INFO - Using env: {'DISPLAY': ':0', 20:53:16 INFO - 'HOME': '/home/cltbld', 20:53:16 INFO - 'LANG': 'en_US.UTF-8', 20:53:16 INFO - 'LANGUAGE': 'en_US:en', 20:53:16 INFO - 'LOGNAME': 'cltbld', 20:53:16 INFO - 'MAIL': '/var/mail/cltbld', 20:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:16 INFO - 'MOZ_NO_REMOTE': '1', 20:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:16 INFO - 'NO_EM_RESTART': '1', 20:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:16 INFO - 'PWD': '/builds/slave/test', 20:53:16 INFO - 'SHELL': '/bin/bash', 20:53:16 INFO - 'SHLVL': '1', 20:53:16 INFO - 'TERM': 'linux', 20:53:16 INFO - 'TMOUT': '86400', 20:53:16 INFO - 'USER': 'cltbld', 20:53:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:16 INFO - '_': '/tools/buildbot/bin/python'} 20:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 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)) 20:53:16 INFO - Cleaning up... 20:53:16 INFO - Return code: 0 20:53:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:16 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:16 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 20:53:16 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 20:53:16 INFO - Using env: {'DISPLAY': ':0', 20:53:16 INFO - 'HOME': '/home/cltbld', 20:53:16 INFO - 'LANG': 'en_US.UTF-8', 20:53:16 INFO - 'LANGUAGE': 'en_US:en', 20:53:16 INFO - 'LOGNAME': 'cltbld', 20:53:16 INFO - 'MAIL': '/var/mail/cltbld', 20:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:16 INFO - 'MOZ_NO_REMOTE': '1', 20:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:16 INFO - 'NO_EM_RESTART': '1', 20:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:16 INFO - 'PWD': '/builds/slave/test', 20:53:16 INFO - 'SHELL': '/bin/bash', 20:53:16 INFO - 'SHLVL': '1', 20:53:16 INFO - 'TERM': 'linux', 20:53:16 INFO - 'TMOUT': '86400', 20:53:16 INFO - 'USER': 'cltbld', 20:53:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:16 INFO - '_': '/tools/buildbot/bin/python'} 20:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:53:17 INFO - Cleaning up... 20:53:17 INFO - Return code: 0 20:53:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:53:17 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')]} 20:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:17 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')]} 20:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:17 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 0x7fb60737ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, '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': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', '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 20:53:17 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 20:53:17 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 20:53:17 INFO - Using env: {'DISPLAY': ':0', 20:53:17 INFO - 'HOME': '/home/cltbld', 20:53:17 INFO - 'LANG': 'en_US.UTF-8', 20:53:17 INFO - 'LANGUAGE': 'en_US:en', 20:53:17 INFO - 'LOGNAME': 'cltbld', 20:53:17 INFO - 'MAIL': '/var/mail/cltbld', 20:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:17 INFO - 'MOZ_NO_REMOTE': '1', 20:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:17 INFO - 'NO_EM_RESTART': '1', 20:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:17 INFO - 'PWD': '/builds/slave/test', 20:53:17 INFO - 'SHELL': '/bin/bash', 20:53:17 INFO - 'SHLVL': '1', 20:53:17 INFO - 'TERM': 'linux', 20:53:17 INFO - 'TMOUT': '86400', 20:53:17 INFO - 'USER': 'cltbld', 20:53:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:17 INFO - '_': '/tools/buildbot/bin/python'} 20:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:17 INFO - Downloading/unpacking flake8 20:53:17 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 20:53:17 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 20:53:17 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 20:53:17 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 20:53:17 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 20:53:17 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 20:53:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:53:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:53:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 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 20:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:53:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:53:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:53:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:53:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:53:19 INFO - no previously-included directories found matching 'docs/_build' 20:53:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:53:20 INFO - Running setup.py install for pep8 20:53:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:53:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:53:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:53:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:53:20 INFO - no previously-included directories found matching 'docs/_build' 20:53:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:53:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:53:20 INFO - Cleaning up... 20:53:20 INFO - Return code: 0 20:53:20 INFO - Running post-action listener: _resource_record_post_action 20:53:20 INFO - Running post-action listener: _start_resource_monitoring 20:53:20 INFO - Starting resource monitoring. 20:53:20 INFO - ##### 20:53:20 INFO - ##### Finished create-virtualenv step (success) 20:53:20 INFO - ##### 20:53:20 INFO - ##### 20:53:20 INFO - ##### Running install step. 20:53:20 INFO - ##### 20:53:20 INFO - Running pre-action listener: _resource_record_pre_action 20:53:20 INFO - Running main action method: install 20:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:53:20 INFO - Reading from file tmpfile_stdout 20:53:20 INFO - Detecting whether we're running mozinstall >=1.0... 20:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:53:20 INFO - Reading from file tmpfile_stdout 20:53:20 INFO - Output received: 20:53:20 INFO - Usage: mozinstall [options] installer 20:53:20 INFO - Options: 20:53:20 INFO - -h, --help show this help message and exit 20:53:20 INFO - -d DEST, --destination=DEST 20:53:20 INFO - Directory to install application into. [default: 20:53:20 INFO - "/builds/slave/test"] 20:53:20 INFO - --app=APP Application being installed. [default: firefox] 20:53:20 INFO - mkdir: /builds/slave/test/build/application 20:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:53:36 INFO - Reading from file tmpfile_stdout 20:53:36 INFO - Output received: 20:53:36 INFO - /builds/slave/test/build/application/firefox/firefox 20:53:36 INFO - Running post-action listener: _resource_record_post_action 20:53:36 INFO - ##### 20:53:36 INFO - ##### Finished install step (success) 20:53:36 INFO - ##### 20:53:36 INFO - ##### 20:53:36 INFO - ##### Running run-tests step. 20:53:36 INFO - ##### 20:53:36 INFO - Running pre-action listener: _resource_record_pre_action 20:53:36 INFO - Running main action method: run_tests 20:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:53:36 INFO - Python 2.7.3 20:53:36 INFO - Return code: 0 20:53:36 INFO - grabbing minidump binary from tooltool 20:53:36 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')]} 20:53:36 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130c1c0>, '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 0x130d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:53:36 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 20:53:36 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 20:53:36 INFO - Calling ['/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'] with output_timeout 600 20:53:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:53:36 INFO - Return code: 0 20:53:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:53:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:53:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:53:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:53:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:53:37 INFO - Return code: 0 20:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 20:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 20:53:37 INFO - Using env: {'DISPLAY': ':0', 20:53:37 INFO - 'HOME': '/home/cltbld', 20:53:37 INFO - 'LANG': 'en_US.UTF-8', 20:53:37 INFO - 'LANGUAGE': 'en_US:en', 20:53:37 INFO - 'LOGNAME': 'cltbld', 20:53:37 INFO - 'MAIL': '/var/mail/cltbld', 20:53:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:53:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:37 INFO - 'MOZ_NO_REMOTE': '1', 20:53:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:53:37 INFO - 'NO_EM_RESTART': '1', 20:53:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:37 INFO - 'PWD': '/builds/slave/test', 20:53:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:53:37 INFO - 'SHELL': '/bin/bash', 20:53:37 INFO - 'SHLVL': '1', 20:53:37 INFO - 'TERM': 'linux', 20:53:37 INFO - 'TMOUT': '86400', 20:53:37 INFO - 'USER': 'cltbld', 20:53:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466480104.673564-505014766', 20:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:37 INFO - '_': '/tools/buildbot/bin/python'} 20:53:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 20:53:37 INFO - mozversion application_buildid: 20160620192300 20:53:37 INFO - mozversion application_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 20:53:37 INFO - mozversion application_display_name: Nightly 20:53:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:53:37 INFO - mozversion application_name: Firefox 20:53:37 INFO - mozversion application_remotingname: firefox 20:53:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:53:37 INFO - mozversion application_vendor: Mozilla 20:53:37 INFO - mozversion application_version: 50.0a1 20:53:37 INFO - mozversion platform_buildid: 20160620192300 20:53:37 INFO - mozversion platform_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 20:53:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:53:37 INFO - mozversion platform_version: 50.0a1 20:53:37 INFO - using testdate: 1466481217 20:53:37 INFO - actual date: 1466481217 20:53:37 INFO - starting webserver on 'localhost:57193' 20:53:37 INFO - SUITE-START | Running 2 tests 20:53:37 INFO - TEST-START | dromaeo_css 20:53:37 INFO - operating with platform_type : linux_ 20:53:37 INFO - Initialising browser for dromaeo_css test... 20:53:37 INFO - TEST-INFO | started process 8752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpClf5P_/profile http://localhost:57193/getInfo.html) 20:53:42 INFO - PROCESS | 8752 | __metrics Screen width/height:1600/1200 20:53:42 INFO - PROCESS | 8752 | colorDepth:24 20:53:42 INFO - PROCESS | 8752 | Browser inner width/height: 1024/697 20:53:42 INFO - PROCESS | 8752 | __metrics 20:53:43 ERROR - PROCESS | 8752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 20:53:44 INFO - TEST-INFO | 8752: exit 0 20:53:44 INFO - Browser initialized. 20:53:44 INFO - Running cycle 1/1 for dromaeo_css test... 20:53:44 INFO - TEST-INFO | started process 8871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpClf5P_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:53:57 INFO - PROCESS | 8871 | RSS: Main: 186437632 20:53:57 INFO - PROCESS | 8871 | 20:54:46 INFO - PROCESS | 8871 | 1466481286635 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] 20:56:59 INFO - PROCESS | 8871 | Cycle 1(1): loaded http://localhost:57193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57193/tests/dromaeo/cssquery-ext.html) 20:57:00 INFO - PROCESS | 8871 | RSS: Main: 189079552 20:57:00 INFO - PROCESS | 8871 | 21:00:02 INFO - PROCESS | 8871 | Cycle 1(1): loaded http://localhost:57193/tests/dromaeo/cssquery-ext.html (next: http://localhost:57193/tests/dromaeo/cssquery-jquery.html) 21:00:03 INFO - PROCESS | 8871 | RSS: Main: 188182528 21:00:03 INFO - PROCESS | 8871 | 21:03:05 INFO - PROCESS | 8871 | Cycle 1(1): loaded http://localhost:57193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57193/tests/dromaeo/cssquery-mootools.html) 21:03:05 INFO - PROCESS | 8871 | RSS: Main: 188968960 21:03:05 INFO - PROCESS | 8871 | 21:06:07 INFO - PROCESS | 8871 | Cycle 1(1): loaded http://localhost:57193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57193/tests/dromaeo/cssquery-prototype.html) 21:06:08 INFO - PROCESS | 8871 | RSS: Main: 186556416 21:06:08 INFO - PROCESS | 8871 | 21:09:11 INFO - PROCESS | 8871 | Cycle 1(1): loaded http://localhost:57193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57193/tests/dromaeo/cssquery-yui.html) 21:09:11 INFO - PROCESS | 8871 | RSS: Main: 189116416 21:09:11 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | Cycle 1(1): loaded http://localhost:57193/tests/dromaeo/cssquery-yui.html (next: http://localhost:57193/tests/dromaeo/cssquery-dojo.html) 21:12:14 INFO - PROCESS | 8871 | RSS: Main: 189648896 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | __start_tp_report 21:12:14 INFO - PROCESS | 8871 | _x_x_mozilla_page_load 21:12:14 INFO - PROCESS | 8871 | _x_x_mozilla_page_load_details 21:12:14 INFO - PROCESS | 8871 | |i|pagename|runs| 21:12:14 INFO - PROCESS | 8871 | |0;dojo.html;2625.9080932167376;2658.747418995195;2659.813813033087;2671.2119924622234;2684.141074856047;4741.454732705735;4768.094062128193;4784.138855006097;4839.443464001641;4887.951120488794;4735.28970654402;4770.7853146608395;4778.163821331271;4846.176150054491;4882.780274887629;4261.6164545191;4376.452943382077;4438.112377524491;4442.2448183808665;4470.642348612103;641.0563419043403;4328.97835510822;4388.034632380871;4411.316245981878;4441.022974945507;4350.651947844165;4355.629771469429;4379.211741886459;4384.0355121873135;4432.335149727534;4315.503717072545;4379.956200437987;4420.513743488214;4427.424434823452;4429.291313389842;4309.806058727365;4313.266744653416;4313.503947046099;4323.870283891489;4386.7367957922625;4769.642276829251;4830.106430310404;4840.249761287007;4847.466778654345;4867.5132486751045;5147.794088236466;5187.48125187482;5203.869903252411;5220.92168617471;5274.630775845692;5224.895502089975;5244.580433565306;5253.658512196695;5276.683398996034;5307.840764777063;4886.853394398174;4901.117798796179;4904.852854414374;4906.362172917497;4908.730019848943;5158.123119069767;5310.283111779938;5317;5361.8123365682795;5377.462253774669;5120.590352771769;5136.203888397305;5136.614753893473;5142.6914385137015;5151.5106064923775;5219.269302297681;5229.843104706789;5268.525832675077;5269.367675878842;5287.02190094826;5042.697438153723;5113.079645663742;5168.61235407346;5175.7153356564995;5177.171652535651;5007.749612519359;5153.742312884416;5168.457311982188;5180.352455943007;5188.714620695822;4450.488193857748;4451.488078870972;4454.933176002362;4471.575200355961;4498.415206023196;3820.255050265227;3839.078621130964;3848.9422658659582;3882.9029274267805;3893.162969961472;4480.012709255915;4535.31970204472;4541.545845415432;4585.70192937458;4607.447106347193;5229.189475631283;5296.09966305729;5315.6013299002725;5329.467053294717;5338.039152952429;4435.090806384684;4441.533638967927;4456;4462.308342206963;4465.955340446619;4610.838620648261;4651.97656515566;4677.766111694402;4677.906441871143;4713;4754.45323787755;4867.902641947141;4874.902501950012;4875.24433712775;4879.878003049952;5228.451012643618;5247.344081989751;5263.89472210546;5276.841694749163;5320.973395133;4922.433920099091;4932.30947667334;4941.456439791548;4953.0589188054155;4984.903321269315;4992.625553083606;5166.896662066662;5180.637355385237;5198.610104242121;5247.895042099213;5242.842714718565;5264;5282.181261904411;5292.417834038176;5321.882404695058;5104.259882317117;5136.332276803992;5147.536721695065;5167.914737905082;5171.250168725589;4955.380577427822;4979.726115063706;5005.499450054966;5014.52362025607;5143.6399452037995;4883.072216278895;4930.186519224288;4936.901261974812;4949.678270912524;4958.826441074545;5125.846224613268;5137.434882162885;5142.305788718475;5180.171172612364;5208.348956380452;4856.9314750754775;4965.726885021359;5053.393592768891;5077.213031980049;5081.923771143362 21:12:14 INFO - PROCESS | 8871 | |1;ext.html;538.3943064052941;558.9770719583163;563.7096895099023;571.2459553389527;603.749443980748;35304.293914121736;39360.803195984015;39421.2115757685;39475;39526.60473395265;39515.209695806065;39518;39536;39582.20835583294;39975.40036899449;7681.57751323677;7818.843623127534;7825.217478252158;7829.021372328459;7838.294553490185;7647.311741943224;7824.178461261571;7842.568658723768;7847.568383738892;7871.173526779691;7867.606619669023;7919.683212671515;7932.762017139495;7947.960260198691;7956.960215198916;7826.843463130734;7828.5694286814205;7845.725399610987;7853.253940875607;7853.960730196341;7745.883811742829;7784.182660820646;7839.804004899866;7841.686332546691;7848.7645370638975;37280.44079338812;37548.87353379403;37602.623973760186;37670.05824854373;37697.43453848167;2707.241972247774;2965.1697524693122;3024.8033877798093;3177.158053115903;3270.3132342207928;26082.86958565214;27181.45637087267;27631.44737105267;28237;28868.422631547463;3398.371301309241;3403.435224461827;3425.6745609167087;3470.2192006798523;3518.8592456301717;214929;221229.9999999984;221316;221752;221921;31875.84062079721;31896.681033189834;32154;32194.034178974667;32392.676073239436;33881.83059084689;33983.32033359319;34021.489677654856;34054.82972585121;34092.48861267083;12037.217580857216;12202.206856554296;12276.631701048982;12314.261144331369;12353.135280530276;9740.707778766648;9742.707718768448;9828.361156524803;9858;9880.209583233323;7937.523748575104;7959.920400796033;7978.6409611567615;8026.27763501276;8046.114927358103;3075.9077227683206;3106.4253113174136;3155.1638815713854;3160.8419579020956;3186.8087914725193;898.910108989109;902.8510295801119;963.036963036963;970.96601618943;990.6483198464585;27966.44067118646;28339.433211335658;28536.571951420745;28691.713082869323;28720.569191462146;936.7377134402378;994.9452780097164;1004.2167109654481;1015.0762805846645;1019.4902548725637;14723.190224537753;14934.70130597382;15075.623109422133;15279.465218717292;15363;383316;390591;391873;393848;394450;48017.75991120092;49616.50383496191;49659.751701241265;49733.50266497361;50086;1083.1443159903588;1173.8943495085484;1200.6458094862037;1200.8318835363232;1201.3092471828734;26559;27372.589411159246;27375.452490949672;27727.861360693067;27829.582556262078;42600.360994585724;43091.56908430876;43179;43272.783636081615;43647.12705745804;331213;333906;333916;335111;335893;25377.49245015126;25484.362890927132;27506.724932751218;27818.165455036382;27821.304467388476;42194.78902605467;42314.5768542323;42557.36163957481;43748.56251437572;43788.56211437845;35749.46375804313;36956.44565331468;37446.25107497889;37605.81197093997;38336.083195840656;35722.28555428929;36099.458508121876;36205;36563.817180913924;36621.26757464783;34077;35859.82070089633;36059.63940360563;36196.81901590475;37229;30880.227994299425;31995.200119997186;32064.16814282631;32359;32364.676353236166;24180;24255;24611.753882461664;24911.377215569755;24947.251582452554 21:12:14 INFO - PROCESS | 8871 | |2;jquery.html;366.65717554086916;369.65991288015033;371.50960731833976;378.1359593329243;379.5635019727315;16465.917670411647;16684.666306673873;17569;17660.735088973677;17703.911480442614;16051.518454446355;16469.67060658786;17178.656426871486;17180.82819171808;17239.138043097828;5065.113605119099;5228.843134705965;5284.2866213061325;5294.841154765363;5296;3623.7860316793904;5117.746152192718;5703.429657034305;6141.477974372184;6142.293636231846;6111.083337499388;6162.784302549411;6177.969110154466;6180.042093475518;6211.068339749051;6313.431791138796;6658.400743933045;6659.267480577133;6727.192736871558;6728.56264342821;6470;6591.143151390336;6596.274409814917;6612.636305003223;6640.535162538624;21701.34895953124;22585.54828903429;23705.288841334786;23760.643590346157;23888.64167037496;2141.1756473757714;2166.447555873258;2261.050358849287;2450.11517635445;2574.3950171709635;14032.43870245189;14124.50564230247;14726.33731482086;15061.849381506154;15287.617809554738;1811.7735283089614;1922.528980399797;1925.653382391183;1949.9707504387445;1950.3466338776527;51867.22199167016;56122.43877561213;82346;82677.58661206656;82823;15441.227938603024;16437.849350545348;16508.66982660364;16741.990961084746;16923.492295231164;28239.858800706275;28510.572341414896;28551.857240713663;28675.426491470054;28772.136835894955;8141.3893957952205;8283.337333013344;8294.8341033179;8353.958230208931;8398.370122240856;6522.869542609121;6566.24488183865;6630.502712296597;6688.732450702015;6759;8118.594070296462;8158.347332213409;8182.918170818216;8348.33213342931;8525.488470691778;1491.4779827060443;1601.719699052661;1624.4152105242104;1650.4635993301986;3138.4505021520567;769.6267310354474;770.0451440214206;814.0231721933585;828.5070383122032;834.7853872615331;16143.192840357935;16697.916510417614;16777.748333775;16791.74812377791;16796.58008549796;811.5495899775564;812.959352032396;838.4047326398326;846.7502086884384;877.3989816975393;9022.819543609092;9348.392354497071;9448.102430269113;9449.90550094504;9558.329977178095;360580;366982;377255;377721;378977;79126;79287.73476466052;80164;80709.59645201736;81893.59053204696;874.7200895713438;879.5426378283257;892.9687460938836;900.594732370436;902.1069141549818;14730.756771572756;14793.92603036978;15046.172460514777;15125.707836790862;15328.351404388432;36283.45574816433;36691.44962825613;37817.81091094527;38589.03527411725;38899.416508752955;50339;50465.74767126141;52134.21798673099;52213.47786522086;53878;7096.893546596909;7104.573725576482;7176.174739904978;7245.963770181115;7377.077865266841;9178.908210917805;11933.105017123577;12018.879811201776;12142.939285303517;12242.081843861924;10546.525406356579;10654.89345106539;10666.573337066431;10744.194185435967;10861.456927153453;10469.895301046892;10657.626983055556;10750.193735469715;10775.784484310427;10941.45292735376;10186.134178594903;10359.896401036194;10504.684859454228;10555.683329500127;10977;6986.231514533296;6995.160580730345;7081.221065682874;7162.820929476805;7286.089238845145;10184.439855808001;10303.690889273334;10340.689779306633;10410.219233557362;10803.189760767817 21:12:14 INFO - PROCESS | 8871 | |3;mootools.html;1362.5503583817342;1380.3236414157063;1473.506375364253;1666.8416500432454;1680.193507116584;6437.517186211029;7193.280671932804;7261.528000679965;7666.195049519803;7681.692732290709;7279.090113735783;7492.925070749291;7522.2101679323705;7575.962120189405;7621.504602200853;2121.830253579714;2164.437246315961;2164.7943445372666;2165.545235500547;2169.609470295346;2190.3319487556287;2200.8569442986236;2218.7004754358118;2232.3860938242033;2242.3497185816095;2172.902219400131;2185.311626837549;2190.87950162741;2200.416889524269;2251.448395143184;2118.947026324339;2129.8296136309136;2143.871367717926;2150.6021386043553;2156.5579056293423;2021.2117274263048;2077.356019633918;2091.027672132466;2096.3396530093123;2104.852660313779;7481.177070522238;7550.282723141293;7556.055493063367;7556.206598307153;7561.924380756177;4192.24539582875;4266.31738921771;4278.4865816102265;4280.400743895857;4284.678649101299;2770.3351195713085;2817.281593193743;2865.957010644842;2888.133559932033;2915.3440475892967;855.820277741675;888.6534251641865;896.0546623312403;900.3382513852313;943.0852073488705;9564.856527152098;9600.90399096007;9604.90395096047;9612.086851749073;9627;3859.55615104261;3930.5283365996265;3994.7603143811466;4011.5186177658866;4014.4781178447197;8286.4613800104;8344.874826877602;8375.623096960651;8391;8462.449940753955;4467.754273514923;4479.484859241164;4486.798094085774;4499.52754960731;4502.3921770560555;3589.3898037333192;3993.740406873602;4014.4781178447197;4050.8177132029127;4167.645750111214;3408.522806807049;3421.7433692473164;3494.934045116213;3506.3513250048313;3551.982240088783;1136.2614300704608;1139.8005349064047;1139.8632164140356;1146.3694967767694;1154.9595764148214;723.4429489293215;734.5555938657143;836.7573403712855;860.8536548786722;863.2877875752529;4989.975050124726;5202.687838729613;5240.895182096337;5281.683099014072;5296.285001524822;403.70731219865365;409.1081442455416;413.3097726796257;413.4294673350757;416.74370262288477;3531.7351198660203;3552.236269202134;3572.356975744339;3614.1868079682386;3648.1062139775927;8978.147076027766;9176.128267814547;9236.399634023766;9296.256299496024;9336.626534938527;9031.864522032174;9134.132257435533;9173.862392064124;9188.540572971324;9235.815283694288;6995.26549712283;7080.964595176991;7081.504294699322;7099.57402555838;7139.785806425815;4959.355283813081;4990.5508504234795;5049.166887463527;5123.231515272739;5143.996920600596;8402.831943360976;8581.184787445183;8658.047614762498;8668.263197628272;8703.91296087031;8631.223189912938;8661.870071949052;8789.516576588348;8802.207801297915;8841.69054083104;6530.08578798959;6534.640594767334;6619.3380661933425;6638.336166383516;6644.435223006099;7110.928890711027;7125.928740712527;7142.214356420894;7147.53541019832;7167.928320716935;6370.872582548416;6427.357264273535;6475.740970361133;6546.967265163644;6739.56192847483;6435.710393032231;6503.934960650522;6529.902051469327;6557.639329836714;6637.103990961158;5838.766449341979;5854.677992710442;5871.970640146772;5924.911126333022;5930.525557955267;4448.088141930832;4496.842610508616;4595.954040459553;4608.677392582487;4613.3771940787565;4346.565343465628;4390.692651514491;4448.110377924493;4508.143452743968;4575.725456472623 21:12:14 INFO - PROCESS | 8871 | |4;prototype.html;295.4888043684426;298.23502715534653;302.7517435702725;303.9133846853647;307.92763700530384;5104.617153713468;5120.5135512126335;5126.333576635042;5170.14692575725;5171.922421163686;4972.825951091712;5013.824516141935;5015.4984501549825;5036.3200967869325;5095.4649761774945;3695.9815200924027;3782.8865134046023;3895.87019764268;3904.6876249899938;3920.980694942107;3902.375619900816;3920.4315374270714;3942.56631770505;3953.3476976298875;3955.1496428267915;3911.9804400978096;3923.4894565592167;3926.1166237596453;3934.881953541384;3950.7875589669734;3820.4078367853026;3870.07118291608;3872.7869967151796;3956.109875278054;3959.1883663848844;3391.16916355492;3394.677505636985;3407.863685452579;3433.364827506919;3436.1753179237053;4934.383202099738;4971.6271279654175;4972.726500042496;4975.278584605212;4984.37695288089;4393.802278897458;4473.932891006638;4520.344550040226;4529;4582.404287442611;5268.604854635918;5292.153255479144;5320.068987927098;5329.095642874642;5357.116075847481;3815.904602384963;3826.8660596878976;3836.271108489406;3840.135969406889;3858.787766672832;5391.272178255964;5599.4120617335;5663.320401551799;5697.1739097831;5713.3429655589725;3861.6717579005535;3885;3895.14306852492;3895.220955808793;3935.1145992151537;3953.466282051886;3983.661388781928;3983.7609743415487;3997.340438827619;4002.1195337025806;4505.932411013838;4508.684392092588;4520.367148599199;4529.573184446888;4538.2738761797955;5117.360329958755;5222.321098257202;5299.2316114164005;5337.6797392156595;5344.4922732340365;1350.122420426711;1354.850966393696;1366.4943970730694;1367.2616786935143;1372.3069849725825;822.7655118291378;860.3031544449017;862.1249431826701;890.3233542507611;890.5013192612029;4567.862964111082;4629.398178236875;4683.711979205746;4703.7883295251795;4712.764361781898;5476.890462190734;5491.979411323836;5492.423295553989;5553.389127196006;5613.691246981373;4488.5511448855505;4676.55572720591;4686.343911852344;4724.055188962221;4753.215719406328;2939.2945693033516;2960.3339248668876;2966.228780517038;2992.5361568956846;3016.9547456788164;5210.609204309692;5214.661047031931;5255.605829562798;5266.578673706094;5287.603429742708;5456.890862182734;5652.123920792284;5685.914711279334;5700.25896633435;5756.359437560275;5204.5576126028955;5251.238570407346;5254.710990895537;5264.763085661078;5269.209618557247;5539.695316757456;5626.833669037532;5636.957162924872;5641.576881733804;5669.801556945487;5188.299579556711;5453.127499600045;5459.508644222039;5489.313835770528;5522.3649280331665;5168.793248270177;5257.263983042453;5278.155495120763;5286.471352864683;5291.391489978548;3812.2244799129894;3845.1540661054523;3879.1465877506903;3894.552126505488;3910.4916360874045;5553.916986187654;5609.326880774333;5610.298712660918;5617.9719101404235;5663.178839068394;5387.542058924879;5388.38033626138;5415;5433;5448;5091.879786446976;5370.113931201308;5390.407055223844;5403.216533602527;5417.891642167214;5312.335958005249;5335.1730481775385;5338.03915295235;5340.465953404629;5361.303030605996;5187.896242075213;5312.229726689531;5449.754761035683;5455.372632147354;5461.143211308175;5321.467853214647;5329.813456529003;5335.532728499694;5354.892902141857;5383.219433182245 21:12:14 INFO - PROCESS | 8871 | |5;yui.html;628.7987843889956;687.8830598798207;691.9896950452339;702.8032150997719;736.9852602947944;12586.748265034705;12843.422046007929;14327.283635818207;15061.322240499176;15074.47239346623;14025.78961315581;14652.926735366334;14704.485343012997;14705.044172128804;14804.25978701066;624.1418050181001;778.5795670338039;783.6904422753009;784.701813310941;790.6007466229546;797.174923953708;799.8160423102661;800.9799755006143;807.3621838747382;807.475141158246;838.9790255243606;842.6081871929551;844.8394804987064;844.8732690096473;846.9915300847005;830.4602008694367;836.2056046755546;837.8994520657499;838.0990435282096;838.6351936907434;612.3478495402427;613.1814028272262;613.7606333529927;614.8309214965875;614.9354317796611;13850.722985540333;13902.652433689138;13956.860431395658;14058.086224395382;14072.648183795385;13763.518276860363;13933;13998.580042598738;14124.788128178085;14166.92916535421;10942.781144377148;11089.168312376603;11139.610113646064;11139.888601114048;11185.552577896955;3341.448660970937;3454.084667563098;3479;3547.7161827053774;3553.0406790166767;64328.67835660838;64586.67706661484;65766.67116664434;66754;67707.32292677108;10563.207759418074;10609.787804244026;10632.681019569425;10693.144548436107;10766;20559.691604625943;20671.58656826855;20765;20830.479238019172;20846.68729969052;7236.638168091575;7288.927110728825;7312.451566132561;7314.524555903849;7464.626768661546;3769.962300376961;3781.9243615127543;3786.110264087937;3867.400552914303;3887.8056097195026;3000.534917087855;3094.706002929718;3117.06488053583;3117.423276693819;3119.828409437457;480.0998128509045;482.7055496147347;491.2067011775956;495.3315006067868;500.2721040885503;474.6511314184072;493.363561006305;509.38364578859256;509.6890896553174;586.3550094895666;7678.923210767933;8210.958945205235;8396.622152003174;8414.621342039623;8578.18507241811;453.31549360465937;492.28864291099734;523.2909407752517;525.7949399734107;537.8467136865975;3804.923901521954;3987.4816273884207;4180.540140584594;4186.706930514895;4246.702730808814;73559.26440735631;88075.55962220147;95190.52404737932;107172.4641376788;110098;81571.5921420389;81577.59211204025;82282;82907.5854620723;83402.58298708468;46402.535974640494;64927.02609460862;70484.2951570488;72068;74977;8402.747917562483;8420.915790842013;8538.829223415372;8599.742007739778;8613;31107.844460777553;40186.1962760749;43220.351694725236;44622.55377446184;45306;55904.6023849407;56873.715631421575;63275.36724632695;63899.3610063912;64074.35925640684;9775.902240977499;9963.651272205438;10084.193264538673;10315.432651204255;10754.623588174376;13019.739605208033;13082.345882706017;13194.538191163263;13483.730325393633;13662.590122296348;11433.256838305484;11861.110416718608;11887.524499019943;12465.065120116209;12482.313472759086;11877.940610296893;12021.519139234333;12054.337011464453;12406.828804959276;12901.161424507378;10559.683209503728;10756.838647420138;10847.186461015297;10886.40124793144;10898.618548351087;9937.292806646059;10377.273590848568;10460.947695261475;10712;10724.678259652223;8907.421017633833;8915.50964696922;9145.86281205769;9192.678256260999;9244.583993720164 21:12:14 INFO - PROCESS | 8871 | __end_tp_report 21:12:14 INFO - PROCESS | 8871 | __start_cc_report 21:12:14 INFO - PROCESS | 8871 | _x_x_mozilla_cycle_collect,394 21:12:14 INFO - PROCESS | 8871 | __end_cc_report 21:12:14 INFO - PROCESS | 8871 | __startTimestamp1466482334569__endTimestamp 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | ------- Summary: start ------- 21:12:14 INFO - PROCESS | 8871 | Number of tests: 6 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | [#0] dojo.html Cycles:165 Average:4777.05 Median:4930.19 stddev:618.58 (12.5%) stddev-sans-first:597.01 21:12:14 INFO - PROCESS | 8871 | Values: 2625.9 2658.7 2659.8 2671.2 2684.1 4741.5 4768.1 4784.1 4839.4 4888.0 4735.3 4770.8 4778.2 4846.2 4882.8 4261.6 4376.5 4438.1 4442.2 4470.6 641.1 4329.0 4388.0 4411.3 4441.0 4350.7 4355.6 4379.2 4384.0 4432.3 4315.5 4380.0 4420.5 4427.4 4429.3 4309.8 4313.3 4313.5 4323.9 4386.7 4769.6 4830.1 4840.2 4847.5 4867.5 5147.8 5187.5 5203.9 5220.9 5274.6 5224.9 5244.6 5253.7 5276.7 5307.8 4886.9 4901.1 4904.9 4906.4 4908.7 5158.1 5310.3 5317.0 5361.8 5377.5 5120.6 5136.2 5136.6 5142.7 5151.5 5219.3 5229.8 5268.5 5269.4 5287.0 5042.7 5113.1 5168.6 5175.7 5177.2 5007.7 5153.7 5168.5 5180.4 5188.7 4450.5 4451.5 4454.9 4471.6 4498.4 3820.3 3839.1 3848.9 3882.9 3893.2 4480.0 4535.3 4541.5 4585.7 4607.4 5229.2 5296.1 5315.6 5329.5 5338.0 4435.1 4441.5 4456.0 4462.3 4466.0 4610.8 4652.0 4677.8 4677.9 4713.0 4754.5 4867.9 4874.9 4875.2 4879.9 5228.5 5247.3 5263.9 5276.8 5321.0 4922.4 4932.3 4941.5 4953.1 4984.9 4992.6 5166.9 5180.6 5198.6 5247.9 5242.8 5264.0 5282.2 5292.4 5321.9 5104.3 5136.3 5147.5 5167.9 5171.3 4955.4 4979.7 5005.5 5014.5 5143.6 4883.1 4930.2 4936.9 4949.7 4958.8 5125.8 5137.4 5142.3 5180.2 5208.3 4856.9 4965.7 5053.4 5077.2 5081.9 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | [#1] ext.html Cycles:180 Average:45448.20 Median:36200.91 stddev:85353.13 (235.8%) stddev-sans-first:85525.96 21:12:14 INFO - PROCESS | 8871 | Values: 538.4 559.0 563.7 571.2 603.7 35304.3 39360.8 39421.2 39475.0 39526.6 39515.2 39518.0 39536.0 39582.2 39975.4 7681.6 7818.8 7825.2 7829.0 7838.3 7647.3 7824.2 7842.6 7847.6 7871.2 7867.6 7919.7 7932.8 7948.0 7957.0 7826.8 7828.6 7845.7 7853.3 7854.0 7745.9 7784.2 7839.8 7841.7 7848.8 37280.4 37548.9 37602.6 37670.1 37697.4 2707.2 2965.2 3024.8 3177.2 3270.3 26082.9 27181.5 27631.4 28237.0 28868.4 3398.4 3403.4 3425.7 3470.2 3518.9 214929.0 221230.0 221316.0 221752.0 221921.0 31875.8 31896.7 32154.0 32194.0 32392.7 33881.8 33983.3 34021.5 34054.8 34092.5 12037.2 12202.2 12276.6 12314.3 12353.1 9740.7 9742.7 9828.4 9858.0 9880.2 7937.5 7959.9 7978.6 8026.3 8046.1 3075.9 3106.4 3155.2 3160.8 3186.8 898.9 902.9 963.0 971.0 990.6 27966.4 28339.4 28536.6 28691.7 28720.6 936.7 994.9 1004.2 1015.1 1019.5 14723.2 14934.7 15075.6 15279.5 15363.0 383316.0 390591.0 391873.0 393848.0 394450.0 48017.8 49616.5 49659.8 49733.5 50086.0 1083.1 1173.9 1200.6 1200.8 1201.3 26559.0 27372.6 27375.5 27727.9 27829.6 42600.4 43091.6 43179.0 43272.8 43647.1 331213.0 333906.0 333916.0 335111.0 335893.0 25377.5 25484.4 27506.7 27818.2 27821.3 42194.8 42314.6 42557.4 43748.6 43788.6 35749.5 36956.4 37446.3 37605.8 38336.1 35722.3 36099.5 36205.0 36563.8 36621.3 34077.0 35859.8 36059.6 36196.8 37229.0 30880.2 31995.2 32064.2 32359.0 32364.7 24180.0 24255.0 24611.8 24911.4 24947.3 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | [#2] jquery.html Cycles:180 Average:25035.54 Median:208397.41 stddev:61628.96 (29.6%) stddev-sans-first:61774.01 21:12:14 INFO - PROCESS | 8871 | Values: 366.7 369.7 371.5 378.1 379.6 16465.9 16684.7 17569.0 17660.7 17703.9 16051.5 16469.7 17178.7 17180.8 17239.1 5065.1 5228.8 5284.3 5294.8 5296.0 3623.8 5117.7 5703.4 6141.5 6142.3 6111.1 6162.8 6178.0 6180.0 6211.1 6313.4 6658.4 6659.3 6727.2 6728.6 6470.0 6591.1 6596.3 6612.6 6640.5 21701.3 22585.5 23705.3 23760.6 23888.6 2141.2 2166.4 2261.1 2450.1 2574.4 14032.4 14124.5 14726.3 15061.8 15287.6 1811.8 1922.5 1925.7 1950.0 1950.3 51867.2 56122.4 82346.0 82677.6 82823.0 15441.2 16437.8 16508.7 16742.0 16923.5 28239.9 28510.6 28551.9 28675.4 28772.1 8141.4 8283.3 8294.8 8354.0 8398.4 6522.9 6566.2 6630.5 6688.7 6759.0 8118.6 8158.3 8182.9 8348.3 8525.5 1491.5 1601.7 1624.4 1650.5 3138.5 769.6 770.0 814.0 828.5 834.8 16143.2 16697.9 16777.7 16791.7 16796.6 811.5 813.0 838.4 846.8 877.4 9022.8 9348.4 9448.1 9449.9 9558.3 360580.0 366982.0 377255.0 377721.0 378977.0 79126.0 79287.7 80164.0 80709.6 81893.6 874.7 879.5 893.0 900.6 902.1 14730.8 14793.9 15046.2 15125.7 15328.4 36283.5 36691.4 37817.8 38589.0 38899.4 50339.0 50465.7 52134.2 52213.5 53878.0 7096.9 7104.6 7176.2 7246.0 7377.1 9178.9 11933.1 12018.9 12142.9 12242.1 10546.5 10654.9 10666.6 10744.2 10861.5 10469.9 10657.6 10750.2 10775.8 10941.5 10186.1 10359.9 10504.7 10555.7 10977.0 6986.2 6995.2 7081.2 7162.8 7286.1 10184.4 10303.7 10340.7 10410.2 10803.2 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | [#3] mootools.html Cycles:180 Average:4919.87 Median:5173.34 stddev:2718.75 (52.6%) stddev-sans-first:2713.23 21:12:14 INFO - PROCESS | 8871 | Values: 1362.6 1380.3 1473.5 1666.8 1680.2 6437.5 7193.3 7261.5 7666.2 7681.7 7279.1 7492.9 7522.2 7576.0 7621.5 2121.8 2164.4 2164.8 2165.5 2169.6 2190.3 2200.9 2218.7 2232.4 2242.3 2172.9 2185.3 2190.9 2200.4 2251.4 2118.9 2129.8 2143.9 2150.6 2156.6 2021.2 2077.4 2091.0 2096.3 2104.9 7481.2 7550.3 7556.1 7556.2 7561.9 4192.2 4266.3 4278.5 4280.4 4284.7 2770.3 2817.3 2866.0 2888.1 2915.3 855.8 888.7 896.1 900.3 943.1 9564.9 9600.9 9604.9 9612.1 9627.0 3859.6 3930.5 3994.8 4011.5 4014.5 8286.5 8344.9 8375.6 8391.0 8462.4 4467.8 4479.5 4486.8 4499.5 4502.4 3589.4 3993.7 4014.5 4050.8 4167.6 3408.5 3421.7 3494.9 3506.4 3552.0 1136.3 1139.8 1139.9 1146.4 1155.0 723.4 734.6 836.8 860.9 863.3 4990.0 5202.7 5240.9 5281.7 5296.3 403.7 409.1 413.3 413.4 416.7 3531.7 3552.2 3572.4 3614.2 3648.1 8978.1 9176.1 9236.4 9296.3 9336.6 9031.9 9134.1 9173.9 9188.5 9235.8 6995.3 7081.0 7081.5 7099.6 7139.8 4959.4 4990.6 5049.2 5123.2 5144.0 8402.8 8581.2 8658.0 8668.3 8703.9 8631.2 8661.9 8789.5 8802.2 8841.7 6530.1 6534.6 6619.3 6638.3 6644.4 7110.9 7125.9 7142.2 7147.5 7167.9 6370.9 6427.4 6475.7 6547.0 6739.6 6435.7 6503.9 6529.9 6557.6 6637.1 5838.8 5854.7 5872.0 5924.9 5930.5 4448.1 4496.8 4596.0 4608.7 4613.4 4346.6 4390.7 4448.1 4508.1 4575.7 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | [#4] prototype.html Cycles:180 Average:4448.84 Median:5100.04 stddev:1312.79 (25.7%) stddev-sans-first:1278.93 21:12:14 INFO - PROCESS | 8871 | Values: 295.5 298.2 302.8 303.9 307.9 5104.6 5120.5 5126.3 5170.1 5171.9 4972.8 5013.8 5015.5 5036.3 5095.5 3696.0 3782.9 3895.9 3904.7 3921.0 3902.4 3920.4 3942.6 3953.3 3955.1 3912.0 3923.5 3926.1 3934.9 3950.8 3820.4 3870.1 3872.8 3956.1 3959.2 3391.2 3394.7 3407.9 3433.4 3436.2 4934.4 4971.6 4972.7 4975.3 4984.4 4393.8 4473.9 4520.3 4529.0 4582.4 5268.6 5292.2 5320.1 5329.1 5357.1 3815.9 3826.9 3836.3 3840.1 3858.8 5391.3 5599.4 5663.3 5697.2 5713.3 3861.7 3885.0 3895.1 3895.2 3935.1 3953.5 3983.7 3983.8 3997.3 4002.1 4505.9 4508.7 4520.4 4529.6 4538.3 5117.4 5222.3 5299.2 5337.7 5344.5 1350.1 1354.9 1366.5 1367.3 1372.3 822.8 860.3 862.1 890.3 890.5 4567.9 4629.4 4683.7 4703.8 4712.8 5476.9 5492.0 5492.4 5553.4 5613.7 4488.6 4676.6 4686.3 4724.1 4753.2 2939.3 2960.3 2966.2 2992.5 3017.0 5210.6 5214.7 5255.6 5266.6 5287.6 5456.9 5652.1 5685.9 5700.3 5756.4 5204.6 5251.2 5254.7 5264.8 5269.2 5539.7 5626.8 5637.0 5641.6 5669.8 5188.3 5453.1 5459.5 5489.3 5522.4 5168.8 5257.3 5278.2 5286.5 5291.4 3812.2 3845.2 3879.1 3894.6 3910.5 5553.9 5609.3 5610.3 5618.0 5663.2 5387.5 5388.4 5415.0 5433.0 5448.0 5091.9 5370.1 5390.4 5403.2 5417.9 5312.3 5335.2 5338.0 5340.5 5361.3 5187.9 5312.2 5449.8 5455.4 5461.1 5321.5 5329.8 5335.5 5354.9 5383.2 21:12:14 INFO - PROCESS | 8871 | 21:12:14 INFO - PROCESS | 8871 | [#5] yui.html Cycles:180 Average:17559.43 Median:23438.59 stddev:24577.92 (104.9%) stddev-sans-first:24613.99 21:12:14 INFO - PROCESS | 8871 | Values: 628.8 687.9 692.0 702.8 737.0 12586.7 12843.4 14327.3 15061.3 15074.5 14025.8 14652.9 14704.5 14705.0 14804.3 624.1 778.6 783.7 784.7 790.6 797.2 799.8 801.0 807.4 807.5 839.0 842.6 844.8 844.9 847.0 830.5 836.2 837.9 838.1 838.6 612.3 613.2 613.8 614.8 614.9 13850.7 13902.7 13956.9 14058.1 14072.6 13763.5 13933.0 13998.6 14124.8 14166.9 10942.8 11089.2 11139.6 11139.9 11185.6 3341.4 3454.1 3479.0 3547.7 3553.0 64328.7 64586.7 65766.7 66754.0 67707.3 10563.2 10609.8 10632.7 10693.1 10766.0 20559.7 20671.6 20765.0 20830.5 20846.7 7236.6 7288.9 7312.5 7314.5 7464.6 3770.0 3781.9 3786.1 3867.4 3887.8 3000.5 3094.7 3117.1 3117.4 3119.8 480.1 482.7 491.2 495.3 500.3 474.7 493.4 509.4 509.7 586.4 7678.9 8211.0 8396.6 8414.6 8578.2 453.3 492.3 523.3 525.8 537.8 3804.9 3987.5 4180.5 4186.7 4246.7 73559.3 88075.6 95190.5 107172.5 110098.0 81571.6 81577.6 82282.0 82907.6 83402.6 46402.5 64927.0 70484.3 72068.0 74977.0 8402.7 8420.9 8538.8 8599.7 8613.0 31107.8 40186.2 43220.4 44622.6 45306.0 55904.6 56873.7 63275.4 63899.4 64074.4 9775.9 9963.7 10084.2 10315.4 10754.6 13019.7 13082.3 13194.5 13483.7 13662.6 11433.3 11861.1 11887.5 12465.1 12482.3 11877.9 12021.5 12054.3 12406.8 12901.2 10559.7 10756.8 10847.2 10886.4 10898.6 9937.3 10377.3 10460.9 10712.0 10724.7 8907.4 8915.5 9145.9 9192.7 9244.6 21:12:14 INFO - PROCESS | 8871 | -------- Summary: end -------- 21:12:14 INFO - PROCESS | 8871 | 21:12:15 INFO - TEST-INFO | 8871: exit 0 21:12:15 INFO - TEST-OK | dromaeo_css | took 1117490ms 21:12:15 INFO - TEST-START | kraken 21:12:15 INFO - operating with platform_type : linux_ 21:12:15 INFO - Initialising browser for kraken test... 21:12:15 INFO - TEST-INFO | started process 9108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVNi4Wm/profile http://localhost:57193/getInfo.html) 21:12:20 INFO - PROCESS | 9108 | __metrics Screen width/height:1600/1200 21:12:20 INFO - PROCESS | 9108 | colorDepth:24 21:12:20 INFO - PROCESS | 9108 | Browser inner width/height: 1024/697 21:12:20 INFO - PROCESS | 9108 | __metrics 21:12:21 ERROR - PROCESS | 9108 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 21:12:22 INFO - TEST-INFO | 9108: exit 0 21:12:22 INFO - Browser initialized. 21:12:22 INFO - Running cycle 1/1 for kraken test... 21:12:22 INFO - TEST-INFO | started process 9225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVNi4Wm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:12:34 INFO - PROCESS | 9225 | RSS: Main: 186413056 21:12:34 INFO - PROCESS | 9225 | 21:12:36 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57193/tests/kraken/driver.html?testName=audio-beat-detection) 21:12:37 INFO - PROCESS | 9225 | RSS: Main: 191139840 21:12:37 INFO - PROCESS | 9225 | 21:12:40 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57193/tests/kraken/driver.html?testName=audio-dft) 21:12:41 INFO - PROCESS | 9225 | RSS: Main: 190480384 21:12:41 INFO - PROCESS | 9225 | 21:12:44 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57193/tests/kraken/driver.html?testName=audio-fft) 21:12:44 INFO - PROCESS | 9225 | RSS: Main: 186454016 21:12:44 INFO - PROCESS | 9225 | 21:12:47 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57193/tests/kraken/driver.html?testName=audio-oscillator) 21:12:47 INFO - PROCESS | 9225 | RSS: Main: 186527744 21:12:47 INFO - PROCESS | 9225 | 21:12:49 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:12:50 INFO - PROCESS | 9225 | RSS: Main: 187240448 21:12:50 INFO - PROCESS | 9225 | 21:12:53 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57193/tests/kraken/driver.html?testName=imaging-darkroom) 21:12:54 INFO - PROCESS | 9225 | RSS: Main: 187256832 21:12:54 INFO - PROCESS | 9225 | 21:12:58 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57193/tests/kraken/driver.html?testName=imaging-desaturate) 21:12:58 INFO - PROCESS | 9225 | RSS: Main: 184262656 21:12:58 INFO - PROCESS | 9225 | 21:13:01 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57193/tests/kraken/driver.html?testName=json-parse-financial) 21:13:02 INFO - PROCESS | 9225 | RSS: Main: 185782272 21:13:02 INFO - PROCESS | 9225 | 21:13:03 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:13:04 INFO - PROCESS | 9225 | RSS: Main: 186392576 21:13:04 INFO - PROCESS | 9225 | 21:13:06 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:13:07 INFO - PROCESS | 9225 | RSS: Main: 186789888 21:13:07 INFO - PROCESS | 9225 | 21:13:09 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:13:10 INFO - PROCESS | 9225 | RSS: Main: 187314176 21:13:10 INFO - PROCESS | 9225 | 21:13:12 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:13:13 INFO - PROCESS | 9225 | RSS: Main: 186654720 21:13:13 INFO - PROCESS | 9225 | 21:13:16 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:13:17 INFO - PROCESS | 9225 | RSS: Main: 186474496 21:13:17 INFO - PROCESS | 9225 | 21:13:18 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:57193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57193/tests/kraken/driver.html?testName=ai-astar) 21:13:19 INFO - PROCESS | 9225 | RSS: Main: 187445248 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | __start_tp_report 21:13:19 INFO - PROCESS | 9225 | _x_x_mozilla_page_load 21:13:19 INFO - PROCESS | 9225 | _x_x_mozilla_page_load_details 21:13:19 INFO - PROCESS | 9225 | |i|pagename|runs| 21:13:19 INFO - PROCESS | 9225 | |0;ai-astar;116;115;115;115;115;117;115;114;115;114 21:13:19 INFO - PROCESS | 9225 | |1;audio-beat-detection;158;134;157;184;136;160;154;148;197;133 21:13:19 INFO - PROCESS | 9225 | |2;audio-dft;164;168;175;165;163;164;163;164;164;164 21:13:19 INFO - PROCESS | 9225 | |3;audio-fft;79;77;77;163;79;78;77;75;162;78 21:13:19 INFO - PROCESS | 9225 | |4;audio-oscillator;86;87;142;88;87;87;135;87;87;135 21:13:19 INFO - PROCESS | 9225 | |5;imaging-gaussian-blur;117;119;127;118;118;119;118;119;117;118 21:13:19 INFO - PROCESS | 9225 | |6;imaging-darkroom;149;148;148;148;149;149;148;148;148;149 21:13:19 INFO - PROCESS | 9225 | |7;imaging-desaturate;95;96;95;97;95;96;95;96;96;96 21:13:19 INFO - PROCESS | 9225 | |8;json-parse-financial;65;69;64;64;65;66;65;64;65;65 21:13:19 INFO - PROCESS | 9225 | |9;json-stringify-tinderbox;66;67;66;66;65;68;66;66;66;66 21:13:19 INFO - PROCESS | 9225 | |10;stanford-crypto-aes;85;85;90;86;85;86;86;86;112;85 21:13:19 INFO - PROCESS | 9225 | |11;stanford-crypto-ccm;134;139;134;132;131;131;133;136;139;134 21:13:19 INFO - PROCESS | 9225 | |12;stanford-crypto-pbkdf2;176;170;171;178;170;170;170;176;180;174 21:13:19 INFO - PROCESS | 9225 | |13;stanford-crypto-sha256-iterative;69;73;69;69;69;69;69;68;69;69 21:13:19 INFO - PROCESS | 9225 | __end_tp_report 21:13:19 INFO - PROCESS | 9225 | __start_cc_report 21:13:19 INFO - PROCESS | 9225 | _x_x_mozilla_cycle_collect,986 21:13:19 INFO - PROCESS | 9225 | __end_cc_report 21:13:19 INFO - PROCESS | 9225 | __startTimestamp1466482399156__endTimestamp 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | ------- Summary: start ------- 21:13:19 INFO - PROCESS | 9225 | Number of tests: 14 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 21:13:19 INFO - PROCESS | 9225 | Values: 116.0 115.0 115.0 115.0 115.0 117.0 115.0 114.0 115.0 114.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:157.50 stddev:20.99 (13.3%) stddev-sans-first:22.26 21:13:19 INFO - PROCESS | 9225 | Values: 158.0 134.0 157.0 184.0 136.0 160.0 154.0 148.0 197.0 133.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:3.66 (2.2%) stddev-sans-first:3.84 21:13:19 INFO - PROCESS | 9225 | Values: 164.0 168.0 175.0 165.0 163.0 164.0 163.0 164.0 164.0 164.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.50 stddev:35.86 (46.3%) stddev-sans-first:37.59 21:13:19 INFO - PROCESS | 9225 | Values: 79.0 77.0 77.0 163.0 79.0 78.0 77.0 75.0 162.0 78.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:87.00 stddev:24.39 (28.0%) stddev-sans-first:25.17 21:13:19 INFO - PROCESS | 9225 | Values: 86.0 87.0 142.0 88.0 87.0 87.0 135.0 87.0 87.0 135.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:118.50 stddev:2.91 (2.5%) stddev-sans-first:2.99 21:13:19 INFO - PROCESS | 9225 | Values: 117.0 119.0 127.0 118.0 118.0 119.0 118.0 119.0 117.0 118.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 21:13:19 INFO - PROCESS | 9225 | Values: 149.0 148.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 149.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 21:13:19 INFO - PROCESS | 9225 | Values: 95.0 96.0 95.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 21:13:19 INFO - PROCESS | 9225 | Values: 65.0 69.0 64.0 64.0 65.0 66.0 65.0 64.0 65.0 65.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 21:13:19 INFO - PROCESS | 9225 | Values: 66.0 67.0 66.0 66.0 65.0 68.0 66.0 66.0 66.0 66.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:86.00 stddev:8.36 (9.7%) stddev-sans-first:8.76 21:13:19 INFO - PROCESS | 9225 | Values: 85.0 85.0 90.0 86.0 85.0 86.0 86.0 86.0 112.0 85.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:134.00 stddev:2.91 (2.2%) stddev-sans-first:3.08 21:13:19 INFO - PROCESS | 9225 | Values: 134.0 139.0 134.0 132.0 131.0 131.0 133.0 136.0 139.0 134.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:175.00 stddev:3.81 (2.2%) stddev-sans-first:3.93 21:13:19 INFO - PROCESS | 9225 | Values: 176.0 170.0 171.0 178.0 170.0 170.0 170.0 176.0 180.0 174.0 21:13:19 INFO - PROCESS | 9225 | 21:13:19 INFO - PROCESS | 9225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 21:13:19 INFO - PROCESS | 9225 | Values: 69.0 73.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 21:13:19 INFO - PROCESS | 9225 | -------- Summary: end -------- 21:13:19 INFO - PROCESS | 9225 | 21:13:20 INFO - TEST-INFO | 9225: exit 0 21:13:20 INFO - TEST-OK | kraken | took 65030ms 21:13:20 INFO - SUITE-END | took 1182s 21:13:20 INFO - Completed test suite (00:19:42) 21:13:20 INFO - javascript benchmark 21:13:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6447.290035653592, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.9080932167376, 2658.747418995195, 2659.813813033087, 2671.2119924622234, 2684.141074856047, 4741.454732705735, 4768.094062128193, 4784.138855006097, 4839.443464001641, 4887.951120488794, 4735.28970654402, 4770.7853146608395, 4778.163821331271, 4846.176150054491, 4882.780274887629, 4261.6164545191, 4376.452943382077, 4438.112377524491, 4442.2448183808665, 4470.642348612103, 641.0563419043403, 4328.97835510822, 4388.034632380871, 4411.316245981878, 4441.022974945507, 4350.651947844165, 4355.629771469429, 4379.211741886459, 4384.0355121873135, 4432.335149727534, 4315.503717072545, 4379.956200437987, 4420.513743488214, 4427.424434823452, 4429.291313389842, 4309.806058727365, 4313.266744653416, 4313.503947046099, 4323.870283891489, 4386.7367957922625, 4769.642276829251, 4830.106430310404, 4840.249761287007, 4847.466778654345, 4867.5132486751045, 5147.794088236466, 5187.48125187482, 5203.869903252411, 5220.92168617471, 5274.630775845692, 5224.895502089975, 5244.580433565306, 5253.658512196695, 5276.683398996034, 5307.840764777063, 4886.853394398174, 4901.117798796179, 4904.852854414374, 4906.362172917497, 4908.730019848943, 5158.123119069767, 5310.283111779938, 5317.0, 5361.8123365682795, 5377.462253774669, 5120.590352771769, 5136.203888397305, 5136.614753893473, 5142.6914385137015, 5151.5106064923775, 5219.269302297681, 5229.843104706789, 5268.525832675077, 5269.367675878842, 5287.02190094826, 5042.697438153723, 5113.079645663742, 5168.61235407346, 5175.7153356564995, 5177.171652535651, 5007.749612519359, 5153.742312884416, 5168.457311982188, 5180.352455943007, 5188.714620695822, 4450.488193857748, 4451.488078870972, 4454.933176002362, 4471.575200355961, 4498.415206023196, 3820.255050265227, 3839.078621130964, 3848.9422658659582, 3882.9029274267805, 3893.162969961472, 4480.012709255915, 4535.31970204472, 4541.545845415432, 4585.70192937458, 4607.447106347193, 5229.189475631283, 5296.09966305729, 5315.6013299002725, 5329.467053294717, 5338.039152952429, 4435.090806384684, 4441.533638967927, 4456.0, 4462.308342206963, 4465.955340446619, 4610.838620648261, 4651.97656515566, 4677.766111694402, 4677.906441871143, 4713.0, 4754.45323787755, 4867.902641947141, 4874.902501950012, 4875.24433712775, 4879.878003049952, 5228.451012643618, 5247.344081989751, 5263.89472210546, 5276.841694749163, 5320.973395133, 4922.433920099091, 4932.30947667334, 4941.456439791548, 4953.0589188054155, 4984.903321269315, 4992.625553083606, 5166.896662066662, 5180.637355385237, 5198.610104242121, 5247.895042099213, 5242.842714718565, 5264.0, 5282.181261904411, 5292.417834038176, 5321.882404695058, 5104.259882317117, 5136.332276803992, 5147.536721695065, 5167.914737905082, 5171.250168725589, 4955.380577427822, 4979.726115063706, 5005.499450054966, 5014.52362025607, 5143.6399452037995, 4883.072216278895, 4930.186519224288, 4936.901261974812, 4949.678270912524, 4958.826441074545, 5125.846224613268, 5137.434882162885, 5142.305788718475, 5180.171172612364, 5208.348956380452, 4856.9314750754775, 4965.726885021359, 5053.393592768891, 5077.213031980049, 5081.923771143362], "value": 4737.514086137045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.3943064052941, 558.9770719583163, 563.7096895099023, 571.2459553389527, 603.749443980748, 35304.293914121736, 39360.803195984015, 39421.2115757685, 39475.0, 39526.60473395265, 39515.209695806065, 39518.0, 39536.0, 39582.20835583294, 39975.40036899449, 7681.57751323677, 7818.843623127534, 7825.217478252158, 7829.021372328459, 7838.294553490185, 7647.311741943224, 7824.178461261571, 7842.568658723768, 7847.568383738892, 7871.173526779691, 7867.606619669023, 7919.683212671515, 7932.762017139495, 7947.960260198691, 7956.960215198916, 7826.843463130734, 7828.5694286814205, 7845.725399610987, 7853.253940875607, 7853.960730196341, 7745.883811742829, 7784.182660820646, 7839.804004899866, 7841.686332546691, 7848.7645370638975, 37280.44079338812, 37548.87353379403, 37602.623973760186, 37670.05824854373, 37697.43453848167, 2707.241972247774, 2965.1697524693122, 3024.8033877798093, 3177.158053115903, 3270.3132342207928, 26082.86958565214, 27181.45637087267, 27631.44737105267, 28237.0, 28868.422631547463, 3398.371301309241, 3403.435224461827, 3425.6745609167087, 3470.2192006798523, 3518.8592456301717, 214929.0, 221229.9999999984, 221316.0, 221752.0, 221921.0, 31875.84062079721, 31896.681033189834, 32154.0, 32194.034178974667, 32392.676073239436, 33881.83059084689, 33983.32033359319, 34021.489677654856, 34054.82972585121, 34092.48861267083, 12037.217580857216, 12202.206856554296, 12276.631701048982, 12314.261144331369, 12353.135280530276, 9740.707778766648, 9742.707718768448, 9828.361156524803, 9858.0, 9880.209583233323, 7937.523748575104, 7959.920400796033, 7978.6409611567615, 8026.27763501276, 8046.114927358103, 3075.9077227683206, 3106.4253113174136, 3155.1638815713854, 3160.8419579020956, 3186.8087914725193, 898.910108989109, 902.8510295801119, 963.036963036963, 970.96601618943, 990.6483198464585, 27966.44067118646, 28339.433211335658, 28536.571951420745, 28691.713082869323, 28720.569191462146, 936.7377134402378, 994.9452780097164, 1004.2167109654481, 1015.0762805846645, 1019.4902548725637, 14723.190224537753, 14934.70130597382, 15075.623109422133, 15279.465218717292, 15363.0, 383316.0, 390591.0, 391873.0, 393848.0, 394450.0, 48017.75991120092, 49616.50383496191, 49659.751701241265, 49733.50266497361, 50086.0, 1083.1443159903588, 1173.8943495085484, 1200.6458094862037, 1200.8318835363232, 1201.3092471828734, 26559.0, 27372.589411159246, 27375.452490949672, 27727.861360693067, 27829.582556262078, 42600.360994585724, 43091.56908430876, 43179.0, 43272.783636081615, 43647.12705745804, 331213.0, 333906.0, 333916.0, 335111.0, 335893.0, 25377.49245015126, 25484.362890927132, 27506.724932751218, 27818.165455036382, 27821.304467388476, 42194.78902605467, 42314.5768542323, 42557.36163957481, 43748.56251437572, 43788.56211437845, 35749.46375804313, 36956.44565331468, 37446.25107497889, 37605.81197093997, 38336.083195840656, 35722.28555428929, 36099.458508121876, 36205.0, 36563.817180913924, 36621.26757464783, 34077.0, 35859.82070089633, 36059.63940360563, 36196.81901590475, 37229.0, 30880.227994299425, 31995.200119997186, 32064.16814282631, 32359.0, 32364.676353236166, 24180.0, 24255.0, 24611.753882461664, 24911.377215569755, 24947.251582452554], "value": 16157.437808368288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.65717554086916, 369.65991288015033, 371.50960731833976, 378.1359593329243, 379.5635019727315, 16465.917670411647, 16684.666306673873, 17569.0, 17660.735088973677, 17703.911480442614, 16051.518454446355, 16469.67060658786, 17178.656426871486, 17180.82819171808, 17239.138043097828, 5065.113605119099, 5228.843134705965, 5284.2866213061325, 5294.841154765363, 5296.0, 3623.7860316793904, 5117.746152192718, 5703.429657034305, 6141.477974372184, 6142.293636231846, 6111.083337499388, 6162.784302549411, 6177.969110154466, 6180.042093475518, 6211.068339749051, 6313.431791138796, 6658.400743933045, 6659.267480577133, 6727.192736871558, 6728.56264342821, 6470.0, 6591.143151390336, 6596.274409814917, 6612.636305003223, 6640.535162538624, 21701.34895953124, 22585.54828903429, 23705.288841334786, 23760.643590346157, 23888.64167037496, 2141.1756473757714, 2166.447555873258, 2261.050358849287, 2450.11517635445, 2574.3950171709635, 14032.43870245189, 14124.50564230247, 14726.33731482086, 15061.849381506154, 15287.617809554738, 1811.7735283089614, 1922.528980399797, 1925.653382391183, 1949.9707504387445, 1950.3466338776527, 51867.22199167016, 56122.43877561213, 82346.0, 82677.58661206656, 82823.0, 15441.227938603024, 16437.849350545348, 16508.66982660364, 16741.990961084746, 16923.492295231164, 28239.858800706275, 28510.572341414896, 28551.857240713663, 28675.426491470054, 28772.136835894955, 8141.3893957952205, 8283.337333013344, 8294.8341033179, 8353.958230208931, 8398.370122240856, 6522.869542609121, 6566.24488183865, 6630.502712296597, 6688.732450702015, 6759.0, 8118.594070296462, 8158.347332213409, 8182.918170818216, 8348.33213342931, 8525.488470691778, 1491.4779827060443, 1601.719699052661, 1624.4152105242104, 1650.4635993301986, 3138.4505021520567, 769.6267310354474, 770.0451440214206, 814.0231721933585, 828.5070383122032, 834.7853872615331, 16143.192840357935, 16697.916510417614, 16777.748333775, 16791.74812377791, 16796.58008549796, 811.5495899775564, 812.959352032396, 838.4047326398326, 846.7502086884384, 877.3989816975393, 9022.819543609092, 9348.392354497071, 9448.102430269113, 9449.90550094504, 9558.329977178095, 360580.0, 366982.0, 377255.0, 377721.0, 378977.0, 79126.0, 79287.73476466052, 80164.0, 80709.59645201736, 81893.59053204696, 874.7200895713438, 879.5426378283257, 892.9687460938836, 900.594732370436, 902.1069141549818, 14730.756771572756, 14793.92603036978, 15046.172460514777, 15125.707836790862, 15328.351404388432, 36283.45574816433, 36691.44962825613, 37817.81091094527, 38589.03527411725, 38899.416508752955, 50339.0, 50465.74767126141, 52134.21798673099, 52213.47786522086, 53878.0, 7096.893546596909, 7104.573725576482, 7176.174739904978, 7245.963770181115, 7377.077865266841, 9178.908210917805, 11933.105017123577, 12018.879811201776, 12142.939285303517, 12242.081843861924, 10546.525406356579, 10654.89345106539, 10666.573337066431, 10744.194185435967, 10861.456927153453, 10469.895301046892, 10657.626983055556, 10750.193735469715, 10775.784484310427, 10941.45292735376, 10186.134178594903, 10359.896401036194, 10504.684859454228, 10555.683329500127, 10977.0, 6986.231514533296, 6995.160580730345, 7081.221065682874, 7162.820929476805, 7286.089238845145, 10184.439855808001, 10303.690889273334, 10340.689779306633, 10410.219233557362, 10803.189760767817], "value": 8986.292485428481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.5503583817342, 1380.3236414157063, 1473.506375364253, 1666.8416500432454, 1680.193507116584, 6437.517186211029, 7193.280671932804, 7261.528000679965, 7666.195049519803, 7681.692732290709, 7279.090113735783, 7492.925070749291, 7522.2101679323705, 7575.962120189405, 7621.504602200853, 2121.830253579714, 2164.437246315961, 2164.7943445372666, 2165.545235500547, 2169.609470295346, 2190.3319487556287, 2200.8569442986236, 2218.7004754358118, 2232.3860938242033, 2242.3497185816095, 2172.902219400131, 2185.311626837549, 2190.87950162741, 2200.416889524269, 2251.448395143184, 2118.947026324339, 2129.8296136309136, 2143.871367717926, 2150.6021386043553, 2156.5579056293423, 2021.2117274263048, 2077.356019633918, 2091.027672132466, 2096.3396530093123, 2104.852660313779, 7481.177070522238, 7550.282723141293, 7556.055493063367, 7556.206598307153, 7561.924380756177, 4192.24539582875, 4266.31738921771, 4278.4865816102265, 4280.400743895857, 4284.678649101299, 2770.3351195713085, 2817.281593193743, 2865.957010644842, 2888.133559932033, 2915.3440475892967, 855.820277741675, 888.6534251641865, 896.0546623312403, 900.3382513852313, 943.0852073488705, 9564.856527152098, 9600.90399096007, 9604.90395096047, 9612.086851749073, 9627.0, 3859.55615104261, 3930.5283365996265, 3994.7603143811466, 4011.5186177658866, 4014.4781178447197, 8286.4613800104, 8344.874826877602, 8375.623096960651, 8391.0, 8462.449940753955, 4467.754273514923, 4479.484859241164, 4486.798094085774, 4499.52754960731, 4502.3921770560555, 3589.3898037333192, 3993.740406873602, 4014.4781178447197, 4050.8177132029127, 4167.645750111214, 3408.522806807049, 3421.7433692473164, 3494.934045116213, 3506.3513250048313, 3551.982240088783, 1136.2614300704608, 1139.8005349064047, 1139.8632164140356, 1146.3694967767694, 1154.9595764148214, 723.4429489293215, 734.5555938657143, 836.7573403712855, 860.8536548786722, 863.2877875752529, 4989.975050124726, 5202.687838729613, 5240.895182096337, 5281.683099014072, 5296.285001524822, 403.70731219865365, 409.1081442455416, 413.3097726796257, 413.4294673350757, 416.74370262288477, 3531.7351198660203, 3552.236269202134, 3572.356975744339, 3614.1868079682386, 3648.1062139775927, 8978.147076027766, 9176.128267814547, 9236.399634023766, 9296.256299496024, 9336.626534938527, 9031.864522032174, 9134.132257435533, 9173.862392064124, 9188.540572971324, 9235.815283694288, 6995.26549712283, 7080.964595176991, 7081.504294699322, 7099.57402555838, 7139.785806425815, 4959.355283813081, 4990.5508504234795, 5049.166887463527, 5123.231515272739, 5143.996920600596, 8402.831943360976, 8581.184787445183, 8658.047614762498, 8668.263197628272, 8703.91296087031, 8631.223189912938, 8661.870071949052, 8789.516576588348, 8802.207801297915, 8841.69054083104, 6530.08578798959, 6534.640594767334, 6619.3380661933425, 6638.336166383516, 6644.435223006099, 7110.928890711027, 7125.928740712527, 7142.214356420894, 7147.53541019832, 7167.928320716935, 6370.872582548416, 6427.357264273535, 6475.740970361133, 6546.967265163644, 6739.56192847483, 6435.710393032231, 6503.934960650522, 6529.902051469327, 6557.639329836714, 6637.103990961158, 5838.766449341979, 5854.677992710442, 5871.970640146772, 5924.911126333022, 5930.525557955267, 4448.088141930832, 4496.842610508616, 4595.954040459553, 4608.677392582487, 4613.3771940787565, 4346.565343465628, 4390.692651514491, 4448.110377924493, 4508.143452743968, 4575.725456472623], "value": 3924.865013730691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4888043684426, 298.23502715534653, 302.7517435702725, 303.9133846853647, 307.92763700530384, 5104.617153713468, 5120.5135512126335, 5126.333576635042, 5170.14692575725, 5171.922421163686, 4972.825951091712, 5013.824516141935, 5015.4984501549825, 5036.3200967869325, 5095.4649761774945, 3695.9815200924027, 3782.8865134046023, 3895.87019764268, 3904.6876249899938, 3920.980694942107, 3902.375619900816, 3920.4315374270714, 3942.56631770505, 3953.3476976298875, 3955.1496428267915, 3911.9804400978096, 3923.4894565592167, 3926.1166237596453, 3934.881953541384, 3950.7875589669734, 3820.4078367853026, 3870.07118291608, 3872.7869967151796, 3956.109875278054, 3959.1883663848844, 3391.16916355492, 3394.677505636985, 3407.863685452579, 3433.364827506919, 3436.1753179237053, 4934.383202099738, 4971.6271279654175, 4972.726500042496, 4975.278584605212, 4984.37695288089, 4393.802278897458, 4473.932891006638, 4520.344550040226, 4529.0, 4582.404287442611, 5268.604854635918, 5292.153255479144, 5320.068987927098, 5329.095642874642, 5357.116075847481, 3815.904602384963, 3826.8660596878976, 3836.271108489406, 3840.135969406889, 3858.787766672832, 5391.272178255964, 5599.4120617335, 5663.320401551799, 5697.1739097831, 5713.3429655589725, 3861.6717579005535, 3885.0, 3895.14306852492, 3895.220955808793, 3935.1145992151537, 3953.466282051886, 3983.661388781928, 3983.7609743415487, 3997.340438827619, 4002.1195337025806, 4505.932411013838, 4508.684392092588, 4520.367148599199, 4529.573184446888, 4538.2738761797955, 5117.360329958755, 5222.321098257202, 5299.2316114164005, 5337.6797392156595, 5344.4922732340365, 1350.122420426711, 1354.850966393696, 1366.4943970730694, 1367.2616786935143, 1372.3069849725825, 822.7655118291378, 860.3031544449017, 862.1249431826701, 890.3233542507611, 890.5013192612029, 4567.862964111082, 4629.398178236875, 4683.711979205746, 4703.7883295251795, 4712.764361781898, 5476.890462190734, 5491.979411323836, 5492.423295553989, 5553.389127196006, 5613.691246981373, 4488.5511448855505, 4676.55572720591, 4686.343911852344, 4724.055188962221, 4753.215719406328, 2939.2945693033516, 2960.3339248668876, 2966.228780517038, 2992.5361568956846, 3016.9547456788164, 5210.609204309692, 5214.661047031931, 5255.605829562798, 5266.578673706094, 5287.603429742708, 5456.890862182734, 5652.123920792284, 5685.914711279334, 5700.25896633435, 5756.359437560275, 5204.5576126028955, 5251.238570407346, 5254.710990895537, 5264.763085661078, 5269.209618557247, 5539.695316757456, 5626.833669037532, 5636.957162924872, 5641.576881733804, 5669.801556945487, 5188.299579556711, 5453.127499600045, 5459.508644222039, 5489.313835770528, 5522.3649280331665, 5168.793248270177, 5257.263983042453, 5278.155495120763, 5286.471352864683, 5291.391489978548, 3812.2244799129894, 3845.1540661054523, 3879.1465877506903, 3894.552126505488, 3910.4916360874045, 5553.916986187654, 5609.326880774333, 5610.298712660918, 5617.9719101404235, 5663.178839068394, 5387.542058924879, 5388.38033626138, 5415.0, 5433.0, 5448.0, 5091.879786446976, 5370.113931201308, 5390.407055223844, 5403.216533602527, 5417.891642167214, 5312.335958005249, 5335.1730481775385, 5338.03915295235, 5340.465953404629, 5361.303030605996, 5187.896242075213, 5312.229726689531, 5449.754761035683, 5455.372632147354, 5461.143211308175, 5321.467853214647, 5329.813456529003, 5335.532728499694, 5354.892902141857, 5383.219433182245], "value": 4024.491263667194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.7987843889956, 687.8830598798207, 691.9896950452339, 702.8032150997719, 736.9852602947944, 12586.748265034705, 12843.422046007929, 14327.283635818207, 15061.322240499176, 15074.47239346623, 14025.78961315581, 14652.926735366334, 14704.485343012997, 14705.044172128804, 14804.25978701066, 624.1418050181001, 778.5795670338039, 783.6904422753009, 784.701813310941, 790.6007466229546, 797.174923953708, 799.8160423102661, 800.9799755006143, 807.3621838747382, 807.475141158246, 838.9790255243606, 842.6081871929551, 844.8394804987064, 844.8732690096473, 846.9915300847005, 830.4602008694367, 836.2056046755546, 837.8994520657499, 838.0990435282096, 838.6351936907434, 612.3478495402427, 613.1814028272262, 613.7606333529927, 614.8309214965875, 614.9354317796611, 13850.722985540333, 13902.652433689138, 13956.860431395658, 14058.086224395382, 14072.648183795385, 13763.518276860363, 13933.0, 13998.580042598738, 14124.788128178085, 14166.92916535421, 10942.781144377148, 11089.168312376603, 11139.610113646064, 11139.888601114048, 11185.552577896955, 3341.448660970937, 3454.084667563098, 3479.0, 3547.7161827053774, 3553.0406790166767, 64328.67835660838, 64586.67706661484, 65766.67116664434, 66754.0, 67707.32292677108, 10563.207759418074, 10609.787804244026, 10632.681019569425, 10693.144548436107, 10766.0, 20559.691604625943, 20671.58656826855, 20765.0, 20830.479238019172, 20846.68729969052, 7236.638168091575, 7288.927110728825, 7312.451566132561, 7314.524555903849, 7464.626768661546, 3769.962300376961, 3781.9243615127543, 3786.110264087937, 3867.400552914303, 3887.8056097195026, 3000.534917087855, 3094.706002929718, 3117.06488053583, 3117.423276693819, 3119.828409437457, 480.0998128509045, 482.7055496147347, 491.2067011775956, 495.3315006067868, 500.2721040885503, 474.6511314184072, 493.363561006305, 509.38364578859256, 509.6890896553174, 586.3550094895666, 7678.923210767933, 8210.958945205235, 8396.622152003174, 8414.621342039623, 8578.18507241811, 453.31549360465937, 492.28864291099734, 523.2909407752517, 525.7949399734107, 537.8467136865975, 3804.923901521954, 3987.4816273884207, 4180.540140584594, 4186.706930514895, 4246.702730808814, 73559.26440735631, 88075.55962220147, 95190.52404737932, 107172.4641376788, 110098.0, 81571.5921420389, 81577.59211204025, 82282.0, 82907.5854620723, 83402.58298708468, 46402.535974640494, 64927.02609460862, 70484.2951570488, 72068.0, 74977.0, 8402.747917562483, 8420.915790842013, 8538.829223415372, 8599.742007739778, 8613.0, 31107.844460777553, 40186.1962760749, 43220.351694725236, 44622.55377446184, 45306.0, 55904.6023849407, 56873.715631421575, 63275.36724632695, 63899.3610063912, 64074.35925640684, 9775.902240977499, 9963.651272205438, 10084.193264538673, 10315.432651204255, 10754.623588174376, 13019.739605208033, 13082.345882706017, 13194.538191163263, 13483.730325393633, 13662.590122296348, 11433.256838305484, 11861.110416718608, 11887.524499019943, 12465.065120116209, 12482.313472759086, 11877.940610296893, 12021.519139234333, 12054.337011464453, 12406.828804959276, 12901.161424507378, 10559.683209503728, 10756.838647420138, 10847.186461015297, 10886.40124793144, 10898.618548351087, 9937.292806646059, 10377.273590848568, 10460.947695261475, 10712.0, 10724.678259652223, 8907.421017633833, 8915.50964696922, 9145.86281205769, 9192.678256260999, 9244.583993720164], "value": 6609.627795752411, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 115.0, 117.0, 115.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 157.0, 184.0, 136.0, 160.0, 154.0, 148.0, 197.0, 133.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 175.0, 165.0, 163.0, 164.0, 163.0, 164.0, 164.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 163.0, 79.0, 78.0, 77.0, 75.0, 162.0, 78.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 142.0, 88.0, 87.0, 87.0, 135.0, 87.0, 87.0, 135.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 127.0, 118.0, 118.0, 119.0, 118.0, 119.0, 117.0, 118.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 65.0, 68.0, 66.0, 66.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 90.0, 86.0, 85.0, 86.0, 86.0, 86.0, 112.0, 85.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 134.0, 132.0, 131.0, 131.0, 133.0, 136.0, 139.0, 134.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 171.0, 178.0, 170.0, 170.0, 170.0, 176.0, 180.0, 174.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "value": 69.3, "unit": "score"}]}]} 21:13:20 INFO - Return code: 0 21:13:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:13:20 ERROR - # TBPL SUCCESS # 21:13:20 INFO - Running post-action listener: _resource_record_post_action 21:13:20 INFO - ##### 21:13:20 INFO - ##### Finished run-tests step (success) 21:13:20 INFO - ##### 21:13:20 INFO - Running post-run listener: _resource_record_post_run 21:13:21 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544509952; Read time: 112; Write time: 587196 21:13:21 INFO - TinderboxPrint: CPU usage
13.5% 21:13:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 21:13:21 INFO - TinderboxPrint: I/O write bytes / time
544,509,952 / 587,196 21:13:21 INFO - TinderboxPrint: CPU idle
8,279.4 (86.5%) 21:13:21 INFO - TinderboxPrint: CPU user
1,231.0 (12.9%) 21:13:21 INFO - TinderboxPrint: Swap in / out
0 / 0 21:13:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 221339648; Read time: 0; Write time: 334448 21:13:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298582016; Read time: 112; Write time: 248220 21:13:21 INFO - Running post-run listener: _upload_blobber_files 21:13:21 INFO - Blob upload gear active. 21:13:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:13:21 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 21:13:21 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:13:21 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:13:22 INFO - (blobuploader) - INFO - Open directory for files ... 21:13:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:13:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:13:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:22 INFO - (blobuploader) - INFO - Done attempting. 21:13:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:13:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:13:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:26 INFO - (blobuploader) - INFO - Done attempting. 21:13:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:13:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:13:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:27 INFO - (blobuploader) - INFO - Done attempting. 21:13:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:13:27 INFO - Return code: 0 21:13:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:13:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:13:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20f354f3821cd5e873d7bcdccb60dde9bc99333940ef7421d3f84c50c9141fe8b21e7b544b6c49d8daf5b2aad70ee0584fcad18701aa1750b60e043b67aaf777", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa96060b7c8deb0ea5d93786165b223136dfa40965b077b10249444832ac5ab2cdabe1530a61b6812c05441d92bc846b76cd87f7f299cf3a93be4ab7d0d8f7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9075be44d18c4c72016f66fd5b827f1c4c6e1a5102fc1942a9fddf3c012145be4e2bf4d11ed4884d060bfb7f2538fad5c20d03e6061a46e9698c38f22f02dcf4"} 21:13:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:13:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:13:27 INFO - Contents: 21:13:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20f354f3821cd5e873d7bcdccb60dde9bc99333940ef7421d3f84c50c9141fe8b21e7b544b6c49d8daf5b2aad70ee0584fcad18701aa1750b60e043b67aaf777", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa96060b7c8deb0ea5d93786165b223136dfa40965b077b10249444832ac5ab2cdabe1530a61b6812c05441d92bc846b76cd87f7f299cf3a93be4ab7d0d8f7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9075be44d18c4c72016f66fd5b827f1c4c6e1a5102fc1942a9fddf3c012145be4e2bf4d11ed4884d060bfb7f2538fad5c20d03e6061a46e9698c38f22f02dcf4"} 21:13:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:13:27 INFO - Copying logs to upload dir... 21:13:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:13:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.268062 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-20 21:13:26.870560) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 21:13:26.873998) ========= 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=52faae308a556c440401f8e5000001e8-1466480104.673564-505014766 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/Fx-Team-Non-PGO/sha512/20f354f3821cd5e873d7bcdccb60dde9bc99333940ef7421d3f84c50c9141fe8b21e7b544b6c49d8daf5b2aad70ee0584fcad18701aa1750b60e043b67aaf777", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa96060b7c8deb0ea5d93786165b223136dfa40965b077b10249444832ac5ab2cdabe1530a61b6812c05441d92bc846b76cd87f7f299cf3a93be4ab7d0d8f7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9075be44d18c4c72016f66fd5b827f1c4c6e1a5102fc1942a9fddf3c012145be4e2bf4d11ed4884d060bfb7f2538fad5c20d03e6061a46e9698c38f22f02dcf4"} build_url:https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/IqVTRY35TDW_tdTcUIGTfQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20f354f3821cd5e873d7bcdccb60dde9bc99333940ef7421d3f84c50c9141fe8b21e7b544b6c49d8daf5b2aad70ee0584fcad18701aa1750b60e043b67aaf777", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa96060b7c8deb0ea5d93786165b223136dfa40965b077b10249444832ac5ab2cdabe1530a61b6812c05441d92bc846b76cd87f7f299cf3a93be4ab7d0d8f7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9075be44d18c4c72016f66fd5b827f1c4c6e1a5102fc1942a9fddf3c012145be4e2bf4d11ed4884d060bfb7f2538fad5c20d03e6061a46e9698c38f22f02dcf4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 21:13:26.906946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 21:13:26.907314) ========= 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=52faae308a556c440401f8e5000001e8-1466480104.673564-505014766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 21:13:26.990710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 21:13:26.991057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 21:13:26.991371) ========= ========= Total master_lag: 0.17 =========