builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1466691366.37 results: success (0) buildid: 20160623055826 builduid: 87d20ab26b314da48b89a453e71b31de revision: d1102663db10b3d4b9358f3cf4e16b7c56902352 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.371185) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.371700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.371985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.387463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.387842) ========= 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=920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 07:16:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-06-23 07:16:06 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.485485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.485833) ========= 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=920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020305 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.536824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:06.537352) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1102663db10b3d4b9358f3cf4e16b7c56902352 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d1102663db10b3d4b9358f3cf4e16b7c56902352 --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=920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 07:16:06,645 truncating revision to first 12 chars 2016-06-23 07:16:06,645 Setting DEBUG logging. 2016-06-23 07:16:06,645 attempt 1/10 2016-06-23 07:16:06,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1102663db10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 07:16:06,959 unpacking tar archive at: mozilla-central-d1102663db10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:07.212182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:07.212530) ========= script_repo_revision: d1102663db10b3d4b9358f3cf4e16b7c56902352 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:07.212950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:07.213255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:16:07.223791) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-23 07:16:07.224129) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:16:07 INFO - MultiFileLogger online at 20160623 07:16:07 in /builds/slave/test 07:16:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:16:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:16:07 INFO - {'append_to_log': False, 07:16:07 INFO - 'base_work_dir': '/builds/slave/test', 07:16:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:16:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:16:07 INFO - 'branch': 'Firefox-Non-PGO', 07:16:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:16:07 INFO - 'config_files': ('talos/linux_config.py',), 07:16:07 INFO - 'default_actions': ('clobber', 07:16:07 INFO - 'read-buildbot-config', 07:16:07 INFO - 'download-and-extract', 07:16:07 INFO - 'populate-webroot', 07:16:07 INFO - 'create-virtualenv', 07:16:07 INFO - 'install', 07:16:07 INFO - 'run-tests'), 07:16:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:16:07 INFO - 'download_minidump_stackwalk': True, 07:16:07 INFO - 'download_symbols': 'ondemand', 07:16:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:16:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:16:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:16:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:16:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:16:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:16:07 INFO - 'installer_path': 'installer.exe', 07:16:07 INFO - 'log_level': 'info', 07:16:07 INFO - 'log_name': 'talos', 07:16:07 INFO - 'log_to_console': True, 07:16:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:16:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:16:07 INFO - 'opt_config_files': (), 07:16:07 INFO - 'pip_index': False, 07:16:07 INFO - 'sps_profile': False, 07:16:07 INFO - 'sps_profile_interval': 0, 07:16:07 INFO - 'suite': 'dromaeojs-e10s', 07:16:07 INFO - 'system_bits': '32', 07:16:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:16:07 INFO - 'title': 'talos-linux64-ix-053', 07:16:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:16:07 INFO - 'use_talos_json': True, 07:16:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:16:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:16:07 INFO - 'work_dir': 'build'} 07:16:07 INFO - ##### 07:16:07 INFO - ##### Running clobber step. 07:16:07 INFO - ##### 07:16:07 INFO - Running pre-action listener: _resource_record_pre_action 07:16:07 INFO - Running main action method: clobber 07:16:07 INFO - rmtree: /builds/slave/test/build 07:16:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:16:08 INFO - Running post-action listener: _resource_record_post_action 07:16:08 INFO - ##### 07:16:08 INFO - ##### Finished clobber step (success) 07:16:08 INFO - ##### 07:16:08 INFO - ##### 07:16:08 INFO - ##### Running read-buildbot-config step. 07:16:08 INFO - ##### 07:16:08 INFO - Running pre-action listener: _resource_record_pre_action 07:16:08 INFO - Running main action method: read_buildbot_config 07:16:08 INFO - Using buildbot properties: 07:16:08 INFO - { 07:16:08 INFO - "project": "", 07:16:08 INFO - "product": "firefox", 07:16:08 INFO - "script_repo_revision": "production", 07:16:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:16:08 INFO - "repository": "", 07:16:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:16:08 INFO - "buildid": "20160623055826", 07:16:08 INFO - "pgo_build": "False", 07:16:08 INFO - "basedir": "/builds/slave/test", 07:16:08 INFO - "buildnumber": 86, 07:16:08 INFO - "slavename": "talos-linux64-ix-053", 07:16:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:16:08 INFO - "platform": "ubuntu64_hw", 07:16:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:16:08 INFO - "branch": "mozilla-central", 07:16:08 INFO - "repo_path": "mozilla-central", 07:16:08 INFO - "revision": "d1102663db10b3d4b9358f3cf4e16b7c56902352", 07:16:08 INFO - "stage_platform": "linux64", 07:16:08 INFO - "builduid": "87d20ab26b314da48b89a453e71b31de", 07:16:08 INFO - "slavebuilddir": "test" 07:16:08 INFO - } 07:16:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:16:08 INFO - Running post-action listener: _resource_record_post_action 07:16:08 INFO - ##### 07:16:08 INFO - ##### Finished read-buildbot-config step (success) 07:16:08 INFO - ##### 07:16:08 INFO - ##### 07:16:08 INFO - ##### Running download-and-extract step. 07:16:08 INFO - ##### 07:16:08 INFO - Running pre-action listener: _resource_record_pre_action 07:16:08 INFO - Running main action method: download_and_extract 07:16:08 INFO - mkdir: /builds/slave/test/build/tests 07:16:08 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')]} 07:16:08 INFO - https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:12 INFO - Downloaded 1361 bytes. 07:16:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:12 INFO - Using the following test package requirements: 07:16:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:16:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:16:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'jsshell-linux-x86_64.zip'], 07:16:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:16:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:16:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:16:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:16:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:16:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:16: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')]} 07:16:12 INFO - https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:16:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:13 INFO - Downloaded 22703282 bytes. 07:16:13 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'] 07:16:13 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 07:16:14 INFO - Return code: 0 07:16:14 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 07:16:14 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')]} 07:16:14 INFO - https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:16 INFO - Downloaded 22703282 bytes. 07:16:16 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'] 07:16:16 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 07:16:18 INFO - Return code: 0 07:16:18 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')]} 07:16:18 INFO - https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:19 INFO - Downloaded 14405384 bytes. 07:16:19 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'] 07:16:19 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 07:16:19 INFO - Return code: 0 07:16:19 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')]} 07:16:19 INFO - https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N_vbBqUxSaqHsPWycMlA4w/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 07:16:21 INFO - Downloaded 56279442 bytes. 07:16:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:21 INFO - mkdir: /builds/slave/test/properties 07:16:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:16:21 INFO - Writing to file /builds/slave/test/properties/build_url 07:16:21 INFO - Contents: 07:16:21 INFO - build_url:https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:21 INFO - Running post-action listener: _resource_record_post_action 07:16:21 INFO - Running post-action listener: set_extra_try_arguments 07:16:21 INFO - ##### 07:16:21 INFO - ##### Finished download-and-extract step (success) 07:16:21 INFO - ##### 07:16:21 INFO - ##### 07:16:21 INFO - ##### Running populate-webroot step. 07:16:21 INFO - ##### 07:16:21 INFO - Running pre-action listener: _resource_record_pre_action 07:16:21 INFO - Running main action method: populate_webroot 07:16:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:16:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:16:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:16:21 INFO - '--tppagecycles', 07:16:21 INFO - '7'], 07:16:21 INFO - 'tests': ['tsvgm']}}, 07:16:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:16:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:16:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:16:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:16:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:21 INFO - 'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:21 INFO - 'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['damp', 'tps']}, 07:16:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:21 INFO - 'tests': ['damp', 'tps']}, 07:16:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['dromaeo_dom']}, 07:16:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:16:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['basic_compositor_video']}, 07:16:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:16:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:16:21 INFO - 'tests': ['a11yr', 07:16:21 INFO - 'ts_paint', 07:16:21 INFO - 'tpaint', 07:16:21 INFO - 'sessionrestore', 07:16:21 INFO - 'sessionrestore_no_auto_restore', 07:16:21 INFO - 'tabpaint']}, 07:16:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:16:21 INFO - 'ts_paint', 07:16:21 INFO - 'tpaint', 07:16:21 INFO - 'sessionrestore', 07:16:21 INFO - 'sessionrestore_no_auto_restore', 07:16:21 INFO - 'tabpaint']}, 07:16:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:16:21 INFO - 'ts_paint', 07:16:21 INFO - 'tpaint', 07:16:21 INFO - 'sessionrestore', 07:16:21 INFO - 'sessionrestore_no_auto_restore', 07:16:21 INFO - 'tabpaint']}, 07:16:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:16:21 INFO - 'ts_paint', 07:16:21 INFO - 'tpaint', 07:16:21 INFO - 'sessionrestore', 07:16:21 INFO - 'sessionrestore_no_auto_restore', 07:16:21 INFO - 'tabpaint']}, 07:16:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:16:22 INFO - 'tests': ['a11yr', 07:16:22 INFO - 'ts_paint', 07:16:22 INFO - 'tpaint', 07:16:22 INFO - 'sessionrestore', 07:16:22 INFO - 'sessionrestore_no_auto_restore', 07:16:22 INFO - 'tabpaint']}, 07:16:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:16:22 INFO - 'tests': ['a11yr', 07:16:22 INFO - 'ts_paint', 07:16:22 INFO - 'tpaint', 07:16:22 INFO - 'sessionrestore', 07:16:22 INFO - 'sessionrestore_no_auto_restore', 07:16:22 INFO - 'tabpaint']}, 07:16:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:16:22 INFO - 'tests': ['tsvgx', 07:16:22 INFO - 'tsvgr_opacity', 07:16:22 INFO - 'tart', 07:16:22 INFO - 'tscrollx', 07:16:22 INFO - 'cart']}, 07:16:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:16:22 INFO - 'tsvgr_opacity', 07:16:22 INFO - 'tart', 07:16:22 INFO - 'tscrollx', 07:16:22 INFO - 'cart']}, 07:16:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:22 INFO - 'talos_options': ['--disable-e10s'], 07:16:22 INFO - 'tests': ['tp5o']}, 07:16:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:22 INFO - 'tests': ['tp5o']}, 07:16:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:22 INFO - 'talos_options': ['--disable-e10s', 07:16:22 INFO - '--xperf_path', 07:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:22 INFO - 'tests': ['tp5n']}, 07:16:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:22 INFO - 'talos_options': ['--xperf_path', 07:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:22 INFO - 'tests': ['tp5n']}}, 07:16:22 INFO - 'talos.zip': {'path': '', 07:16:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:16:22 INFO - Running post-action listener: _resource_record_post_action 07:16:22 INFO - ##### 07:16:22 INFO - ##### Finished populate-webroot step (success) 07:16:22 INFO - ##### 07:16:22 INFO - ##### 07:16:22 INFO - ##### Running create-virtualenv step. 07:16:22 INFO - ##### 07:16:22 INFO - Running pre-action listener: _resource_record_pre_action 07:16:22 INFO - Running main action method: create_virtualenv 07:16:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:16:22 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 07:16:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:16:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:16:22 INFO - Using real prefix '/usr' 07:16:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:16:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:16:24 INFO - Installing pip.................done. 07:16:24 INFO - Return code: 0 07:16:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:24 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:24 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 07:16:24 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 07:16:24 INFO - Using env: {'DISPLAY': ':0', 07:16:24 INFO - 'HOME': '/home/cltbld', 07:16:24 INFO - 'LANG': 'en_US.UTF-8', 07:16:24 INFO - 'LANGUAGE': 'en_US:en', 07:16:24 INFO - 'LOGNAME': 'cltbld', 07:16:24 INFO - 'MAIL': '/var/mail/cltbld', 07:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:24 INFO - 'MOZ_NO_REMOTE': '1', 07:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:24 INFO - 'NO_EM_RESTART': '1', 07:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:24 INFO - 'PWD': '/builds/slave/test', 07:16:24 INFO - 'SHELL': '/bin/bash', 07:16:24 INFO - 'SHLVL': '1', 07:16:24 INFO - 'TERM': 'linux', 07:16:24 INFO - 'TMOUT': '86400', 07:16:24 INFO - 'USER': 'cltbld', 07:16:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:24 INFO - '_': '/tools/buildbot/bin/python'} 07:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:24 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 07:16:24 INFO - Cleaning up... 07:16:24 INFO - Return code: 0 07:16:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:24 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:24 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 07:16:24 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 07:16:24 INFO - Using env: {'DISPLAY': ':0', 07:16:24 INFO - 'HOME': '/home/cltbld', 07:16:24 INFO - 'LANG': 'en_US.UTF-8', 07:16:24 INFO - 'LANGUAGE': 'en_US:en', 07:16:24 INFO - 'LOGNAME': 'cltbld', 07:16:24 INFO - 'MAIL': '/var/mail/cltbld', 07:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:24 INFO - 'MOZ_NO_REMOTE': '1', 07:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:24 INFO - 'NO_EM_RESTART': '1', 07:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:24 INFO - 'PWD': '/builds/slave/test', 07:16:24 INFO - 'SHELL': '/bin/bash', 07:16:24 INFO - 'SHLVL': '1', 07:16:24 INFO - 'TERM': 'linux', 07:16:24 INFO - 'TMOUT': '86400', 07:16:24 INFO - 'USER': 'cltbld', 07:16:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:24 INFO - '_': '/tools/buildbot/bin/python'} 07:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:25 INFO - Downloading/unpacking psutil>=3.1.1 07:16:25 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 07:16:25 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 07:16:25 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 07:16:25 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 07:16:25 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 07:16:25 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 07:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:27 INFO - Installing collected packages: psutil 07:16:27 INFO - Running setup.py install for psutil 07:16:27 INFO - building 'psutil._psutil_linux' extension 07:16:27 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 07:16:27 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 07:16:27 INFO - building 'psutil._psutil_posix' extension 07:16:27 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 07:16:27 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 07:16:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:29 INFO - Successfully installed psutil 07:16:29 INFO - Cleaning up... 07:16:29 INFO - Return code: 0 07:16:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:16:29 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')]} 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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')]} 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:29 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:29 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 07:16:29 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 07:16:29 INFO - Using env: {'DISPLAY': ':0', 07:16:29 INFO - 'HOME': '/home/cltbld', 07:16:29 INFO - 'LANG': 'en_US.UTF-8', 07:16:29 INFO - 'LANGUAGE': 'en_US:en', 07:16:29 INFO - 'LOGNAME': 'cltbld', 07:16:29 INFO - 'MAIL': '/var/mail/cltbld', 07:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:29 INFO - 'MOZ_NO_REMOTE': '1', 07:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:29 INFO - 'NO_EM_RESTART': '1', 07:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:29 INFO - 'PWD': '/builds/slave/test', 07:16:29 INFO - 'SHELL': '/bin/bash', 07:16:29 INFO - 'SHLVL': '1', 07:16:29 INFO - 'TERM': 'linux', 07:16:29 INFO - 'TMOUT': '86400', 07:16:29 INFO - 'USER': 'cltbld', 07:16:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:29 INFO - '_': '/tools/buildbot/bin/python'} 07:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:16:29 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 07:16:29 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 07:16:29 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 07:16:29 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 07:16:29 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 07:16:29 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 07:16:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:16:31 INFO - Installing collected packages: mozsystemmonitor 07:16:31 INFO - Running setup.py install for mozsystemmonitor 07:16:31 INFO - Successfully installed mozsystemmonitor 07:16:31 INFO - Cleaning up... 07:16:31 INFO - Return code: 0 07:16:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:16:31 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')]} 07:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:31 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')]} 07:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:31 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:31 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 07:16:31 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 07:16:31 INFO - Using env: {'DISPLAY': ':0', 07:16:31 INFO - 'HOME': '/home/cltbld', 07:16:31 INFO - 'LANG': 'en_US.UTF-8', 07:16:31 INFO - 'LANGUAGE': 'en_US:en', 07:16:31 INFO - 'LOGNAME': 'cltbld', 07:16:31 INFO - 'MAIL': '/var/mail/cltbld', 07:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:31 INFO - 'MOZ_NO_REMOTE': '1', 07:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:31 INFO - 'NO_EM_RESTART': '1', 07:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:31 INFO - 'PWD': '/builds/slave/test', 07:16:31 INFO - 'SHELL': '/bin/bash', 07:16:31 INFO - 'SHLVL': '1', 07:16:31 INFO - 'TERM': 'linux', 07:16:31 INFO - 'TMOUT': '86400', 07:16:31 INFO - 'USER': 'cltbld', 07:16:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:31 INFO - '_': '/tools/buildbot/bin/python'} 07:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 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 07:16:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:16:33 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 07:16:33 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 07:16:33 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 07:16:33 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 07:16:33 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 07:16:33 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 07:16:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:33 INFO - warning: no files found matching '*.txt' 07:16:33 INFO - no previously-included directories found matching 'build' 07:16:33 INFO - no previously-included directories found matching 'dist' 07:16:33 INFO - no previously-included directories found matching '.git*' 07:16:33 INFO - Installing collected packages: jsonschema, functools32 07:16:33 INFO - Running setup.py install for functools32 07:16:33 INFO - warning: no files found matching '*.txt' 07:16:33 INFO - no previously-included directories found matching 'build' 07:16:33 INFO - no previously-included directories found matching 'dist' 07:16:33 INFO - no previously-included directories found matching '.git*' 07:16:33 INFO - Successfully installed jsonschema functools32 07:16:33 INFO - Cleaning up... 07:16:33 INFO - Return code: 0 07:16:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:16:33 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')]} 07:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:33 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')]} 07:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:33 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:33 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 07:16:33 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 07:16:33 INFO - Using env: {'DISPLAY': ':0', 07:16:33 INFO - 'HOME': '/home/cltbld', 07:16:33 INFO - 'LANG': 'en_US.UTF-8', 07:16:33 INFO - 'LANGUAGE': 'en_US:en', 07:16:33 INFO - 'LOGNAME': 'cltbld', 07:16:33 INFO - 'MAIL': '/var/mail/cltbld', 07:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:33 INFO - 'MOZ_NO_REMOTE': '1', 07:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:33 INFO - 'NO_EM_RESTART': '1', 07:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:33 INFO - 'PWD': '/builds/slave/test', 07:16:33 INFO - 'SHELL': '/bin/bash', 07:16:33 INFO - 'SHLVL': '1', 07:16:33 INFO - 'TERM': 'linux', 07:16:33 INFO - 'TMOUT': '86400', 07:16:33 INFO - 'USER': 'cltbld', 07:16:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:33 INFO - '_': '/tools/buildbot/bin/python'} 07:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:16:34 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 07:16:34 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 07:16:34 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 07:16:34 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 07:16:34 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 07:16:34 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 07:16:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:16:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:16:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 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 07:16:36 INFO - Downloading docopt-0.6.1.tar.gz 07:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:16:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:16:36 INFO - Running setup.py install for blobuploader 07:16:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:16:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:16:37 INFO - Running setup.py install for requests 07:16:37 INFO - Running setup.py install for docopt 07:16:37 INFO - Successfully installed blobuploader requests docopt 07:16:37 INFO - Cleaning up... 07:16:37 INFO - Return code: 0 07:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:37 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')]} 07:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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')]} 07:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:37 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:37 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 07:16:37 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 07:16:37 INFO - Using env: {'DISPLAY': ':0', 07:16:37 INFO - 'HOME': '/home/cltbld', 07:16:37 INFO - 'LANG': 'en_US.UTF-8', 07:16:37 INFO - 'LANGUAGE': 'en_US:en', 07:16:37 INFO - 'LOGNAME': 'cltbld', 07:16:37 INFO - 'MAIL': '/var/mail/cltbld', 07:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:37 INFO - 'MOZ_NO_REMOTE': '1', 07:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:37 INFO - 'NO_EM_RESTART': '1', 07:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:37 INFO - 'PWD': '/builds/slave/test', 07:16:37 INFO - 'SHELL': '/bin/bash', 07:16:37 INFO - 'SHLVL': '1', 07:16:37 INFO - 'TERM': 'linux', 07:16:37 INFO - 'TMOUT': '86400', 07:16:37 INFO - 'USER': 'cltbld', 07:16:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:37 INFO - '_': '/tools/buildbot/bin/python'} 07:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:37 INFO - Running setup.py (path:/tmp/pip-UipmYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:37 INFO - Running setup.py (path:/tmp/pip-bMvtHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:37 INFO - Running setup.py (path:/tmp/pip-X7qr_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:38 INFO - Running setup.py (path:/tmp/pip-ZNySDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:38 INFO - Running setup.py (path:/tmp/pip-z1wn2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:38 INFO - Running setup.py (path:/tmp/pip-vT9Hrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:38 INFO - Running setup.py (path:/tmp/pip-7OS39s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:38 INFO - Running setup.py (path:/tmp/pip-aq8RcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:38 INFO - Running setup.py (path:/tmp/pip-p_41A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:38 INFO - Running setup.py (path:/tmp/pip-Waqe05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:38 INFO - Running setup.py (path:/tmp/pip-HPUQub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:38 INFO - Running setup.py (path:/tmp/pip-J2R_4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:38 INFO - Running setup.py (path:/tmp/pip-OAYAqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:38 INFO - Running setup.py (path:/tmp/pip-GD9Rxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:38 INFO - Running setup.py (path:/tmp/pip-cSCJQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:38 INFO - Running setup.py (path:/tmp/pip-HcTiD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:38 INFO - Running setup.py (path:/tmp/pip-FObMsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:16:38 INFO - Running setup.py install for manifestparser 07:16:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Running setup.py install for mozcrash 07:16:39 INFO - Running setup.py install for mozdebug 07:16:39 INFO - Running setup.py install for mozdevice 07:16:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Running setup.py install for mozfile 07:16:39 INFO - Running setup.py install for mozhttpd 07:16:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Running setup.py install for mozinfo 07:16:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Running setup.py install for mozInstall 07:16:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:16:39 INFO - Running setup.py install for mozleak 07:16:39 INFO - Running setup.py install for mozlog 07:16:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Running setup.py install for moznetwork 07:16:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Running setup.py install for mozprocess 07:16:40 INFO - Running setup.py install for mozprofile 07:16:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Running setup.py install for mozrunner 07:16:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Running setup.py install for mozscreenshot 07:16:40 INFO - Running setup.py install for moztest 07:16:40 INFO - Running setup.py install for mozversion 07:16:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:40 INFO - Cleaning up... 07:16:40 INFO - Return code: 0 07:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:40 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:40 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 07:16:40 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 07:16:40 INFO - Using env: {'DISPLAY': ':0', 07:16:40 INFO - 'HOME': '/home/cltbld', 07:16:40 INFO - 'LANG': 'en_US.UTF-8', 07:16:40 INFO - 'LANGUAGE': 'en_US:en', 07:16:40 INFO - 'LOGNAME': 'cltbld', 07:16:40 INFO - 'MAIL': '/var/mail/cltbld', 07:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:40 INFO - 'MOZ_NO_REMOTE': '1', 07:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:40 INFO - 'NO_EM_RESTART': '1', 07:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:40 INFO - 'PWD': '/builds/slave/test', 07:16:40 INFO - 'SHELL': '/bin/bash', 07:16:40 INFO - 'SHLVL': '1', 07:16:40 INFO - 'TERM': 'linux', 07:16:40 INFO - 'TMOUT': '86400', 07:16:40 INFO - 'USER': 'cltbld', 07:16:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:40 INFO - '_': '/tools/buildbot/bin/python'} 07:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:40 INFO - Running setup.py (path:/tmp/pip-4bMAHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:41 INFO - Running setup.py (path:/tmp/pip-n494GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:41 INFO - Running setup.py (path:/tmp/pip-UopgNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:41 INFO - Running setup.py (path:/tmp/pip-wQ0sSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:41 INFO - Running setup.py (path:/tmp/pip-5eWz2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:41 INFO - Running setup.py (path:/tmp/pip-Nx3xjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:41 INFO - Running setup.py (path:/tmp/pip-SQ0_b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:41 INFO - Running setup.py (path:/tmp/pip-ZJu1Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:41 INFO - Running setup.py (path:/tmp/pip-VpjsO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:41 INFO - Running setup.py (path:/tmp/pip-UUiwP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:41 INFO - Running setup.py (path:/tmp/pip-gYzlFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:41 INFO - Running setup.py (path:/tmp/pip-dLYuKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:41 INFO - Running setup.py (path:/tmp/pip-_yx139-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:41 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)) 07:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:41 INFO - Running setup.py (path:/tmp/pip-ClWi_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:42 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)) 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:42 INFO - Running setup.py (path:/tmp/pip-cz43Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:42 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)) 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:42 INFO - Running setup.py (path:/tmp/pip-mwPt1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:42 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)) 07:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:42 INFO - Running setup.py (path:/tmp/pip-cayPY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:42 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)) 07:16:42 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)) 07:16:42 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)) 07:16:42 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)) 07:16:42 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)) 07:16:42 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)) 07:16:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:42 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 07:16:42 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 07:16:42 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 07:16:42 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 07:16:42 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 07:16:42 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 07:16:44 INFO - Downloading blessings-1.6.tar.gz 07:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:44 INFO - Installing collected packages: blessings 07:16:44 INFO - Running setup.py install for blessings 07:16:44 INFO - Successfully installed blessings 07:16:44 INFO - Cleaning up... 07:16:44 INFO - Return code: 0 07:16:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:44 INFO - Reading from file tmpfile_stdout 07:16:44 INFO - Current package versions: 07:16:44 INFO - argparse == 1.2.1 07:16:44 INFO - blessings == 1.6 07:16:44 INFO - blobuploader == 1.2.4 07:16:44 INFO - docopt == 0.6.1 07:16:44 INFO - functools32 == 3.2.3-2 07:16:44 INFO - jsonschema == 2.5.1 07:16:44 INFO - manifestparser == 1.1 07:16:44 INFO - mozInstall == 1.12 07:16:44 INFO - mozcrash == 0.17 07:16:44 INFO - mozdebug == 0.1 07:16:44 INFO - mozdevice == 0.48 07:16:44 INFO - mozfile == 1.2 07:16:44 INFO - mozhttpd == 0.7 07:16:44 INFO - mozinfo == 0.9 07:16:44 INFO - mozleak == 0.1 07:16:44 INFO - mozlog == 3.2 07:16:44 INFO - moznetwork == 0.27 07:16:44 INFO - mozprocess == 0.22 07:16:44 INFO - mozprofile == 0.28 07:16:44 INFO - mozrunner == 6.11 07:16:44 INFO - mozscreenshot == 0.1 07:16:44 INFO - mozsystemmonitor == 0.3 07:16:44 INFO - moztest == 0.7 07:16:44 INFO - mozversion == 1.4 07:16:44 INFO - psutil == 3.1.1 07:16:44 INFO - requests == 1.2.3 07:16:44 INFO - wsgiref == 0.1.2 07:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:44 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')]} 07:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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')]} 07:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:44 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 07:16:44 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 07:16:44 INFO - Using env: {'DISPLAY': ':0', 07:16:44 INFO - 'HOME': '/home/cltbld', 07:16:44 INFO - 'LANG': 'en_US.UTF-8', 07:16:44 INFO - 'LANGUAGE': 'en_US:en', 07:16:44 INFO - 'LOGNAME': 'cltbld', 07:16:44 INFO - 'MAIL': '/var/mail/cltbld', 07:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:44 INFO - 'MOZ_NO_REMOTE': '1', 07:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:44 INFO - 'NO_EM_RESTART': '1', 07:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:44 INFO - 'PWD': '/builds/slave/test', 07:16:44 INFO - 'SHELL': '/bin/bash', 07:16:44 INFO - 'SHLVL': '1', 07:16:44 INFO - 'TERM': 'linux', 07:16:44 INFO - 'TMOUT': '86400', 07:16:44 INFO - 'USER': 'cltbld', 07:16:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:44 INFO - '_': '/tools/buildbot/bin/python'} 07:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 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)) 07:16:44 INFO - Cleaning up... 07:16:44 INFO - Return code: 0 07:16:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:44 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')]} 07:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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')]} 07:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:44 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 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:44 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 07:16:44 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 07:16:44 INFO - Using env: {'DISPLAY': ':0', 07:16:44 INFO - 'HOME': '/home/cltbld', 07:16:44 INFO - 'LANG': 'en_US.UTF-8', 07:16:44 INFO - 'LANGUAGE': 'en_US:en', 07:16:44 INFO - 'LOGNAME': 'cltbld', 07:16:44 INFO - 'MAIL': '/var/mail/cltbld', 07:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:44 INFO - 'MOZ_NO_REMOTE': '1', 07:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:44 INFO - 'NO_EM_RESTART': '1', 07:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:44 INFO - 'PWD': '/builds/slave/test', 07:16:44 INFO - 'SHELL': '/bin/bash', 07:16:44 INFO - 'SHLVL': '1', 07:16:44 INFO - 'TERM': 'linux', 07:16:44 INFO - 'TMOUT': '86400', 07:16:44 INFO - 'USER': 'cltbld', 07:16:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:44 INFO - '_': '/tools/buildbot/bin/python'} 07:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:16:45 INFO - Cleaning up... 07:16:45 INFO - Return code: 0 07:16:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e2bbc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, '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': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', '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 07:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:16:45 INFO - Using env: {'DISPLAY': ':0', 07:16:45 INFO - 'HOME': '/home/cltbld', 07:16:45 INFO - 'LANG': 'en_US.UTF-8', 07:16:45 INFO - 'LANGUAGE': 'en_US:en', 07:16:45 INFO - 'LOGNAME': 'cltbld', 07:16:45 INFO - 'MAIL': '/var/mail/cltbld', 07:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:45 INFO - 'MOZ_NO_REMOTE': '1', 07:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:45 INFO - 'NO_EM_RESTART': '1', 07:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:45 INFO - 'PWD': '/builds/slave/test', 07:16:45 INFO - 'SHELL': '/bin/bash', 07:16:45 INFO - 'SHLVL': '1', 07:16:45 INFO - 'TERM': 'linux', 07:16:45 INFO - 'TMOUT': '86400', 07:16:45 INFO - 'USER': 'cltbld', 07:16:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:45 INFO - '_': '/tools/buildbot/bin/python'} 07:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:45 INFO - Downloading/unpacking flake8 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:16:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:16:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 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 07:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:16:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:47 INFO - no previously-included directories found matching 'docs/_build' 07:16:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:16:47 INFO - Running setup.py install for pep8 07:16:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:47 INFO - no previously-included directories found matching 'docs/_build' 07:16:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:16:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:16:48 INFO - Cleaning up... 07:16:48 INFO - Return code: 0 07:16:48 INFO - Running post-action listener: _resource_record_post_action 07:16:48 INFO - Running post-action listener: _start_resource_monitoring 07:16:48 INFO - Starting resource monitoring. 07:16:48 INFO - ##### 07:16:48 INFO - ##### Finished create-virtualenv step (success) 07:16:48 INFO - ##### 07:16:48 INFO - ##### 07:16:48 INFO - ##### Running install step. 07:16:48 INFO - ##### 07:16:48 INFO - Running pre-action listener: _resource_record_pre_action 07:16:48 INFO - Running main action method: install 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:48 INFO - Reading from file tmpfile_stdout 07:16:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:48 INFO - Reading from file tmpfile_stdout 07:16:48 INFO - Output received: 07:16:48 INFO - Usage: mozinstall [options] installer 07:16:48 INFO - Options: 07:16:48 INFO - -h, --help show this help message and exit 07:16:48 INFO - -d DEST, --destination=DEST 07:16:48 INFO - Directory to install application into. [default: 07:16:48 INFO - "/builds/slave/test"] 07:16:48 INFO - --app=APP Application being installed. [default: firefox] 07:16:48 INFO - mkdir: /builds/slave/test/build/application 07:16:48 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'] 07:16:48 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 07:17:04 INFO - Reading from file tmpfile_stdout 07:17:04 INFO - Output received: 07:17:04 INFO - /builds/slave/test/build/application/firefox/firefox 07:17:04 INFO - Running post-action listener: _resource_record_post_action 07:17:04 INFO - ##### 07:17:04 INFO - ##### Finished install step (success) 07:17:04 INFO - ##### 07:17:04 INFO - ##### 07:17:04 INFO - ##### Running run-tests step. 07:17:04 INFO - ##### 07:17:04 INFO - Running pre-action listener: _resource_record_pre_action 07:17:04 INFO - Running main action method: run_tests 07:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:17:04 INFO - Python 2.7.3 07:17:04 INFO - Return code: 0 07:17:04 INFO - grabbing minidump binary from tooltool 07:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:04 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 0x153f1c0>, '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 0x15400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1540550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:17:04 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 07:17:04 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 07:17:04 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 07:17:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:17:04 INFO - Return code: 0 07:17:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:17:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:17:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:17:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:17:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:17:05 INFO - Return code: 0 07:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 07:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 07:17:05 INFO - Using env: {'DISPLAY': ':0', 07:17:05 INFO - 'HOME': '/home/cltbld', 07:17:05 INFO - 'LANG': 'en_US.UTF-8', 07:17:05 INFO - 'LANGUAGE': 'en_US:en', 07:17:05 INFO - 'LOGNAME': 'cltbld', 07:17:05 INFO - 'MAIL': '/var/mail/cltbld', 07:17:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:17:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:05 INFO - 'MOZ_NO_REMOTE': '1', 07:17:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:05 INFO - 'NO_EM_RESTART': '1', 07:17:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:05 INFO - 'PWD': '/builds/slave/test', 07:17:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:17:05 INFO - 'SHELL': '/bin/bash', 07:17:05 INFO - 'SHLVL': '1', 07:17:05 INFO - 'TERM': 'linux', 07:17:05 INFO - 'TMOUT': '86400', 07:17:05 INFO - 'USER': 'cltbld', 07:17:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948', 07:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:05 INFO - '_': '/tools/buildbot/bin/python'} 07:17:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 07:17:05 INFO - mozversion application_buildid: 20160623055826 07:17:05 INFO - mozversion application_changeset: d1102663db10b3d4b9358f3cf4e16b7c56902352 07:17:05 INFO - mozversion application_display_name: Nightly 07:17:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:17:05 INFO - mozversion application_name: Firefox 07:17:05 INFO - mozversion application_remotingname: firefox 07:17:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:17:05 INFO - mozversion application_vendor: Mozilla 07:17:05 INFO - mozversion application_version: 50.0a1 07:17:05 INFO - mozversion platform_buildid: 20160623055826 07:17:05 INFO - mozversion platform_changeset: d1102663db10b3d4b9358f3cf4e16b7c56902352 07:17:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:17:05 INFO - mozversion platform_version: 50.0a1 07:17:05 INFO - using testdate: 1466691425 07:17:05 INFO - actual date: 1466691425 07:17:05 INFO - starting webserver on 'localhost:47283' 07:17:05 INFO - SUITE-START | Running 2 tests 07:17:05 INFO - TEST-START | dromaeo_css 07:17:05 INFO - operating with platform_type : linux_ 07:17:05 INFO - Initialising browser for dromaeo_css test... 07:17:05 INFO - TEST-INFO | started process 27845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkD0dde/profile http://localhost:47283/getInfo.html) 07:17:11 INFO - PROCESS | 27845 | __metrics Screen width/height:1600/1200 07:17:11 INFO - PROCESS | 27845 | colorDepth:24 07:17:11 INFO - PROCESS | 27845 | Browser inner width/height: 1024/697 07:17:11 INFO - PROCESS | 27845 | __metrics 07:17:11 ERROR - PROCESS | 27845 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:17:12 INFO - TEST-INFO | 27845: exit 0 07:17:12 INFO - Browser initialized. 07:17:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:12 INFO - TEST-INFO | started process 27963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkD0dde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:24 INFO - PROCESS | 27963 | RSS: Main: 185745408 07:17:24 INFO - PROCESS | 27963 | 07:18:14 INFO - PROCESS | 27963 | 1466691494506 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] 07:20:27 INFO - PROCESS | 27963 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47283/tests/dromaeo/cssquery-ext.html) 07:20:28 INFO - PROCESS | 27963 | RSS: Main: 189231104 07:20:28 INFO - PROCESS | 27963 | 07:23:30 INFO - PROCESS | 27963 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-ext.html (next: http://localhost:47283/tests/dromaeo/cssquery-jquery.html) 07:23:31 INFO - PROCESS | 27963 | RSS: Main: 188256256 07:23:31 INFO - PROCESS | 27963 | 07:26:32 INFO - PROCESS | 27963 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47283/tests/dromaeo/cssquery-mootools.html) 07:26:33 INFO - PROCESS | 27963 | RSS: Main: 189243392 07:26:33 INFO - PROCESS | 27963 | 07:29:35 INFO - PROCESS | 27963 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47283/tests/dromaeo/cssquery-prototype.html) 07:29:36 INFO - PROCESS | 27963 | RSS: Main: 186765312 07:29:36 INFO - PROCESS | 27963 | 07:32:38 INFO - PROCESS | 27963 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47283/tests/dromaeo/cssquery-yui.html) 07:32:39 INFO - PROCESS | 27963 | RSS: Main: 188829696 07:32:39 INFO - PROCESS | 27963 | 07:35:41 INFO - PROCESS | 27963 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-yui.html (next: http://localhost:47283/tests/dromaeo/cssquery-dojo.html) 07:35:42 INFO - PROCESS | 27963 | RSS: Main: 189775872 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | __start_tp_report 07:35:42 INFO - PROCESS | 27963 | _x_x_mozilla_page_load 07:35:42 INFO - PROCESS | 27963 | _x_x_mozilla_page_load_details 07:35:42 INFO - PROCESS | 27963 | |i|pagename|runs| 07:35:42 INFO - PROCESS | 27963 | |0;dojo.html;2646.179684297868;2702.418979919318;2707.16078015815;2711.349276173719;2724.0193530329084;4861.756912154391;4863.294822250771;4903.239997800338;4929.457759646436;5001.949590585981;4769.713817170972;4846.297286893398;4847.175980083385;4863.854084377465;4882.072406242812;4419.999999999992;4455.933161002587;4521.163584736818;4533.8413155539565;4538.3873177120995;634.1604380891251;4367.650587952972;4454.198244316021;4474.105178964204;4519.683622146435;4459.35339375792;4473.776311184444;4500.144972455223;4510.526394728539;4536.954630453686;4485.102979404132;4501.932471012905;4520.909581808378;4528.298113792367;4529.4791099023705;4307.073979094478;4379.364992076131;4393.0994146199955;4399.252127138394;4418.491873434532;4787.640926930494;4865.124277630025;4879.097366987084;4912.287718280865;4958.628102892261;5178.326817513736;5261.5264626183825;5276.709780962045;5289.550388217006;5337.6797392156595;5209.270702101709;5283.471652834686;5295.179247216687;5307.681539107666;5348.5186333230195;4917.041176970492;4925.532074452885;4935.481774413706;4935.75321233944;4935.876603084952;5256.684598924;5344.6258761887075;5371.865703357369;5399.541039011649;5425.972870135703;5190.948090519122;5211.140161873249;5221.13851214553;5221.947780522222;5266.47335266478;5301.708406037628;5318.680879147263;5324.893502129936;5331.280277162611;5370.91943620846;5051.6716413433005;5188.351456067991;5238.476152384807;5263.499967503081;5270.841874743764;5226.817061402909;5235.790568377299;5263.815766448156;5263.973680131575;5276.314079169683;4505.256632655575;4513.706609070466;4518.954810451919;4538.52345503724;4569.543045695404;3802.6957843373016;3830.9808450957566;3877.4765406670303;3880.3985382265796;3928.4696565963227;4443.7111587746695;4447.3773671685985;4464.598186163261;4496.010877606921;4504.819807207675;5255.13290307095;5270.446603106695;5275.103232450492;5276.762545685453;5280.1815718563685;4352.891177720582;4462.464504259509;4510.210713125256;4516.209663308908;4533.818647254139;4741.525847415231;4753.073150735573;4762.690425122356;4781.067691800135;4828;4757.119932812441;4946.060248552763;4949.752512374439;4956.405231372114;5004.974975125174;5195.818146364859;5232.319798426181;5245.344331958505;5255.0540902637895;5255.579553635624;4849.345338379415;4918.0901533216465;4918.508149185053;4919.901601968012;4947.554720075211;4979.377577802775;5143.7428128594165;5159.277701121921;5161;5168.121419358793;5219.739013049409;5295.417504074626;5314.362276526842;5315.069862773922;5362.570994320523;5135.3324067870935;5141.61437892167;5149.562287205629;5149.716765577929;5183.714895680774;5008.84973450797;5049.166887463527;5088.084144853962;5135.38375394955;5168.224766285088;5012.423571289202;5033.521815427529;5039.798408063636;5060.038592667382;5073.8731531712;5163.044836705221;5163.432022477599;5167.767450464663;5175.870603234949;5196.064708352533;4924.581410579997;4996.575291100297;5008.824691135793;5010.874728131826;5056.974715126401 07:35:42 INFO - PROCESS | 27963 | |1;ext.html;538.122406639004;571.1090698510325;586.8386193796705;593.0540787444027;608.2245137449754;35941.460878086815;36710.26579468409;40249.396259056135;40420.393694094615;40483.59516404835;39428.605713942925;39922.40116398256;40113.7994310028;40332.19335613286;40368.39447408291;7837.2946434820715;7922.524648521078;7955.761327160194;7980.720674776384;8007.439479236426;7806.5316081035035;7844.450888437812;7844.68621255152;7925.722599709012;7931.881021784678;7880.763577092696;7907.327877130451;7914.881276780853;7933.841323173533;7961.164077771838;7830.334421574173;7834.72578459754;7873.724419645342;7896.842063158733;7898;7620.085589729268;7680;7685.308322250969;7728.497647652885;7734.381249500027;37334;37577.43633845494;37682.24635507302;37704.24591508154;37793.81103094467;2545.9745402545923;2870.899518516863;2873.655161380627;2987.2233219362906;3439.7592168548213;26896.59655105175;27172.864135679392;27523.86238068797;27814;28690.139295821158;3189.6331921828823;3203.9679603203904;3225.8870939517237;3260.788048776822;3275.6233033201247;221382;221656;221858;222632;223067;31212;31368.686313137034;31380.686193138234;31479.685203148132;31589.8420507896;32107.35785284281;32643;33274.3345133096;33278.50082248768;33562.66437335644;13305.534306299232;13446.394912228972;13467.393967271497;13499.257540835348;13499.86500134986;11173.273737207055;11184.496697648625;11191.216614837045;11239.887601123884;11308.151888608387;7737.574433406104;7756.379489640815;7790.805229869298;7823.804404889924;7853.960730196312;3032.605761251067;3051.832149231769;3083.2908431060982;3106.51848963411;3134.091113577037;866.571047331575;891.0554811899408;926.249737712455;970.4613939263777;981.7202097402206;28321;28337.858310708725;29740.40519189604;30239.848800755855;31832.681673183433;951.1154626197564;961.6922584772806;1009.8333774927202;1020.4081632653043;1041.2190856857358;14357.210353430453;14775.778363324558;14813.629659258604;14832;14863.033902796284;443174;443521;445167;445593;446696;47339.289910651365;47687.761561191975;47806.282905756445;47962.520374796506;48044;1149.8677652069953;1157.1726215755775;1181.8936295733254;1189.2983139947473;1202.1765090912752;26246;27232.36605803658;27384.589231161946;27619;28099;41764.373534397615;41894;42296.57703422927;42392.36411453769;42561.36157957695;378645;382462;382605;382840;384787;23863.642045368986;24115.397115071562;24301.878490608142;24303.635445468684;24450.388740281636;40580;40657;40846.38730418987;40979.795101024305;41299.38050929298;34260.31479370349;35674;35778.463323050695;35964.280714385044;36614.8169259152;33003.339933200725;35380.115497112776;35524.28951420906;35575.288494229455;36024.27951441009;33174.502382464765;33480;33952.15119622029;33994;34165.145871353416;30909.227269318446;31676.683233168296;31854;31898;32184.19539511531;24483;24802.379940501633;24843.254702358958;24914.626280606168;25190.74809251884 07:35:42 INFO - PROCESS | 27963 | |2;jquery.html;361.7558148249931;367.3901323802487;367.39196629578055;379.08072923161325;382.8009435093753;15553.144577048271;16998;17699.469015929528;17749.20128594213;17761.64476710465;16180.433684821033;16649.66700665986;17335.91332043341;17385.91307043463;17458;5049.974750126254;5214.947850521503;5251.632385733;5253.343332083489;5253.86865328366;3758.4174452959833;5118.718470484122;5875.970620146893;6211.720472578745;6215.81352559424;6157.353477884825;6172.4136207060255;6172.629642221481;6212.875742485147;6213.161223234851;4938.432080310757;5261.921071183935;5268.209768534713;5316.893662126736;5322.893542129174;5103.464136265676;5182.300389447414;5188.92216616751;5189.169732842727;5205.479452054802;12668.55660051903;12730.363481825872;13220.537281195207;19283.325083622007;19441.416757497158;1795.8742887997846;1854.4714756294527;1953.8339241164517;1961.3037371732971;2375.548645757318;8879.28965682744;9173.81652366949;9579.856302155473;9619.759506012335;9702.078302561245;1672.8327167283296;1707.1378953628462;1722.1819635672955;1741.7909850817982;1769.840714335716;66765;67300;68035.65982170108;68064.3193568068;68559.65720171417;9996.600135994624;10058.195344372432;10101.747456313504;10330.896691033144;10426.061654450985;13918.234497102756;14051;14059.156450612996;14075.85924140766;14124.788128178085;7195.964020179866;7482.139553951257;7486.13909400415;7592.620368981528;7651;7141;7153;7272.090988626422;7288.599127047957;7315.4147668186415;4396.560343965578;4507.076049409863;4510.909781804346;4546.431696037996;4626.814927402934;1668.2076013893545;1707.760913472115;1784.3762176419655;1818.8726789124635;1862.245790454868;373.1231605726575;378.43801954098143;415.93760935859865;747.7009196321407;863.7432535660598;10370.688879333633;10552.41961692099;10684.839727404094;10933.835992460119;10960.12319014477;410.6653077741631;411.1879038898212;424.27660838270674;430.14830635342196;437.63457512976385;5621.747021384048;5738.569607279471;5905.43898329658;5931.228940237742;5996.070609055603;408842;419654;436474;446255;446581;81942;85141.57429212939;85810;87018.56490717505;87025;431.82726909236555;435.42741295196714;439.02536369260827;439.0297442651712;439.1765439800374;9545.761355966157;9676.371035882645;9832.9016709832;10262.538185781508;10384;36117.63882361248;36463.453048203766;37204;37758.056048599006;38231.426528601536;49483.25775113304;50301.74849125731;54386;55392.446075538726;56507;7886.408519360956;8053.718119866011;8066.314363279187;8080.83838323242;8096.595170241582;8743.038265790885;10842;11471.942640286745;11912.702182445162;11958.58144964922;10519.10587600032;10556.155507559222;10634.73413164677;10643.467826608483;10763.569457221623;10454.529546170288;10623.468826558486;10697.625583104555;10747.193960453154;10918;9908.950455247677;10600.1519878408;10705.25316139376;10866.945665271624;10908.945455272673;7603.581803000667;7901.68393264263;8016.198380161937;8115.391345649218;8169.5506747129475;4799.712017278975;8175.591220439073;10194.286399951932;10347.43089130105;10595 07:35:42 INFO - PROCESS | 27963 | |3;mootools.html;1343.3283358320837;1389.1317926296065;1441.7549016667172;1648.736202207647;1652.2564845819384;6803.829904252384;7478.401727861765;7528.397728181746;8072.71745488908;8105.594720263985;7580.545167289966;7793.181715919832;7839.647215875285;7898.289153976141;7911.564863932495;2171.3594489625557;2206.933791986243;2207.426069222006;2210.0386331945656;2215.9224427145055;2147.9248226312084;2151.7310336207975;2193.5064610462678;2195.484061245606;2197.21998690465;2165.4694599823065;2191.3097374327117;2193.1337121836864;2207.194374053467;2215.401841502793;2158.773328800477;2179.7602263750973;2219.5893759654514;2223.3552269841807;2223.788740069691;2151.128792838887;2155.277981876073;2157.4067131538795;2180.890955452237;2185.7704940981125;7879.842403151905;7953.880691789628;7969.442139050268;7970.561619110947;7996;4615.953840461586;4682.836100736492;4704.247320428715;4705.482396936334;4730.692504987165;2841.8579071046365;2899.7245261700104;2943.072932026405;2985.1641540368514;2990.4019196160857;944.6788092048737;971.4899677669209;982.4841957972051;986.5264672957021;995.532099913047;10668.893311066868;10738.892611073867;10758.300710453796;10780.353178809297;10796.460176991119;4116.835326586963;4195.8741237762915;4276.401303817468;4292.59220374064;4301.139772045603;9163.03788102253;9202.079792020879;9210.171084602418;9216.124468175512;9270.814583708288;4699.671023028423;4716.3632909557455;4716.6698331116495;4728.361671174347;4728.739919304471;3635.0730563706084;4185.100203456272;4302.935455968163;4346.304591265445;4358.4769827620885;3572.214112895159;3622.637736226356;3679.7608155469807;3700.5559332880225;3732.5894151643297;1189.5539172810197;1208.8972437342748;1219.1344145656506;1220.2373516552154;1233.8272641830151;644.6422235659254;709.1383968478324;767.4819496839611;794.7377365469381;806.7378102116835;5029.723365214875;5209.71346575942;5246.344206974129;5255.369355677343;5271.4728527147745;406.8555662739744;414.76565740357205;426.058410911882;431.4865310280756;432.81389002728497;3329.8501567429525;3450.8447119879665;3482.2861313430685;3493.703035242033;3498.4052711039185;9434.90565094354;9629.951850240845;9718.805623887483;9747.805043899225;9766.75583110428;9651.806963860683;9657.613695452103;9693.273004524688;9735.805283894424;9741.318107732532;6909.861802763917;7179.31796479344;7262.31008054234;7399.519031263058;7423.700852350817;5234.241035049972;5257.579393648575;5285.814996475105;5334.78660853577;5337.733113344395;8865.202131808168;9003.774905627411;9167.724968250963;9186.816263674822;9222.40054396462;9241.630334786532;9297.209737172416;9402.623895044122;9479.383840050376;9501.192398646193;6666.533342665967;6750.35871592198;6855.143107111611;6896.896546551906;6906.37842594169;7737.303642671961;7767.223277672188;7790.143084260613;7791.22087791239;7811.140774514913;6781.287964763629;6920.9653951729915;6960;7028.683709232994;7056.259092795388;6650.401463868275;6715.764948226789;6866.279040700654;6910.20532638753;6950.096487456598;5526.696031718294;5645.1532270159805;5672.7730890763905;5706;5831.446012628793;4565.474970378449;4588.426446694163;4597.08058388317;4622.399088118523;4646.303054541846;4181.560936101787;4186.225548273579;4239.576042395859;4267.743935363888;4347.195768782785 07:35:42 INFO - PROCESS | 27963 | |4;prototype.html;283.8864454218313;293.9661938877029;298.7415885259251;304.8490996956505;306.84197638216307;4931.802727890885;4941.184704523754;5017.724025178613;5027.572656324208;5028.622853286004;4929.746367397518;4931.852044438664;4948.851534453963;4976.925346119811;4980.9252861207115;3726.124360775216;3775.528058992626;3875.670568001723;3888.7083468739816;3943.1719338938856;3840.7119466040017;3852.210296889145;3856.768593884362;3869.7678139311593;3893.683258461211;3816.2749077675294;3819.52255968004;3820.388737801952;3844.788536630498;3845.1732877431346;3761;3824.7322687412034;3838;3842.923141537168;3877.86427475037;3417.2994536120036;3434.6050204226585;3444.863195145596;3445.2592692571216;3450.723942084627;4967.304577359137;4970.707616019825;4978.983511677777;4985.725785081819;5016.523430274118;4501.639868810487;4512.255477846152;4529.660275479319;4529.682922195448;4532.614727748145;5101.489851014906;5289.365276166846;5305.434896705481;5319.281896943901;5362.605722512136;3807.162424266657;3811.294910441577;3826.7321287509885;3829.7127715421457;3833.290841194388;5580.91628625571;5595.272614560122;5598.636088654265;5606.887862242732;5642.520385767256;3767.981160094182;3829.5064924679396;3836.9232615347537;3843.7501562398356;3847.3074846527893;3891.8324502649093;3902.375619900802;3910.667593254548;3922.607739226112;3933.1347103637154;4435.733855968652;4442.6890117691455;4461.665375096881;4491.686781307629;4534.070515544371;5069.290299358093;5276.604254680914;5311.618979065393;5316.787328506816;5331.360236771612;1375.4154484344115;1395.8115654386731;1396.5391420831102;1400.1109295597166;1407.9155250684992;873.8033942363045;880.9647614095364;898.3038145437208;900.3697411811758;912.7130745648736;4408.162449134654;4493.213687604656;4614.930776038362;4641.141388843075;4649.697769644962;5488.094464413407;5498.505134537911;5516.613837031369;5517.724113794295;5518.33779946401;4520.801987473322;4556.544345565417;4599.862004139881;4628.143793398232;4646.3495110684535;2848.800583959144;2872.5116730155924;2891.5662650602576;2919.985400072986;2938.3241854373614;5065.898682026413;5091.3126727892;5119.334486516729;5121.61587880903;5142.611494896431;5352;5577.2191893135;5581.6371935824045;5622.971885140548;5669.744861481243;5156.324194636758;5156.92264616031;5162.303089082926;5166.5866730661455;5212.218167274787;5571.275734154696;5579.74891129892;5614.29821272341;5621.184928185308;5641;5253;5410.675359478444;5421.5602978660545;5422.376426710821;5430.42980487059;5101.38783345986;5126.282320475062;5157.710572356911;5160.580840268956;5166.535011848951;3828.5788563258575;3844.826982785837;3849.191669749384;3862.111714305782;3892.746971446847;5315.388730296066;5531.806386776443;5536.474034966672;5555.194496798023;5584.497395234448;5334.75940105149;5358.839234822962;5374.785008599612;5402.135658294654;5408.188771684278;5285.418603953485;5304.257403963526;5368.919466207932;5371.865703357447;5379.515843574097;4993.825216117419;5241.60687948413;5243.790248390022;5272.971770504715;5286.471352864683;5166.3800343958965;5254.6847189168775;5325.7750717336;5402.081646120248;5411.864703382289;5240.449752775904;5292.603054770831;5298.311219541435;5312.017276803804;5318.627696061239 07:35:42 INFO - PROCESS | 27963 | |5;yui.html;687.2543290529775;689.9482538809588;698.6751160710269;740.2005833699604;747.6934456872683;11575.53697852086;12274.63176104716;12279;12357.814632780515;12434.502619895193;12447.37763111843;12650.240985540873;12653.30406827624;12659.493620255178;12680.175788573737;614.529884638252;744.3115118515365;750.8798592225245;755.4296506137886;761.4251240313555;769.6844293839526;772.2277722277722;773.3967505345811;775.1163673412315;777.0946846923327;823.2056065896409;823.6746485138367;823.6787652815407;824.4229039672224;824.7484517222244;800.0559339978822;810.088650268448;810.1088802317433;812.1837553258996;813.7518056992615;584.9356570777211;590.7135039505836;591.9970400148014;592.63552914957;593.3087952535291;11128.165387595962;11230.94384528072;11253.71865703364;11253.887461125447;11258.54965801367;12741.108122431433;13191.934040329834;13314.334283285894;13386.39761210748;13403.731925361439;10080.395176289447;10569.41868197249;10768.730781730519;10840.078593319577;10899.182561307935;3285.817105841895;3337.3825842219267;3373.325334933023;3398.6771256730817;3426.931461370759;57227;57693;57965.710171448874;58166;58220.708896455246;10236.126332569522;10396.16830653546;10426.791464170674;10608.946955265174;10779.461026948622;19356.32252871143;19636.214551417783;19662;19690.803091969185;19743.60512789736;6874.175098988054;6901.551399159039;6944.826379340557;7044.260352662999;7148.070750802362;3626.9455958160647;3735.1782607826235;3756.7370284079852;3761.097336639187;3765.7928813915496;2883.5098033334384;2977.5087110626937;2991.790574659753;2996.8052076615386;3001.7598592113013;479.9976000119977;488.5944665927272;491.33178876727624;497.6566169343142;498.8303976647957;607.5261296188979;648.282151424432;651.5308977536166;654.2084078265257;654.852658151912;7844.921550784533;8003.39974501903;8163.346932245406;8260.256576908107;8461;607.9969600151971;624.8750249950028;625.0936142593258;627.438442593876;630.6342321453637;3813.9046523836573;3825.540935087807;3851.1334949636666;3905.3556163233316;4003.199360127986;56520.71739641276;87959;88746;90078;93390.53304733569;79111;82410;82630;82748.17251827405;83294.58352708198;71313;73118.99999999894;73229;73259;73565;7718.189590092959;7728.845423091394;7793.2596403341595;7825.765227043198;7942.523448593103;30057.098287051424;30275;30358.241043974078;36831.07922301964;42082.579174207865;39921;45829.31256031229;52229.7388513055;57023;59397.406025939184;10990.230683852054;11170.720731981766;11328.433578321215;11363.886361136283;11377.146713996317;12039.939800300943;12289.262644241375;12385.318807465675;12557.183783054072;13076.476940922257;11192.38441885704;11227.157963152633;11296.661100167008;11323.773524529628;11922.940385298018;10914.945425272823;11018.559257629926;11140.220184587;11213.66359009231;11357.148213884157;9916.801663966537;11052.281601695864;11107.444627768418;11190.720231994264;11515.424228788695;9457.29070319715;9774.85337719949;9813.313068085166;9846.064623860722;9855.901440985499;10349.172066234834;10522.263441559018;10539.578416863545;10548;10571.682849514527 07:35:42 INFO - PROCESS | 27963 | __end_tp_report 07:35:42 INFO - PROCESS | 27963 | __start_cc_report 07:35:42 INFO - PROCESS | 27963 | _x_x_mozilla_cycle_collect,401 07:35:42 INFO - PROCESS | 27963 | __end_cc_report 07:35:42 INFO - PROCESS | 27963 | __startTimestamp1466692542124__endTimestamp 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | ------- Summary: start ------- 07:35:42 INFO - PROCESS | 27963 | Number of tests: 6 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | [#0] dojo.html Cycles:165 Average:4821.13 Median:4958.63 stddev:617.79 (12.5%) stddev-sans-first:595.66 07:35:42 INFO - PROCESS | 27963 | Values: 2646.2 2702.4 2707.2 2711.3 2724.0 4861.8 4863.3 4903.2 4929.5 5001.9 4769.7 4846.3 4847.2 4863.9 4882.1 4420.0 4455.9 4521.2 4533.8 4538.4 634.2 4367.7 4454.2 4474.1 4519.7 4459.4 4473.8 4500.1 4510.5 4537.0 4485.1 4501.9 4520.9 4528.3 4529.5 4307.1 4379.4 4393.1 4399.3 4418.5 4787.6 4865.1 4879.1 4912.3 4958.6 5178.3 5261.5 5276.7 5289.6 5337.7 5209.3 5283.5 5295.2 5307.7 5348.5 4917.0 4925.5 4935.5 4935.8 4935.9 5256.7 5344.6 5371.9 5399.5 5426.0 5190.9 5211.1 5221.1 5221.9 5266.5 5301.7 5318.7 5324.9 5331.3 5370.9 5051.7 5188.4 5238.5 5263.5 5270.8 5226.8 5235.8 5263.8 5264.0 5276.3 4505.3 4513.7 4519.0 4538.5 4569.5 3802.7 3831.0 3877.5 3880.4 3928.5 4443.7 4447.4 4464.6 4496.0 4504.8 5255.1 5270.4 5275.1 5276.8 5280.2 4352.9 4462.5 4510.2 4516.2 4533.8 4741.5 4753.1 4762.7 4781.1 4828.0 4757.1 4946.1 4949.8 4956.4 5005.0 5195.8 5232.3 5245.3 5255.1 5255.6 4849.3 4918.1 4918.5 4919.9 4947.6 4979.4 5143.7 5159.3 5161.0 5168.1 5219.7 5295.4 5314.4 5315.1 5362.6 5135.3 5141.6 5149.6 5149.7 5183.7 5008.8 5049.2 5088.1 5135.4 5168.2 5012.4 5033.5 5039.8 5060.0 5073.9 5163.0 5163.4 5167.8 5175.9 5196.1 4924.6 4996.6 5008.8 5010.9 5057.0 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | [#1] ext.html Cycles:180 Average:48059.43 Median:35452.20 stddev:96256.50 (271.5%) stddev-sans-first:96460.40 07:35:42 INFO - PROCESS | 27963 | Values: 538.1 571.1 586.8 593.1 608.2 35941.5 36710.3 40249.4 40420.4 40483.6 39428.6 39922.4 40113.8 40332.2 40368.4 7837.3 7922.5 7955.8 7980.7 8007.4 7806.5 7844.5 7844.7 7925.7 7931.9 7880.8 7907.3 7914.9 7933.8 7961.2 7830.3 7834.7 7873.7 7896.8 7898.0 7620.1 7680.0 7685.3 7728.5 7734.4 37334.0 37577.4 37682.2 37704.2 37793.8 2546.0 2870.9 2873.7 2987.2 3439.8 26896.6 27172.9 27523.9 27814.0 28690.1 3189.6 3204.0 3225.9 3260.8 3275.6 221382.0 221656.0 221858.0 222632.0 223067.0 31212.0 31368.7 31380.7 31479.7 31589.8 32107.4 32643.0 33274.3 33278.5 33562.7 13305.5 13446.4 13467.4 13499.3 13499.9 11173.3 11184.5 11191.2 11239.9 11308.2 7737.6 7756.4 7790.8 7823.8 7854.0 3032.6 3051.8 3083.3 3106.5 3134.1 866.6 891.1 926.2 970.5 981.7 28321.0 28337.9 29740.4 30239.8 31832.7 951.1 961.7 1009.8 1020.4 1041.2 14357.2 14775.8 14813.6 14832.0 14863.0 443174.0 443521.0 445167.0 445593.0 446696.0 47339.3 47687.8 47806.3 47962.5 48044.0 1149.9 1157.2 1181.9 1189.3 1202.2 26246.0 27232.4 27384.6 27619.0 28099.0 41764.4 41894.0 42296.6 42392.4 42561.4 378645.0 382462.0 382605.0 382840.0 384787.0 23863.6 24115.4 24301.9 24303.6 24450.4 40580.0 40657.0 40846.4 40979.8 41299.4 34260.3 35674.0 35778.5 35964.3 36614.8 33003.3 35380.1 35524.3 35575.3 36024.3 33174.5 33480.0 33952.2 33994.0 34165.1 30909.2 31676.7 31854.0 31898.0 32184.2 24483.0 24802.4 24843.3 24914.6 25190.7 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | [#2] jquery.html Cycles:180 Average:25172.83 Median:438.33 stddev:71338.95 (16275.2%) stddev-sans-first:71514.75 07:35:42 INFO - PROCESS | 27963 | Values: 361.8 367.4 367.4 379.1 382.8 15553.1 16998.0 17699.5 17749.2 17761.6 16180.4 16649.7 17335.9 17385.9 17458.0 5050.0 5214.9 5251.6 5253.3 5253.9 3758.4 5118.7 5876.0 6211.7 6215.8 6157.4 6172.4 6172.6 6212.9 6213.2 4938.4 5261.9 5268.2 5316.9 5322.9 5103.5 5182.3 5188.9 5189.2 5205.5 12668.6 12730.4 13220.5 19283.3 19441.4 1795.9 1854.5 1953.8 1961.3 2375.5 8879.3 9173.8 9579.9 9619.8 9702.1 1672.8 1707.1 1722.2 1741.8 1769.8 66765.0 67300.0 68035.7 68064.3 68559.7 9996.6 10058.2 10101.7 10330.9 10426.1 13918.2 14051.0 14059.2 14075.9 14124.8 7196.0 7482.1 7486.1 7592.6 7651.0 7141.0 7153.0 7272.1 7288.6 7315.4 4396.6 4507.1 4510.9 4546.4 4626.8 1668.2 1707.8 1784.4 1818.9 1862.2 373.1 378.4 415.9 747.7 863.7 10370.7 10552.4 10684.8 10933.8 10960.1 410.7 411.2 424.3 430.1 437.6 5621.7 5738.6 5905.4 5931.2 5996.1 408842.0 419654.0 436474.0 446255.0 446581.0 81942.0 85141.6 85810.0 87018.6 87025.0 431.8 435.4 439.0 439.0 439.2 9545.8 9676.4 9832.9 10262.5 10384.0 36117.6 36463.5 37204.0 37758.1 38231.4 49483.3 50301.7 54386.0 55392.4 56507.0 7886.4 8053.7 8066.3 8080.8 8096.6 8743.0 10842.0 11471.9 11912.7 11958.6 10519.1 10556.2 10634.7 10643.5 10763.6 10454.5 10623.5 10697.6 10747.2 10918.0 9909.0 10600.2 10705.3 10866.9 10908.9 7603.6 7901.7 8016.2 8115.4 8169.6 4799.7 8175.6 10194.3 10347.4 10595.0 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | [#3] mootools.html Cycles:180 Average:5150.21 Median:5119.72 stddev:2939.24 (57.4%) stddev-sans-first:2933.56 07:35:42 INFO - PROCESS | 27963 | Values: 1343.3 1389.1 1441.8 1648.7 1652.3 6803.8 7478.4 7528.4 8072.7 8105.6 7580.5 7793.2 7839.6 7898.3 7911.6 2171.4 2206.9 2207.4 2210.0 2215.9 2147.9 2151.7 2193.5 2195.5 2197.2 2165.5 2191.3 2193.1 2207.2 2215.4 2158.8 2179.8 2219.6 2223.4 2223.8 2151.1 2155.3 2157.4 2180.9 2185.8 7879.8 7953.9 7969.4 7970.6 7996.0 4616.0 4682.8 4704.2 4705.5 4730.7 2841.9 2899.7 2943.1 2985.2 2990.4 944.7 971.5 982.5 986.5 995.5 10668.9 10738.9 10758.3 10780.4 10796.5 4116.8 4195.9 4276.4 4292.6 4301.1 9163.0 9202.1 9210.2 9216.1 9270.8 4699.7 4716.4 4716.7 4728.4 4728.7 3635.1 4185.1 4302.9 4346.3 4358.5 3572.2 3622.6 3679.8 3700.6 3732.6 1189.6 1208.9 1219.1 1220.2 1233.8 644.6 709.1 767.5 794.7 806.7 5029.7 5209.7 5246.3 5255.4 5271.5 406.9 414.8 426.1 431.5 432.8 3329.9 3450.8 3482.3 3493.7 3498.4 9434.9 9630.0 9718.8 9747.8 9766.8 9651.8 9657.6 9693.3 9735.8 9741.3 6909.9 7179.3 7262.3 7399.5 7423.7 5234.2 5257.6 5285.8 5334.8 5337.7 8865.2 9003.8 9167.7 9186.8 9222.4 9241.6 9297.2 9402.6 9479.4 9501.2 6666.5 6750.4 6855.1 6896.9 6906.4 7737.3 7767.2 7790.1 7791.2 7811.1 6781.3 6921.0 6960.0 7028.7 7056.3 6650.4 6715.8 6866.3 6910.2 6950.1 5526.7 5645.2 5672.8 5706.0 5831.4 4565.5 4588.4 4597.1 4622.4 4646.3 4181.6 4186.2 4239.6 4267.7 4347.2 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | [#4] prototype.html Cycles:180 Average:4400.79 Median:4989.78 stddev:1293.77 (25.9%) stddev-sans-first:1259.96 07:35:42 INFO - PROCESS | 27963 | Values: 283.9 294.0 298.7 304.8 306.8 4931.8 4941.2 5017.7 5027.6 5028.6 4929.7 4931.9 4948.9 4976.9 4980.9 3726.1 3775.5 3875.7 3888.7 3943.2 3840.7 3852.2 3856.8 3869.8 3893.7 3816.3 3819.5 3820.4 3844.8 3845.2 3761.0 3824.7 3838.0 3842.9 3877.9 3417.3 3434.6 3444.9 3445.3 3450.7 4967.3 4970.7 4979.0 4985.7 5016.5 4501.6 4512.3 4529.7 4529.7 4532.6 5101.5 5289.4 5305.4 5319.3 5362.6 3807.2 3811.3 3826.7 3829.7 3833.3 5580.9 5595.3 5598.6 5606.9 5642.5 3768.0 3829.5 3836.9 3843.8 3847.3 3891.8 3902.4 3910.7 3922.6 3933.1 4435.7 4442.7 4461.7 4491.7 4534.1 5069.3 5276.6 5311.6 5316.8 5331.4 1375.4 1395.8 1396.5 1400.1 1407.9 873.8 881.0 898.3 900.4 912.7 4408.2 4493.2 4614.9 4641.1 4649.7 5488.1 5498.5 5516.6 5517.7 5518.3 4520.8 4556.5 4599.9 4628.1 4646.3 2848.8 2872.5 2891.6 2920.0 2938.3 5065.9 5091.3 5119.3 5121.6 5142.6 5352.0 5577.2 5581.6 5623.0 5669.7 5156.3 5156.9 5162.3 5166.6 5212.2 5571.3 5579.7 5614.3 5621.2 5641.0 5253.0 5410.7 5421.6 5422.4 5430.4 5101.4 5126.3 5157.7 5160.6 5166.5 3828.6 3844.8 3849.2 3862.1 3892.7 5315.4 5531.8 5536.5 5555.2 5584.5 5334.8 5358.8 5374.8 5402.1 5408.2 5285.4 5304.3 5368.9 5371.9 5379.5 4993.8 5241.6 5243.8 5273.0 5286.5 5166.4 5254.7 5325.8 5402.1 5411.9 5240.4 5292.6 5298.3 5312.0 5318.6 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - PROCESS | 27963 | [#5] yui.html Cycles:180 Average:16428.36 Median:23154.66 stddev:22994.22 (99.3%) stddev-sans-first:23028.34 07:35:42 INFO - PROCESS | 27963 | Values: 687.3 689.9 698.7 740.2 747.7 11575.5 12274.6 12279.0 12357.8 12434.5 12447.4 12650.2 12653.3 12659.5 12680.2 614.5 744.3 750.9 755.4 761.4 769.7 772.2 773.4 775.1 777.1 823.2 823.7 823.7 824.4 824.7 800.1 810.1 810.1 812.2 813.8 584.9 590.7 592.0 592.6 593.3 11128.2 11230.9 11253.7 11253.9 11258.5 12741.1 13191.9 13314.3 13386.4 13403.7 10080.4 10569.4 10768.7 10840.1 10899.2 3285.8 3337.4 3373.3 3398.7 3426.9 57227.0 57693.0 57965.7 58166.0 58220.7 10236.1 10396.2 10426.8 10608.9 10779.5 19356.3 19636.2 19662.0 19690.8 19743.6 6874.2 6901.6 6944.8 7044.3 7148.1 3626.9 3735.2 3756.7 3761.1 3765.8 2883.5 2977.5 2991.8 2996.8 3001.8 480.0 488.6 491.3 497.7 498.8 607.5 648.3 651.5 654.2 654.9 7844.9 8003.4 8163.3 8260.3 8461.0 608.0 624.9 625.1 627.4 630.6 3813.9 3825.5 3851.1 3905.4 4003.2 56520.7 87959.0 88746.0 90078.0 93390.5 79111.0 82410.0 82630.0 82748.2 83294.6 71313.0 73119.0 73229.0 73259.0 73565.0 7718.2 7728.8 7793.3 7825.8 7942.5 30057.1 30275.0 30358.2 36831.1 42082.6 39921.0 45829.3 52229.7 57023.0 59397.4 10990.2 11170.7 11328.4 11363.9 11377.1 12039.9 12289.3 12385.3 12557.2 13076.5 11192.4 11227.2 11296.7 11323.8 11922.9 10914.9 11018.6 11140.2 11213.7 11357.1 9916.8 11052.3 11107.4 11190.7 11515.4 9457.3 9774.9 9813.3 9846.1 9855.9 10349.2 10522.3 10539.6 10548.0 10571.7 07:35:42 INFO - PROCESS | 27963 | -------- Summary: end -------- 07:35:42 INFO - PROCESS | 27963 | 07:35:42 INFO - TEST-INFO | 27963: exit 0 07:35:42 INFO - TEST-OK | dromaeo_css | took 1117107ms 07:35:42 INFO - TEST-START | kraken 07:35:42 INFO - operating with platform_type : linux_ 07:35:42 INFO - Initialising browser for kraken test... 07:35:42 INFO - TEST-INFO | started process 28208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj23jCQ/profile http://localhost:47283/getInfo.html) 07:35:48 INFO - PROCESS | 28208 | __metrics Screen width/height:1600/1200 07:35:48 INFO - PROCESS | 28208 | colorDepth:24 07:35:48 INFO - PROCESS | 28208 | Browser inner width/height: 1024/697 07:35:48 INFO - PROCESS | 28208 | __metrics 07:35:48 ERROR - PROCESS | 28208 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:35:49 INFO - TEST-INFO | 28208: exit 0 07:35:49 INFO - Browser initialized. 07:35:49 INFO - Running cycle 1/1 for kraken test... 07:35:49 INFO - TEST-INFO | started process 28326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj23jCQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:01 INFO - PROCESS | 28326 | RSS: Main: 185753600 07:36:01 INFO - PROCESS | 28326 | 07:36:04 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-beat-detection) 07:36:05 INFO - PROCESS | 28326 | RSS: Main: 190623744 07:36:05 INFO - PROCESS | 28326 | 07:36:08 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-dft) 07:36:09 INFO - PROCESS | 28326 | RSS: Main: 190623744 07:36:09 INFO - PROCESS | 28326 | 07:36:11 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-fft) 07:36:12 INFO - PROCESS | 28326 | RSS: Main: 185729024 07:36:12 INFO - PROCESS | 28326 | 07:36:14 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-oscillator) 07:36:15 INFO - PROCESS | 28326 | RSS: Main: 186257408 07:36:15 INFO - PROCESS | 28326 | 07:36:17 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:36:18 INFO - PROCESS | 28326 | RSS: Main: 186564608 07:36:18 INFO - PROCESS | 28326 | 07:36:21 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47283/tests/kraken/driver.html?testName=imaging-darkroom) 07:36:22 INFO - PROCESS | 28326 | RSS: Main: 186773504 07:36:22 INFO - PROCESS | 28326 | 07:36:25 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47283/tests/kraken/driver.html?testName=imaging-desaturate) 07:36:26 INFO - PROCESS | 28326 | RSS: Main: 184188928 07:36:26 INFO - PROCESS | 28326 | 07:36:29 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47283/tests/kraken/driver.html?testName=json-parse-financial) 07:36:29 INFO - PROCESS | 28326 | RSS: Main: 186478592 07:36:29 INFO - PROCESS | 28326 | 07:36:31 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:32 INFO - PROCESS | 28326 | RSS: Main: 186757120 07:36:32 INFO - PROCESS | 28326 | 07:36:34 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:34 INFO - PROCESS | 28326 | RSS: Main: 186822656 07:36:34 INFO - PROCESS | 28326 | 07:36:37 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:37 INFO - PROCESS | 28326 | RSS: Main: 187367424 07:36:37 INFO - PROCESS | 28326 | 07:36:40 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:41 INFO - PROCESS | 28326 | RSS: Main: 187424768 07:36:41 INFO - PROCESS | 28326 | 07:36:44 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:44 INFO - PROCESS | 28326 | RSS: Main: 187138048 07:36:44 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47283/tests/kraken/driver.html?testName=ai-astar) 07:36:46 INFO - PROCESS | 28326 | RSS: Main: 188874752 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | __start_tp_report 07:36:46 INFO - PROCESS | 28326 | _x_x_mozilla_page_load 07:36:46 INFO - PROCESS | 28326 | _x_x_mozilla_page_load_details 07:36:46 INFO - PROCESS | 28326 | |i|pagename|runs| 07:36:46 INFO - PROCESS | 28326 | |0;ai-astar;106;114;106;112;114;113;115;115;112;112 07:36:46 INFO - PROCESS | 28326 | |1;audio-beat-detection;156;133;169;187;131;175;157;133;208;132 07:36:46 INFO - PROCESS | 28326 | |2;audio-dft;162;170;169;163;162;163;161;163;162;163 07:36:46 INFO - PROCESS | 28326 | |3;audio-fft;76;87;76;165;76;77;74;76;176;78 07:36:46 INFO - PROCESS | 28326 | |4;audio-oscillator;86;86;159;87;87;87;133;86;88;152 07:36:46 INFO - PROCESS | 28326 | |5;imaging-gaussian-blur;118;118;118;120;118;118;120;118;120;121 07:36:46 INFO - PROCESS | 28326 | |6;imaging-darkroom;148;148;148;149;147;148;148;147;149;150 07:36:46 INFO - PROCESS | 28326 | |7;imaging-desaturate;95;96;96;95;96;96;95;96;95;95 07:36:46 INFO - PROCESS | 28326 | |8;json-parse-financial;65;65;66;71;66;66;66;65;66;65 07:36:46 INFO - PROCESS | 28326 | |9;json-stringify-tinderbox;64;65;65;65;65;64;64;65;65;66 07:36:46 INFO - PROCESS | 28326 | |10;stanford-crypto-aes;83;83;83;89;85;83;86;83;109;83 07:36:46 INFO - PROCESS | 28326 | |11;stanford-crypto-ccm;149;143;143;139;150;142;137;132;140;132 07:36:46 INFO - PROCESS | 28326 | |12;stanford-crypto-pbkdf2;171;170;170;170;176;170;171;168;170;175 07:36:46 INFO - PROCESS | 28326 | |13;stanford-crypto-sha256-iterative;72;69;69;70;70;67;71;68;68;66 07:36:46 INFO - PROCESS | 28326 | __end_tp_report 07:36:46 INFO - PROCESS | 28326 | __start_cc_report 07:36:46 INFO - PROCESS | 28326 | _x_x_mozilla_cycle_collect,964 07:36:46 INFO - PROCESS | 28326 | __end_cc_report 07:36:46 INFO - PROCESS | 28326 | __startTimestamp1466692606845__endTimestamp 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | ------- Summary: start ------- 07:36:46 INFO - PROCESS | 28326 | Number of tests: 14 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.31 (2.9%) stddev-sans-first:2.74 07:36:46 INFO - PROCESS | 28326 | Values: 106.0 114.0 106.0 112.0 114.0 113.0 115.0 115.0 112.0 112.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:163.00 stddev:26.69 (16.4%) stddev-sans-first:28.30 07:36:46 INFO - PROCESS | 28326 | Values: 156.0 133.0 169.0 187.0 131.0 175.0 157.0 133.0 208.0 132.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.08 (1.9%) stddev-sans-first:3.20 07:36:46 INFO - PROCESS | 28326 | Values: 162.0 170.0 169.0 163.0 162.0 163.0 161.0 163.0 162.0 163.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:39.46 (51.9%) stddev-sans-first:41.17 07:36:46 INFO - PROCESS | 28326 | Values: 76.0 87.0 76.0 165.0 76.0 77.0 74.0 76.0 176.0 78.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:86.50 stddev:30.28 (35.0%) stddev-sans-first:31.32 07:36:46 INFO - PROCESS | 28326 | Values: 86.0 86.0 159.0 87.0 87.0 87.0 133.0 86.0 88.0 152.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 07:36:46 INFO - PROCESS | 28326 | Values: 118.0 118.0 118.0 120.0 118.0 118.0 120.0 118.0 120.0 121.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:36:46 INFO - PROCESS | 28326 | Values: 148.0 148.0 148.0 149.0 147.0 148.0 148.0 147.0 149.0 150.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:36:46 INFO - PROCESS | 28326 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:1.79 (2.7%) stddev-sans-first:1.86 07:36:46 INFO - PROCESS | 28326 | Values: 65.0 65.0 66.0 71.0 66.0 66.0 66.0 65.0 66.0 65.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 07:36:46 INFO - PROCESS | 28326 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 66.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.00 stddev:8.08 (9.7%) stddev-sans-first:8.46 07:36:46 INFO - PROCESS | 28326 | Values: 83.0 83.0 83.0 89.0 85.0 83.0 86.0 83.0 109.0 83.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:142.50 stddev:6.11 (4.3%) stddev-sans-first:5.70 07:36:46 INFO - PROCESS | 28326 | Values: 149.0 143.0 143.0 139.0 150.0 142.0 137.0 132.0 140.0 132.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:170.50 stddev:2.47 (1.4%) stddev-sans-first:2.62 07:36:46 INFO - PROCESS | 28326 | Values: 171.0 170.0 170.0 170.0 176.0 170.0 171.0 168.0 170.0 175.0 07:36:46 INFO - PROCESS | 28326 | 07:36:46 INFO - PROCESS | 28326 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.83 (2.6%) stddev-sans-first:1.58 07:36:46 INFO - PROCESS | 28326 | Values: 72.0 69.0 69.0 70.0 70.0 67.0 71.0 68.0 68.0 66.0 07:36:46 INFO - PROCESS | 28326 | -------- Summary: end -------- 07:36:46 INFO - PROCESS | 28326 | 07:36:47 INFO - TEST-INFO | 28326: exit 0 07:36:47 INFO - TEST-OK | kraken | took 65064ms 07:36:47 INFO - SUITE-END | took 1182s 07:36:48 INFO - Completed test suite (00:19:42) 07:36:48 INFO - javascript benchmark 07:36:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6262.665424423267, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.179684297868, 2702.418979919318, 2707.16078015815, 2711.349276173719, 2724.0193530329084, 4861.756912154391, 4863.294822250771, 4903.239997800338, 4929.457759646436, 5001.949590585981, 4769.713817170972, 4846.297286893398, 4847.175980083385, 4863.854084377465, 4882.072406242812, 4419.999999999992, 4455.933161002587, 4521.163584736818, 4533.8413155539565, 4538.3873177120995, 634.1604380891251, 4367.650587952972, 4454.198244316021, 4474.105178964204, 4519.683622146435, 4459.35339375792, 4473.776311184444, 4500.144972455223, 4510.526394728539, 4536.954630453686, 4485.102979404132, 4501.932471012905, 4520.909581808378, 4528.298113792367, 4529.4791099023705, 4307.073979094478, 4379.364992076131, 4393.0994146199955, 4399.252127138394, 4418.491873434532, 4787.640926930494, 4865.124277630025, 4879.097366987084, 4912.287718280865, 4958.628102892261, 5178.326817513736, 5261.5264626183825, 5276.709780962045, 5289.550388217006, 5337.6797392156595, 5209.270702101709, 5283.471652834686, 5295.179247216687, 5307.681539107666, 5348.5186333230195, 4917.041176970492, 4925.532074452885, 4935.481774413706, 4935.75321233944, 4935.876603084952, 5256.684598924, 5344.6258761887075, 5371.865703357369, 5399.541039011649, 5425.972870135703, 5190.948090519122, 5211.140161873249, 5221.13851214553, 5221.947780522222, 5266.47335266478, 5301.708406037628, 5318.680879147263, 5324.893502129936, 5331.280277162611, 5370.91943620846, 5051.6716413433005, 5188.351456067991, 5238.476152384807, 5263.499967503081, 5270.841874743764, 5226.817061402909, 5235.790568377299, 5263.815766448156, 5263.973680131575, 5276.314079169683, 4505.256632655575, 4513.706609070466, 4518.954810451919, 4538.52345503724, 4569.543045695404, 3802.6957843373016, 3830.9808450957566, 3877.4765406670303, 3880.3985382265796, 3928.4696565963227, 4443.7111587746695, 4447.3773671685985, 4464.598186163261, 4496.010877606921, 4504.819807207675, 5255.13290307095, 5270.446603106695, 5275.103232450492, 5276.762545685453, 5280.1815718563685, 4352.891177720582, 4462.464504259509, 4510.210713125256, 4516.209663308908, 4533.818647254139, 4741.525847415231, 4753.073150735573, 4762.690425122356, 4781.067691800135, 4828.0, 4757.119932812441, 4946.060248552763, 4949.752512374439, 4956.405231372114, 5004.974975125174, 5195.818146364859, 5232.319798426181, 5245.344331958505, 5255.0540902637895, 5255.579553635624, 4849.345338379415, 4918.0901533216465, 4918.508149185053, 4919.901601968012, 4947.554720075211, 4979.377577802775, 5143.7428128594165, 5159.277701121921, 5161.0, 5168.121419358793, 5219.739013049409, 5295.417504074626, 5314.362276526842, 5315.069862773922, 5362.570994320523, 5135.3324067870935, 5141.61437892167, 5149.562287205629, 5149.716765577929, 5183.714895680774, 5008.84973450797, 5049.166887463527, 5088.084144853962, 5135.38375394955, 5168.224766285088, 5012.423571289202, 5033.521815427529, 5039.798408063636, 5060.038592667382, 5073.8731531712, 5163.044836705221, 5163.432022477599, 5167.767450464663, 5175.870603234949, 5196.064708352533, 4924.581410579997, 4996.575291100297, 5008.824691135793, 5010.874728131826, 5056.974715126401], "value": 4782.283530855555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.122406639004, 571.1090698510325, 586.8386193796705, 593.0540787444027, 608.2245137449754, 35941.460878086815, 36710.26579468409, 40249.396259056135, 40420.393694094615, 40483.59516404835, 39428.605713942925, 39922.40116398256, 40113.7994310028, 40332.19335613286, 40368.39447408291, 7837.2946434820715, 7922.524648521078, 7955.761327160194, 7980.720674776384, 8007.439479236426, 7806.5316081035035, 7844.450888437812, 7844.68621255152, 7925.722599709012, 7931.881021784678, 7880.763577092696, 7907.327877130451, 7914.881276780853, 7933.841323173533, 7961.164077771838, 7830.334421574173, 7834.72578459754, 7873.724419645342, 7896.842063158733, 7898.0, 7620.085589729268, 7680.0, 7685.308322250969, 7728.497647652885, 7734.381249500027, 37334.0, 37577.43633845494, 37682.24635507302, 37704.24591508154, 37793.81103094467, 2545.9745402545923, 2870.899518516863, 2873.655161380627, 2987.2233219362906, 3439.7592168548213, 26896.59655105175, 27172.864135679392, 27523.86238068797, 27814.0, 28690.139295821158, 3189.6331921828823, 3203.9679603203904, 3225.8870939517237, 3260.788048776822, 3275.6233033201247, 221382.0, 221656.0, 221858.0, 222632.0, 223067.0, 31212.0, 31368.686313137034, 31380.686193138234, 31479.685203148132, 31589.8420507896, 32107.35785284281, 32643.0, 33274.3345133096, 33278.50082248768, 33562.66437335644, 13305.534306299232, 13446.394912228972, 13467.393967271497, 13499.257540835348, 13499.86500134986, 11173.273737207055, 11184.496697648625, 11191.216614837045, 11239.887601123884, 11308.151888608387, 7737.574433406104, 7756.379489640815, 7790.805229869298, 7823.804404889924, 7853.960730196312, 3032.605761251067, 3051.832149231769, 3083.2908431060982, 3106.51848963411, 3134.091113577037, 866.571047331575, 891.0554811899408, 926.249737712455, 970.4613939263777, 981.7202097402206, 28321.0, 28337.858310708725, 29740.40519189604, 30239.848800755855, 31832.681673183433, 951.1154626197564, 961.6922584772806, 1009.8333774927202, 1020.4081632653043, 1041.2190856857358, 14357.210353430453, 14775.778363324558, 14813.629659258604, 14832.0, 14863.033902796284, 443174.0, 443521.0, 445167.0, 445593.0, 446696.0, 47339.289910651365, 47687.761561191975, 47806.282905756445, 47962.520374796506, 48044.0, 1149.8677652069953, 1157.1726215755775, 1181.8936295733254, 1189.2983139947473, 1202.1765090912752, 26246.0, 27232.36605803658, 27384.589231161946, 27619.0, 28099.0, 41764.373534397615, 41894.0, 42296.57703422927, 42392.36411453769, 42561.36157957695, 378645.0, 382462.0, 382605.0, 382840.0, 384787.0, 23863.642045368986, 24115.397115071562, 24301.878490608142, 24303.635445468684, 24450.388740281636, 40580.0, 40657.0, 40846.38730418987, 40979.795101024305, 41299.38050929298, 34260.31479370349, 35674.0, 35778.463323050695, 35964.280714385044, 36614.8169259152, 33003.339933200725, 35380.115497112776, 35524.28951420906, 35575.288494229455, 36024.27951441009, 33174.502382464765, 33480.0, 33952.15119622029, 33994.0, 34165.145871353416, 30909.227269318446, 31676.683233168296, 31854.0, 31898.0, 32184.19539511531, 24483.0, 24802.379940501633, 24843.254702358958, 24914.626280606168, 25190.74809251884], "value": 16170.138370860828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.7558148249931, 367.3901323802487, 367.39196629578055, 379.08072923161325, 382.8009435093753, 15553.144577048271, 16998.0, 17699.469015929528, 17749.20128594213, 17761.64476710465, 16180.433684821033, 16649.66700665986, 17335.91332043341, 17385.91307043463, 17458.0, 5049.974750126254, 5214.947850521503, 5251.632385733, 5253.343332083489, 5253.86865328366, 3758.4174452959833, 5118.718470484122, 5875.970620146893, 6211.720472578745, 6215.81352559424, 6157.353477884825, 6172.4136207060255, 6172.629642221481, 6212.875742485147, 6213.161223234851, 4938.432080310757, 5261.921071183935, 5268.209768534713, 5316.893662126736, 5322.893542129174, 5103.464136265676, 5182.300389447414, 5188.92216616751, 5189.169732842727, 5205.479452054802, 12668.55660051903, 12730.363481825872, 13220.537281195207, 19283.325083622007, 19441.416757497158, 1795.8742887997846, 1854.4714756294527, 1953.8339241164517, 1961.3037371732971, 2375.548645757318, 8879.28965682744, 9173.81652366949, 9579.856302155473, 9619.759506012335, 9702.078302561245, 1672.8327167283296, 1707.1378953628462, 1722.1819635672955, 1741.7909850817982, 1769.840714335716, 66765.0, 67300.0, 68035.65982170108, 68064.3193568068, 68559.65720171417, 9996.600135994624, 10058.195344372432, 10101.747456313504, 10330.896691033144, 10426.061654450985, 13918.234497102756, 14051.0, 14059.156450612996, 14075.85924140766, 14124.788128178085, 7195.964020179866, 7482.139553951257, 7486.13909400415, 7592.620368981528, 7651.0, 7141.0, 7153.0, 7272.090988626422, 7288.599127047957, 7315.4147668186415, 4396.560343965578, 4507.076049409863, 4510.909781804346, 4546.431696037996, 4626.814927402934, 1668.2076013893545, 1707.760913472115, 1784.3762176419655, 1818.8726789124635, 1862.245790454868, 373.1231605726575, 378.43801954098143, 415.93760935859865, 747.7009196321407, 863.7432535660598, 10370.688879333633, 10552.41961692099, 10684.839727404094, 10933.835992460119, 10960.12319014477, 410.6653077741631, 411.1879038898212, 424.27660838270674, 430.14830635342196, 437.63457512976385, 5621.747021384048, 5738.569607279471, 5905.43898329658, 5931.228940237742, 5996.070609055603, 408842.0, 419654.0, 436474.0, 446255.0, 446581.0, 81942.0, 85141.57429212939, 85810.0, 87018.56490717505, 87025.0, 431.82726909236555, 435.42741295196714, 439.02536369260827, 439.0297442651712, 439.1765439800374, 9545.761355966157, 9676.371035882645, 9832.9016709832, 10262.538185781508, 10384.0, 36117.63882361248, 36463.453048203766, 37204.0, 37758.056048599006, 38231.426528601536, 49483.25775113304, 50301.74849125731, 54386.0, 55392.446075538726, 56507.0, 7886.408519360956, 8053.718119866011, 8066.314363279187, 8080.83838323242, 8096.595170241582, 8743.038265790885, 10842.0, 11471.942640286745, 11912.702182445162, 11958.58144964922, 10519.10587600032, 10556.155507559222, 10634.73413164677, 10643.467826608483, 10763.569457221623, 10454.529546170288, 10623.468826558486, 10697.625583104555, 10747.193960453154, 10918.0, 9908.950455247677, 10600.1519878408, 10705.25316139376, 10866.945665271624, 10908.945455272673, 7603.581803000667, 7901.68393264263, 8016.198380161937, 8115.391345649218, 8169.5506747129475, 4799.712017278975, 8175.591220439073, 10194.286399951932, 10347.43089130105, 10595.0], "value": 7533.779487584116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.3283358320837, 1389.1317926296065, 1441.7549016667172, 1648.736202207647, 1652.2564845819384, 6803.829904252384, 7478.401727861765, 7528.397728181746, 8072.71745488908, 8105.594720263985, 7580.545167289966, 7793.181715919832, 7839.647215875285, 7898.289153976141, 7911.564863932495, 2171.3594489625557, 2206.933791986243, 2207.426069222006, 2210.0386331945656, 2215.9224427145055, 2147.9248226312084, 2151.7310336207975, 2193.5064610462678, 2195.484061245606, 2197.21998690465, 2165.4694599823065, 2191.3097374327117, 2193.1337121836864, 2207.194374053467, 2215.401841502793, 2158.773328800477, 2179.7602263750973, 2219.5893759654514, 2223.3552269841807, 2223.788740069691, 2151.128792838887, 2155.277981876073, 2157.4067131538795, 2180.890955452237, 2185.7704940981125, 7879.842403151905, 7953.880691789628, 7969.442139050268, 7970.561619110947, 7996.0, 4615.953840461586, 4682.836100736492, 4704.247320428715, 4705.482396936334, 4730.692504987165, 2841.8579071046365, 2899.7245261700104, 2943.072932026405, 2985.1641540368514, 2990.4019196160857, 944.6788092048737, 971.4899677669209, 982.4841957972051, 986.5264672957021, 995.532099913047, 10668.893311066868, 10738.892611073867, 10758.300710453796, 10780.353178809297, 10796.460176991119, 4116.835326586963, 4195.8741237762915, 4276.401303817468, 4292.59220374064, 4301.139772045603, 9163.03788102253, 9202.079792020879, 9210.171084602418, 9216.124468175512, 9270.814583708288, 4699.671023028423, 4716.3632909557455, 4716.6698331116495, 4728.361671174347, 4728.739919304471, 3635.0730563706084, 4185.100203456272, 4302.935455968163, 4346.304591265445, 4358.4769827620885, 3572.214112895159, 3622.637736226356, 3679.7608155469807, 3700.5559332880225, 3732.5894151643297, 1189.5539172810197, 1208.8972437342748, 1219.1344145656506, 1220.2373516552154, 1233.8272641830151, 644.6422235659254, 709.1383968478324, 767.4819496839611, 794.7377365469381, 806.7378102116835, 5029.723365214875, 5209.71346575942, 5246.344206974129, 5255.369355677343, 5271.4728527147745, 406.8555662739744, 414.76565740357205, 426.058410911882, 431.4865310280756, 432.81389002728497, 3329.8501567429525, 3450.8447119879665, 3482.2861313430685, 3493.703035242033, 3498.4052711039185, 9434.90565094354, 9629.951850240845, 9718.805623887483, 9747.805043899225, 9766.75583110428, 9651.806963860683, 9657.613695452103, 9693.273004524688, 9735.805283894424, 9741.318107732532, 6909.861802763917, 7179.31796479344, 7262.31008054234, 7399.519031263058, 7423.700852350817, 5234.241035049972, 5257.579393648575, 5285.814996475105, 5334.78660853577, 5337.733113344395, 8865.202131808168, 9003.774905627411, 9167.724968250963, 9186.816263674822, 9222.40054396462, 9241.630334786532, 9297.209737172416, 9402.623895044122, 9479.383840050376, 9501.192398646193, 6666.533342665967, 6750.35871592198, 6855.143107111611, 6896.896546551906, 6906.37842594169, 7737.303642671961, 7767.223277672188, 7790.143084260613, 7791.22087791239, 7811.140774514913, 6781.287964763629, 6920.9653951729915, 6960.0, 7028.683709232994, 7056.259092795388, 6650.401463868275, 6715.764948226789, 6866.279040700654, 6910.20532638753, 6950.096487456598, 5526.696031718294, 5645.1532270159805, 5672.7730890763905, 5706.0, 5831.446012628793, 4565.474970378449, 4588.426446694163, 4597.08058388317, 4622.399088118523, 4646.303054541846, 4181.560936101787, 4186.225548273579, 4239.576042395859, 4267.743935363888, 4347.195768782785], "value": 4064.582943607084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8864454218313, 293.9661938877029, 298.7415885259251, 304.8490996956505, 306.84197638216307, 4931.802727890885, 4941.184704523754, 5017.724025178613, 5027.572656324208, 5028.622853286004, 4929.746367397518, 4931.852044438664, 4948.851534453963, 4976.925346119811, 4980.9252861207115, 3726.124360775216, 3775.528058992626, 3875.670568001723, 3888.7083468739816, 3943.1719338938856, 3840.7119466040017, 3852.210296889145, 3856.768593884362, 3869.7678139311593, 3893.683258461211, 3816.2749077675294, 3819.52255968004, 3820.388737801952, 3844.788536630498, 3845.1732877431346, 3761.0, 3824.7322687412034, 3838.0, 3842.923141537168, 3877.86427475037, 3417.2994536120036, 3434.6050204226585, 3444.863195145596, 3445.2592692571216, 3450.723942084627, 4967.304577359137, 4970.707616019825, 4978.983511677777, 4985.725785081819, 5016.523430274118, 4501.639868810487, 4512.255477846152, 4529.660275479319, 4529.682922195448, 4532.614727748145, 5101.489851014906, 5289.365276166846, 5305.434896705481, 5319.281896943901, 5362.605722512136, 3807.162424266657, 3811.294910441577, 3826.7321287509885, 3829.7127715421457, 3833.290841194388, 5580.91628625571, 5595.272614560122, 5598.636088654265, 5606.887862242732, 5642.520385767256, 3767.981160094182, 3829.5064924679396, 3836.9232615347537, 3843.7501562398356, 3847.3074846527893, 3891.8324502649093, 3902.375619900802, 3910.667593254548, 3922.607739226112, 3933.1347103637154, 4435.733855968652, 4442.6890117691455, 4461.665375096881, 4491.686781307629, 4534.070515544371, 5069.290299358093, 5276.604254680914, 5311.618979065393, 5316.787328506816, 5331.360236771612, 1375.4154484344115, 1395.8115654386731, 1396.5391420831102, 1400.1109295597166, 1407.9155250684992, 873.8033942363045, 880.9647614095364, 898.3038145437208, 900.3697411811758, 912.7130745648736, 4408.162449134654, 4493.213687604656, 4614.930776038362, 4641.141388843075, 4649.697769644962, 5488.094464413407, 5498.505134537911, 5516.613837031369, 5517.724113794295, 5518.33779946401, 4520.801987473322, 4556.544345565417, 4599.862004139881, 4628.143793398232, 4646.3495110684535, 2848.800583959144, 2872.5116730155924, 2891.5662650602576, 2919.985400072986, 2938.3241854373614, 5065.898682026413, 5091.3126727892, 5119.334486516729, 5121.61587880903, 5142.611494896431, 5352.0, 5577.2191893135, 5581.6371935824045, 5622.971885140548, 5669.744861481243, 5156.324194636758, 5156.92264616031, 5162.303089082926, 5166.5866730661455, 5212.218167274787, 5571.275734154696, 5579.74891129892, 5614.29821272341, 5621.184928185308, 5641.0, 5253.0, 5410.675359478444, 5421.5602978660545, 5422.376426710821, 5430.42980487059, 5101.38783345986, 5126.282320475062, 5157.710572356911, 5160.580840268956, 5166.535011848951, 3828.5788563258575, 3844.826982785837, 3849.191669749384, 3862.111714305782, 3892.746971446847, 5315.388730296066, 5531.806386776443, 5536.474034966672, 5555.194496798023, 5584.497395234448, 5334.75940105149, 5358.839234822962, 5374.785008599612, 5402.135658294654, 5408.188771684278, 5285.418603953485, 5304.257403963526, 5368.919466207932, 5371.865703357447, 5379.515843574097, 4993.825216117419, 5241.60687948413, 5243.790248390022, 5272.971770504715, 5286.471352864683, 5166.3800343958965, 5254.6847189168775, 5325.7750717336, 5402.081646120248, 5411.864703382289, 5240.449752775904, 5292.603054770831, 5298.311219541435, 5312.017276803804, 5318.627696061239], "value": 3986.8049997731223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2543290529775, 689.9482538809588, 698.6751160710269, 740.2005833699604, 747.6934456872683, 11575.53697852086, 12274.63176104716, 12279.0, 12357.814632780515, 12434.502619895193, 12447.37763111843, 12650.240985540873, 12653.30406827624, 12659.493620255178, 12680.175788573737, 614.529884638252, 744.3115118515365, 750.8798592225245, 755.4296506137886, 761.4251240313555, 769.6844293839526, 772.2277722277722, 773.3967505345811, 775.1163673412315, 777.0946846923327, 823.2056065896409, 823.6746485138367, 823.6787652815407, 824.4229039672224, 824.7484517222244, 800.0559339978822, 810.088650268448, 810.1088802317433, 812.1837553258996, 813.7518056992615, 584.9356570777211, 590.7135039505836, 591.9970400148014, 592.63552914957, 593.3087952535291, 11128.165387595962, 11230.94384528072, 11253.71865703364, 11253.887461125447, 11258.54965801367, 12741.108122431433, 13191.934040329834, 13314.334283285894, 13386.39761210748, 13403.731925361439, 10080.395176289447, 10569.41868197249, 10768.730781730519, 10840.078593319577, 10899.182561307935, 3285.817105841895, 3337.3825842219267, 3373.325334933023, 3398.6771256730817, 3426.931461370759, 57227.0, 57693.0, 57965.710171448874, 58166.0, 58220.708896455246, 10236.126332569522, 10396.16830653546, 10426.791464170674, 10608.946955265174, 10779.461026948622, 19356.32252871143, 19636.214551417783, 19662.0, 19690.803091969185, 19743.60512789736, 6874.175098988054, 6901.551399159039, 6944.826379340557, 7044.260352662999, 7148.070750802362, 3626.9455958160647, 3735.1782607826235, 3756.7370284079852, 3761.097336639187, 3765.7928813915496, 2883.5098033334384, 2977.5087110626937, 2991.790574659753, 2996.8052076615386, 3001.7598592113013, 479.9976000119977, 488.5944665927272, 491.33178876727624, 497.6566169343142, 498.8303976647957, 607.5261296188979, 648.282151424432, 651.5308977536166, 654.2084078265257, 654.852658151912, 7844.921550784533, 8003.39974501903, 8163.346932245406, 8260.256576908107, 8461.0, 607.9969600151971, 624.8750249950028, 625.0936142593258, 627.438442593876, 630.6342321453637, 3813.9046523836573, 3825.540935087807, 3851.1334949636666, 3905.3556163233316, 4003.199360127986, 56520.71739641276, 87959.0, 88746.0, 90078.0, 93390.53304733569, 79111.0, 82410.0, 82630.0, 82748.17251827405, 83294.58352708198, 71313.0, 73118.99999999894, 73229.0, 73259.0, 73565.0, 7718.189590092959, 7728.845423091394, 7793.2596403341595, 7825.765227043198, 7942.523448593103, 30057.098287051424, 30275.0, 30358.241043974078, 36831.07922301964, 42082.579174207865, 39921.0, 45829.31256031229, 52229.7388513055, 57023.0, 59397.406025939184, 10990.230683852054, 11170.720731981766, 11328.433578321215, 11363.886361136283, 11377.146713996317, 12039.939800300943, 12289.262644241375, 12385.318807465675, 12557.183783054072, 13076.476940922257, 11192.38441885704, 11227.157963152633, 11296.661100167008, 11323.773524529628, 11922.940385298018, 10914.945425272823, 11018.559257629926, 11140.220184587, 11213.66359009231, 11357.148213884157, 9916.801663966537, 11052.281601695864, 11107.444627768418, 11190.720231994264, 11515.424228788695, 9457.29070319715, 9774.85337719949, 9813.313068085166, 9846.064623860722, 9855.901440985499, 10349.172066234834, 10522.263441559018, 10539.578416863545, 10548.0, 10571.682849514527], "value": 6390.124920398294, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 106.0, 112.0, 114.0, 113.0, 115.0, 115.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 169.0, 187.0, 131.0, 175.0, 157.0, 133.0, 208.0, 132.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 170.0, 169.0, 163.0, 162.0, 163.0, 161.0, 163.0, 162.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 87.0, 76.0, 165.0, 76.0, 77.0, 74.0, 76.0, 176.0, 78.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 159.0, 87.0, 87.0, 87.0, 133.0, 86.0, 88.0, 152.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 120.0, 118.0, 118.0, 120.0, 118.0, 120.0, 121.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 147.0, 149.0, 150.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 71.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 89.0, 85.0, 83.0, 86.0, 83.0, 109.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 143.0, 143.0, 139.0, 150.0, 142.0, 137.0, 132.0, 140.0, 132.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 170.0, 170.0, 176.0, 170.0, 171.0, 168.0, 170.0, 175.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 70.0, 70.0, 67.0, 71.0, 68.0, 68.0, 66.0], "value": 69.0, "unit": "score"}]}]} 07:36:48 INFO - Return code: 0 07:36:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:36:48 ERROR - # TBPL SUCCESS # 07:36:48 INFO - Running post-action listener: _resource_record_post_action 07:36:48 INFO - ##### 07:36:48 INFO - ##### Finished run-tests step (success) 07:36:48 INFO - ##### 07:36:48 INFO - Running post-run listener: _resource_record_post_run 07:36:48 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 143360; Write bytes: 311033856; Read time: 48; Write time: 269800 07:36:48 INFO - TinderboxPrint: CPU usage
13.4% 07:36:48 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 48 07:36:48 INFO - TinderboxPrint: I/O write bytes / time
311,033,856 / 269,800 07:36:48 INFO - TinderboxPrint: CPU idle
8,279.7 (86.6%) 07:36:48 INFO - TinderboxPrint: CPU user
1,228.1 (12.8%) 07:36:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:36:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 17932288; Read time: 12; Write time: 10584 07:36:48 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 139264; Write bytes: 293101568; Read time: 36; Write time: 259216 07:36:48 INFO - Running post-run listener: _upload_blobber_files 07:36:48 INFO - Blob upload gear active. 07:36:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:48 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 07:36:48 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:36:48 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:36:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:36:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:36:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:49 INFO - (blobuploader) - INFO - Done attempting. 07:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:50 INFO - (blobuploader) - INFO - Done attempting. 07:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:54 INFO - (blobuploader) - INFO - Done attempting. 07:36:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:54 INFO - Return code: 0 07:36:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5faee67066b056b7599757c1ebd4fdf321480b0ac05a4f217bf7bddda9d9a2439cef7ca42cfa8de03c1f44b4a8eb5573d7e5e8f4a0e98f18e55911a6e3bb0319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/569f3dae181666bf5227fa20082fdc94ca1cca4569f7c74b32acd1987679ff7c2b1623da5fead944e68c5470999ff32311a3722f84afdf0cd31e97cc29daf2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c9ac47664c7a7de071b7bbae5c77873f5e673b0b43b8c3bd78b91fdde3c518fa7b3c1353120980d511422dc4fe4cfc22b4dd165801468f1a2eef3d2c0352a64"} 07:36:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:54 INFO - Contents: 07:36:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5faee67066b056b7599757c1ebd4fdf321480b0ac05a4f217bf7bddda9d9a2439cef7ca42cfa8de03c1f44b4a8eb5573d7e5e8f4a0e98f18e55911a6e3bb0319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/569f3dae181666bf5227fa20082fdc94ca1cca4569f7c74b32acd1987679ff7c2b1623da5fead944e68c5470999ff32311a3722f84afdf0cd31e97cc29daf2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c9ac47664c7a7de071b7bbae5c77873f5e673b0b43b8c3bd78b91fdde3c518fa7b3c1353120980d511422dc4fe4cfc22b4dd165801468f1a2eef3d2c0352a64"} 07:36:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:54 INFO - Copying logs to upload dir... 07:36:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.150880 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-23 07:36:54.384375) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 07:36:54.387760) ========= 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=920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948 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/Firefox-Non-PGO/sha512/5faee67066b056b7599757c1ebd4fdf321480b0ac05a4f217bf7bddda9d9a2439cef7ca42cfa8de03c1f44b4a8eb5573d7e5e8f4a0e98f18e55911a6e3bb0319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/569f3dae181666bf5227fa20082fdc94ca1cca4569f7c74b32acd1987679ff7c2b1623da5fead944e68c5470999ff32311a3722f84afdf0cd31e97cc29daf2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c9ac47664c7a7de071b7bbae5c77873f5e673b0b43b8c3bd78b91fdde3c518fa7b3c1353120980d511422dc4fe4cfc22b4dd165801468f1a2eef3d2c0352a64"} build_url:https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/N_vbBqUxSaqHsPWycMlA4w/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/Firefox-Non-PGO/sha512/5faee67066b056b7599757c1ebd4fdf321480b0ac05a4f217bf7bddda9d9a2439cef7ca42cfa8de03c1f44b4a8eb5573d7e5e8f4a0e98f18e55911a6e3bb0319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/569f3dae181666bf5227fa20082fdc94ca1cca4569f7c74b32acd1987679ff7c2b1623da5fead944e68c5470999ff32311a3722f84afdf0cd31e97cc29daf2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c9ac47664c7a7de071b7bbae5c77873f5e673b0b43b8c3bd78b91fdde3c518fa7b3c1353120980d511422dc4fe4cfc22b4dd165801468f1a2eef3d2c0352a64"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 07:36:54.413795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:36:54.414134) ========= 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=920470bf432669ad7e3a5387000001ca-1466690179.206651-988193948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:36:54.498579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 07:36:54.498898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 07:36:54.499227) ========= ========= Total master_lag: 0.16 =========