builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1466773436.62 results: success (0) buildid: 20160624030212 builduid: e1e27e42a3aa4aa488423fb62e197b16 revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.618786) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.619384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.619707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.635032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.635376) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 06:03:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2016-06-24 06:03:56 (23.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.756508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.757113) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:56.808860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 06:03:56.809541) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --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 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --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=934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 06:03:56,941 truncating revision to first 12 chars 2016-06-24 06:03:56,941 Setting DEBUG logging. 2016-06-24 06:03:56,941 attempt 1/10 2016-06-24 06:03:56,941 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/939ecc4e9d05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 06:03:58,384 unpacking tar archive at: mozilla-central-939ecc4e9d05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.790915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 06:03:58.615724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:58.616427) ========= script_repo_revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:58.616923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:58.617331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 06:03:58.627844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-24 06:03:58.628373) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:03:58 INFO - MultiFileLogger online at 20160624 06:03:58 in /builds/slave/test 06:03:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:03:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:03:58 INFO - {'append_to_log': False, 06:03:58 INFO - 'base_work_dir': '/builds/slave/test', 06:03:58 INFO - 'blob_upload_branch': 'Firefox', 06:03:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:03:58 INFO - 'branch': 'Firefox', 06:03:58 INFO - 'buildbot_json_path': 'buildprops.json', 06:03:58 INFO - 'config_files': ('talos/linux_config.py',), 06:03:58 INFO - 'default_actions': ('clobber', 06:03:58 INFO - 'read-buildbot-config', 06:03:58 INFO - 'download-and-extract', 06:03:58 INFO - 'populate-webroot', 06:03:58 INFO - 'create-virtualenv', 06:03:58 INFO - 'install', 06:03:58 INFO - 'run-tests'), 06:03:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:03:58 INFO - 'download_minidump_stackwalk': True, 06:03:58 INFO - 'download_symbols': 'ondemand', 06:03:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:03:58 INFO - 'tooltool.py': '/tools/tooltool.py', 06:03:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:03:58 INFO - '/tools/misc-python/virtualenv.py')}, 06:03:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:03:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:03:58 INFO - 'installer_path': 'installer.exe', 06:03:58 INFO - 'log_level': 'info', 06:03:58 INFO - 'log_name': 'talos', 06:03:58 INFO - 'log_to_console': True, 06:03:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:03:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:03:58 INFO - 'opt_config_files': (), 06:03:58 INFO - 'pip_index': False, 06:03:58 INFO - 'sps_profile': False, 06:03:58 INFO - 'sps_profile_interval': 0, 06:03:58 INFO - 'suite': 'dromaeojs-e10s', 06:03:58 INFO - 'system_bits': '32', 06:03:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:03:58 INFO - 'title': 'talos-linux64-ix-057', 06:03:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:03:58 INFO - 'use_talos_json': True, 06:03:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:03:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:03:58 INFO - 'work_dir': 'build'} 06:03:58 INFO - ##### 06:03:58 INFO - ##### Running clobber step. 06:03:58 INFO - ##### 06:03:58 INFO - Running pre-action listener: _resource_record_pre_action 06:03:58 INFO - Running main action method: clobber 06:03:58 INFO - rmtree: /builds/slave/test/build 06:03:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:03:59 INFO - Running post-action listener: _resource_record_post_action 06:03:59 INFO - ##### 06:03:59 INFO - ##### Finished clobber step (success) 06:03:59 INFO - ##### 06:03:59 INFO - ##### 06:03:59 INFO - ##### Running read-buildbot-config step. 06:03:59 INFO - ##### 06:03:59 INFO - Running pre-action listener: _resource_record_pre_action 06:03:59 INFO - Running main action method: read_buildbot_config 06:03:59 INFO - Using buildbot properties: 06:03:59 INFO - { 06:03:59 INFO - "project": "", 06:03:59 INFO - "product": "firefox", 06:03:59 INFO - "script_repo_revision": "production", 06:03:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:03:59 INFO - "repository": "", 06:03:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:03:59 INFO - "buildid": "20160624030212", 06:03:59 INFO - "stage_platform": "linux64-pgo", 06:03:59 INFO - "basedir": "/builds/slave/test", 06:03:59 INFO - "nightly_build": "True", 06:03:59 INFO - "buildnumber": 70, 06:03:59 INFO - "slavename": "talos-linux64-ix-057", 06:03:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:03:59 INFO - "platform": "ubuntu64_hw", 06:03:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:03:59 INFO - "branch": "mozilla-central", 06:03:59 INFO - "repo_path": "mozilla-central", 06:03:59 INFO - "revision": "939ecc4e9d055c263633cbe276bfb634a68fe4c5", 06:03:59 INFO - "pgo_build": "True", 06:03:59 INFO - "builduid": "e1e27e42a3aa4aa488423fb62e197b16", 06:03:59 INFO - "slavebuilddir": "test" 06:03:59 INFO - } 06:03:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:03:59 INFO - Running post-action listener: _resource_record_post_action 06:03:59 INFO - ##### 06:03:59 INFO - ##### Finished read-buildbot-config step (success) 06:03:59 INFO - ##### 06:03:59 INFO - ##### 06:03:59 INFO - ##### Running download-and-extract step. 06:03:59 INFO - ##### 06:03:59 INFO - Running pre-action listener: _resource_record_pre_action 06:03:59 INFO - Running main action method: download_and_extract 06:03:59 INFO - mkdir: /builds/slave/test/build/tests 06:03:59 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')]} 06:03:59 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:03:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:03:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:03:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:03:59 INFO - Downloaded 1361 bytes. 06:03:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:03:59 INFO - Using the following test package requirements: 06:03:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:03:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:03:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:03:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'jsshell-linux-x86_64.zip'], 06:03:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:03:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:03:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:03:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:03:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:03:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:03:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:03:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:03:59 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')]} 06:03:59 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:03:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:03:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:03:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:01 INFO - Downloaded 24277161 bytes. 06:04:01 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'] 06:04:01 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 06:04:02 INFO - Return code: 0 06:04:02 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 06:04:02 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')]} 06:04:02 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:03 INFO - Downloaded 24277161 bytes. 06:04:03 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'] 06:04:03 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 06:04:05 INFO - Return code: 0 06:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:05 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:06 INFO - Downloaded 14405518 bytes. 06:04:06 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'] 06:04:06 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 06:04:06 INFO - Return code: 0 06:04:06 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')]} 06:04:06 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:04:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:04:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:04:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/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 06:04:07 INFO - Downloaded 60154910 bytes. 06:04:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:04:07 INFO - mkdir: /builds/slave/test/properties 06:04:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:04:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:04:07 INFO - Contents: 06:04:07 INFO - build_url:https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:04:08 INFO - Running post-action listener: _resource_record_post_action 06:04:08 INFO - Running post-action listener: set_extra_try_arguments 06:04:08 INFO - ##### 06:04:08 INFO - ##### Finished download-and-extract step (success) 06:04:08 INFO - ##### 06:04:08 INFO - ##### 06:04:08 INFO - ##### Running populate-webroot step. 06:04:08 INFO - ##### 06:04:08 INFO - Running pre-action listener: _resource_record_pre_action 06:04:08 INFO - Running main action method: populate_webroot 06:04:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:04:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:04:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:04:08 INFO - '--tppagecycles', 06:04:08 INFO - '7'], 06:04:08 INFO - 'tests': ['tsvgm']}}, 06:04:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:04:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:04:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:04:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:04:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['damp', 'tps']}, 06:04:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'tests': ['damp', 'tps']}, 06:04:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['dromaeo_dom']}, 06:04:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:04:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['basic_compositor_video']}, 06:04:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:04:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['a11yr', 06:04:08 INFO - 'ts_paint', 06:04:08 INFO - 'tpaint', 06:04:08 INFO - 'sessionrestore', 06:04:08 INFO - 'sessionrestore_no_auto_restore', 06:04:08 INFO - 'tabpaint']}, 06:04:08 INFO - 'other-e10s': {'tests': ['a11yr', 06:04:08 INFO - 'ts_paint', 06:04:08 INFO - 'tpaint', 06:04:08 INFO - 'sessionrestore', 06:04:08 INFO - 'sessionrestore_no_auto_restore', 06:04:08 INFO - 'tabpaint']}, 06:04:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:04:08 INFO - 'ts_paint', 06:04:08 INFO - 'tpaint', 06:04:08 INFO - 'sessionrestore', 06:04:08 INFO - 'sessionrestore_no_auto_restore', 06:04:08 INFO - 'tabpaint']}, 06:04:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:04:08 INFO - 'ts_paint', 06:04:08 INFO - 'tpaint', 06:04:08 INFO - 'sessionrestore', 06:04:08 INFO - 'sessionrestore_no_auto_restore', 06:04:08 INFO - 'tabpaint']}, 06:04:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['a11yr', 06:04:08 INFO - 'ts_paint', 06:04:08 INFO - 'tpaint', 06:04:08 INFO - 'sessionrestore', 06:04:08 INFO - 'sessionrestore_no_auto_restore', 06:04:08 INFO - 'tabpaint']}, 06:04:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['a11yr', 06:04:08 INFO - 'ts_paint', 06:04:08 INFO - 'tpaint', 06:04:08 INFO - 'sessionrestore', 06:04:08 INFO - 'sessionrestore_no_auto_restore', 06:04:08 INFO - 'tabpaint']}, 06:04:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['tsvgx', 06:04:08 INFO - 'tsvgr_opacity', 06:04:08 INFO - 'tart', 06:04:08 INFO - 'tscrollx', 06:04:08 INFO - 'cart']}, 06:04:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:04:08 INFO - 'tsvgr_opacity', 06:04:08 INFO - 'tart', 06:04:08 INFO - 'tscrollx', 06:04:08 INFO - 'cart']}, 06:04:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'talos_options': ['--disable-e10s'], 06:04:08 INFO - 'tests': ['tp5o']}, 06:04:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'tests': ['tp5o']}, 06:04:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'talos_options': ['--disable-e10s', 06:04:08 INFO - '--xperf_path', 06:04:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:08 INFO - 'tests': ['tp5n']}, 06:04:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:08 INFO - 'talos_options': ['--xperf_path', 06:04:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:08 INFO - 'tests': ['tp5n']}}, 06:04:08 INFO - 'talos.zip': {'path': '', 06:04:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:04:08 INFO - Running post-action listener: _resource_record_post_action 06:04:08 INFO - ##### 06:04:08 INFO - ##### Finished populate-webroot step (success) 06:04:08 INFO - ##### 06:04:08 INFO - ##### 06:04:08 INFO - ##### Running create-virtualenv step. 06:04:08 INFO - ##### 06:04:08 INFO - Running pre-action listener: _resource_record_pre_action 06:04:08 INFO - Running main action method: create_virtualenv 06:04:08 INFO - Creating virtualenv /builds/slave/test/build/venv 06:04:08 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 06:04:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:04:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:04:08 INFO - Using real prefix '/usr' 06:04:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:04:09 INFO - Installing distribute.............................................................................................................................................................................................done. 06:04:11 INFO - Installing pip.................done. 06:04:11 INFO - Return code: 0 06:04:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:04:11 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')]} 06:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:11 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')]} 06:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:11 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:11 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 06:04:11 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 06:04:11 INFO - Using env: {'DISPLAY': ':0', 06:04:11 INFO - 'HOME': '/home/cltbld', 06:04:11 INFO - 'LANG': 'en_US.UTF-8', 06:04:11 INFO - 'LANGUAGE': 'en_US:en', 06:04:11 INFO - 'LOGNAME': 'cltbld', 06:04:11 INFO - 'MAIL': '/var/mail/cltbld', 06:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:11 INFO - 'MOZ_NO_REMOTE': '1', 06:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:11 INFO - 'NO_EM_RESTART': '1', 06:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:11 INFO - 'PWD': '/builds/slave/test', 06:04:11 INFO - 'SHELL': '/bin/bash', 06:04:11 INFO - 'SHLVL': '1', 06:04:11 INFO - 'TERM': 'linux', 06:04:11 INFO - 'TMOUT': '86400', 06:04:11 INFO - 'USER': 'cltbld', 06:04:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:11 INFO - '_': '/tools/buildbot/bin/python'} 06:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:11 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 06:04:11 INFO - Cleaning up... 06:04:11 INFO - Return code: 0 06:04:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:04:11 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')]} 06:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:11 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')]} 06:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:11 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:11 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 06:04:11 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 06:04:11 INFO - Using env: {'DISPLAY': ':0', 06:04:11 INFO - 'HOME': '/home/cltbld', 06:04:11 INFO - 'LANG': 'en_US.UTF-8', 06:04:11 INFO - 'LANGUAGE': 'en_US:en', 06:04:11 INFO - 'LOGNAME': 'cltbld', 06:04:11 INFO - 'MAIL': '/var/mail/cltbld', 06:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:11 INFO - 'MOZ_NO_REMOTE': '1', 06:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:11 INFO - 'NO_EM_RESTART': '1', 06:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:11 INFO - 'PWD': '/builds/slave/test', 06:04:11 INFO - 'SHELL': '/bin/bash', 06:04:11 INFO - 'SHLVL': '1', 06:04:11 INFO - 'TERM': 'linux', 06:04:11 INFO - 'TMOUT': '86400', 06:04:11 INFO - 'USER': 'cltbld', 06:04:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:11 INFO - '_': '/tools/buildbot/bin/python'} 06:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:11 INFO - Downloading/unpacking psutil>=3.1.1 06:04:11 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 06:04:11 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 06:04:11 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 06:04:11 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 06:04:11 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 06:04:11 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 06:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:04:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:13 INFO - Installing collected packages: psutil 06:04:13 INFO - Running setup.py install for psutil 06:04:13 INFO - building 'psutil._psutil_linux' extension 06:04:13 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 06:04:14 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 06:04:14 INFO - building 'psutil._psutil_posix' extension 06:04:14 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 06:04:14 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 06:04:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:14 INFO - Successfully installed psutil 06:04:14 INFO - Cleaning up... 06:04:14 INFO - Return code: 0 06:04:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:14 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:14 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 06:04:14 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 06:04:14 INFO - Using env: {'DISPLAY': ':0', 06:04:14 INFO - 'HOME': '/home/cltbld', 06:04:14 INFO - 'LANG': 'en_US.UTF-8', 06:04:14 INFO - 'LANGUAGE': 'en_US:en', 06:04:14 INFO - 'LOGNAME': 'cltbld', 06:04:14 INFO - 'MAIL': '/var/mail/cltbld', 06:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:14 INFO - 'MOZ_NO_REMOTE': '1', 06:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:14 INFO - 'NO_EM_RESTART': '1', 06:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:14 INFO - 'PWD': '/builds/slave/test', 06:04:14 INFO - 'SHELL': '/bin/bash', 06:04:14 INFO - 'SHLVL': '1', 06:04:14 INFO - 'TERM': 'linux', 06:04:14 INFO - 'TMOUT': '86400', 06:04:14 INFO - 'USER': 'cltbld', 06:04:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:14 INFO - '_': '/tools/buildbot/bin/python'} 06:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:04:16 INFO - Installing collected packages: mozsystemmonitor 06:04:16 INFO - Running setup.py install for mozsystemmonitor 06:04:16 INFO - Successfully installed mozsystemmonitor 06:04:16 INFO - Cleaning up... 06:04:16 INFO - Return code: 0 06:04:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:04:16 INFO - Using env: {'DISPLAY': ':0', 06:04:16 INFO - 'HOME': '/home/cltbld', 06:04:16 INFO - 'LANG': 'en_US.UTF-8', 06:04:16 INFO - 'LANGUAGE': 'en_US:en', 06:04:16 INFO - 'LOGNAME': 'cltbld', 06:04:16 INFO - 'MAIL': '/var/mail/cltbld', 06:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:16 INFO - 'MOZ_NO_REMOTE': '1', 06:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:16 INFO - 'NO_EM_RESTART': '1', 06:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:16 INFO - 'PWD': '/builds/slave/test', 06:04:16 INFO - 'SHELL': '/bin/bash', 06:04:16 INFO - 'SHLVL': '1', 06:04:16 INFO - 'TERM': 'linux', 06:04:16 INFO - 'TMOUT': '86400', 06:04:16 INFO - 'USER': 'cltbld', 06:04:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:16 INFO - '_': '/tools/buildbot/bin/python'} 06:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:16 INFO - Downloading/unpacking jsonschema==2.5.1 06:04:16 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 06:04:16 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 06:04:16 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 06:04:16 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 06:04:16 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 06:04:16 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 06:04:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:04:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:04:18 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 06:04:18 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 06:04:18 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 06:04:18 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 06:04:18 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 06:04:18 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 06:04:19 INFO - Downloading functools32-3.2.3-2.tar.gz 06:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:04:19 INFO - warning: no files found matching '*.txt' 06:04:19 INFO - no previously-included directories found matching 'build' 06:04:19 INFO - no previously-included directories found matching 'dist' 06:04:19 INFO - no previously-included directories found matching '.git*' 06:04:19 INFO - Installing collected packages: jsonschema, functools32 06:04:19 INFO - Running setup.py install for functools32 06:04:19 INFO - warning: no files found matching '*.txt' 06:04:19 INFO - no previously-included directories found matching 'build' 06:04:19 INFO - no previously-included directories found matching 'dist' 06:04:19 INFO - no previously-included directories found matching '.git*' 06:04:19 INFO - Successfully installed jsonschema functools32 06:04:19 INFO - Cleaning up... 06:04:19 INFO - Return code: 0 06:04:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:19 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:19 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 06:04:19 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 06:04:19 INFO - Using env: {'DISPLAY': ':0', 06:04:19 INFO - 'HOME': '/home/cltbld', 06:04:19 INFO - 'LANG': 'en_US.UTF-8', 06:04:19 INFO - 'LANGUAGE': 'en_US:en', 06:04:19 INFO - 'LOGNAME': 'cltbld', 06:04:19 INFO - 'MAIL': '/var/mail/cltbld', 06:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:19 INFO - 'MOZ_NO_REMOTE': '1', 06:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:19 INFO - 'NO_EM_RESTART': '1', 06:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:19 INFO - 'PWD': '/builds/slave/test', 06:04:19 INFO - 'SHELL': '/bin/bash', 06:04:19 INFO - 'SHLVL': '1', 06:04:19 INFO - 'TERM': 'linux', 06:04:19 INFO - 'TMOUT': '86400', 06:04:19 INFO - 'USER': 'cltbld', 06:04:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:19 INFO - '_': '/tools/buildbot/bin/python'} 06:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:19 INFO - Downloading/unpacking blobuploader==1.2.4 06:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:21 INFO - Downloading blobuploader-1.2.4.tar.gz 06:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:04:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:04:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 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 06:04:21 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 06:04:22 INFO - Downloading docopt-0.6.1.tar.gz 06:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:04:22 INFO - Installing collected packages: blobuploader, requests, docopt 06:04:22 INFO - Running setup.py install for blobuploader 06:04:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:04:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:04:22 INFO - Running setup.py install for requests 06:04:22 INFO - Running setup.py install for docopt 06:04:22 INFO - Successfully installed blobuploader requests docopt 06:04:22 INFO - Cleaning up... 06:04:22 INFO - Return code: 0 06:04:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04:22 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')]} 06:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:22 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')]} 06:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:22 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:22 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 06:04:22 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 06:04:22 INFO - Using env: {'DISPLAY': ':0', 06:04:22 INFO - 'HOME': '/home/cltbld', 06:04:22 INFO - 'LANG': 'en_US.UTF-8', 06:04:22 INFO - 'LANGUAGE': 'en_US:en', 06:04:22 INFO - 'LOGNAME': 'cltbld', 06:04:22 INFO - 'MAIL': '/var/mail/cltbld', 06:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:22 INFO - 'MOZ_NO_REMOTE': '1', 06:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:22 INFO - 'NO_EM_RESTART': '1', 06:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:22 INFO - 'PWD': '/builds/slave/test', 06:04:22 INFO - 'SHELL': '/bin/bash', 06:04:22 INFO - 'SHLVL': '1', 06:04:22 INFO - 'TERM': 'linux', 06:04:22 INFO - 'TMOUT': '86400', 06:04:22 INFO - 'USER': 'cltbld', 06:04:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:22 INFO - '_': '/tools/buildbot/bin/python'} 06:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:04:23 INFO - Running setup.py (path:/tmp/pip-QJbGL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:04:23 INFO - Running setup.py (path:/tmp/pip-FN9RSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:04:23 INFO - Running setup.py (path:/tmp/pip-IYdC2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:04:23 INFO - Running setup.py (path:/tmp/pip-Ek16tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:04:23 INFO - Running setup.py (path:/tmp/pip-VW_tRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:04:23 INFO - Running setup.py (path:/tmp/pip-31HXwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:04:23 INFO - Running setup.py (path:/tmp/pip-Stt_xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:04:23 INFO - Running setup.py (path:/tmp/pip-UJY9n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:23 INFO - Running setup.py (path:/tmp/pip-5DChNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:23 INFO - Running setup.py (path:/tmp/pip-6NhHjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:23 INFO - Running setup.py (path:/tmp/pip-5aYhC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:23 INFO - Running setup.py (path:/tmp/pip-WJByF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:23 INFO - Running setup.py (path:/tmp/pip-nTO9tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:23 INFO - Running setup.py (path:/tmp/pip-pfDJbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:24 INFO - Running setup.py (path:/tmp/pip-XuB_xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:24 INFO - Running setup.py (path:/tmp/pip-DcE9FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:24 INFO - Running setup.py (path:/tmp/pip-GjC6rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:04:24 INFO - Running setup.py install for manifestparser 06:04:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:04:24 INFO - Running setup.py install for mozcrash 06:04:24 INFO - Running setup.py install for mozdebug 06:04:24 INFO - Running setup.py install for mozdevice 06:04:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:04:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:04:24 INFO - Running setup.py install for mozfile 06:04:24 INFO - Running setup.py install for mozhttpd 06:04:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:04:24 INFO - Running setup.py install for mozinfo 06:04:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:04:24 INFO - Running setup.py install for mozInstall 06:04:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Running setup.py install for mozleak 06:04:25 INFO - Running setup.py install for mozlog 06:04:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Running setup.py install for moznetwork 06:04:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Running setup.py install for mozprocess 06:04:25 INFO - Running setup.py install for mozprofile 06:04:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Running setup.py install for mozrunner 06:04:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Running setup.py install for mozscreenshot 06:04:25 INFO - Running setup.py install for moztest 06:04:25 INFO - Running setup.py install for mozversion 06:04:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:04:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:04:25 INFO - Cleaning up... 06:04:26 INFO - Return code: 0 06:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04:26 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')]} 06:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:26 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')]} 06:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:26 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:26 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 06:04:26 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 06:04:26 INFO - Using env: {'DISPLAY': ':0', 06:04:26 INFO - 'HOME': '/home/cltbld', 06:04:26 INFO - 'LANG': 'en_US.UTF-8', 06:04:26 INFO - 'LANGUAGE': 'en_US:en', 06:04:26 INFO - 'LOGNAME': 'cltbld', 06:04:26 INFO - 'MAIL': '/var/mail/cltbld', 06:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:26 INFO - 'MOZ_NO_REMOTE': '1', 06:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:26 INFO - 'NO_EM_RESTART': '1', 06:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:26 INFO - 'PWD': '/builds/slave/test', 06:04:26 INFO - 'SHELL': '/bin/bash', 06:04:26 INFO - 'SHLVL': '1', 06:04:26 INFO - 'TERM': 'linux', 06:04:26 INFO - 'TMOUT': '86400', 06:04:26 INFO - 'USER': 'cltbld', 06:04:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:26 INFO - '_': '/tools/buildbot/bin/python'} 06:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:04:26 INFO - Running setup.py (path:/tmp/pip-oG3mTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:04:26 INFO - Running setup.py (path:/tmp/pip-GnJspQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:04:26 INFO - Running setup.py (path:/tmp/pip-GMEtxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:04:26 INFO - Running setup.py (path:/tmp/pip-A7WPf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:04:26 INFO - Running setup.py (path:/tmp/pip-qp4AZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:04:26 INFO - Running setup.py (path:/tmp/pip-VMuwpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:04:26 INFO - Running setup.py (path:/tmp/pip-Bh_xwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:04:26 INFO - Running setup.py (path:/tmp/pip-5fQ0iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:26 INFO - Running setup.py (path:/tmp/pip-K_7o2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:26 INFO - Running setup.py (path:/tmp/pip-Whij_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:26 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)) 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:26 INFO - Running setup.py (path:/tmp/pip-NlnLRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:27 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)) 06:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:27 INFO - Running setup.py (path:/tmp/pip-EWXgD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:27 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)) 06:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:27 INFO - Running setup.py (path:/tmp/pip-IHFJGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:27 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)) 06:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:27 INFO - Running setup.py (path:/tmp/pip-CIGtfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:27 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)) 06:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:27 INFO - Running setup.py (path:/tmp/pip-msfn37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:27 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)) 06:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:27 INFO - Running setup.py (path:/tmp/pip-zscvIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:27 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)) 06:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:27 INFO - Running setup.py (path:/tmp/pip-ruwexx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:27 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)) 06:04:27 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)) 06:04:27 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)) 06:04:27 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)) 06:04:27 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)) 06:04:27 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)) 06:04:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:04:27 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 06:04:27 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 06:04:27 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 06:04:27 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 06:04:27 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 06:04:27 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 06:04:29 INFO - Downloading blessings-1.6.tar.gz 06:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:04:29 INFO - Installing collected packages: blessings 06:04:29 INFO - Running setup.py install for blessings 06:04:29 INFO - Successfully installed blessings 06:04:29 INFO - Cleaning up... 06:04:29 INFO - Return code: 0 06:04:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:04:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:29 INFO - Reading from file tmpfile_stdout 06:04:29 INFO - Current package versions: 06:04:29 INFO - argparse == 1.2.1 06:04:29 INFO - blessings == 1.6 06:04:29 INFO - blobuploader == 1.2.4 06:04:29 INFO - docopt == 0.6.1 06:04:29 INFO - functools32 == 3.2.3-2 06:04:29 INFO - jsonschema == 2.5.1 06:04:29 INFO - manifestparser == 1.1 06:04:29 INFO - mozInstall == 1.12 06:04:29 INFO - mozcrash == 0.17 06:04:29 INFO - mozdebug == 0.1 06:04:29 INFO - mozdevice == 0.48 06:04:29 INFO - mozfile == 1.2 06:04:29 INFO - mozhttpd == 0.7 06:04:29 INFO - mozinfo == 0.9 06:04:29 INFO - mozleak == 0.1 06:04:29 INFO - mozlog == 3.2 06:04:29 INFO - moznetwork == 0.27 06:04:29 INFO - mozprocess == 0.22 06:04:29 INFO - mozprofile == 0.28 06:04:29 INFO - mozrunner == 6.11 06:04:29 INFO - mozscreenshot == 0.1 06:04:29 INFO - mozsystemmonitor == 0.3 06:04:29 INFO - moztest == 0.7 06:04:29 INFO - mozversion == 1.4 06:04:29 INFO - psutil == 3.1.1 06:04:29 INFO - requests == 1.2.3 06:04:29 INFO - wsgiref == 0.1.2 06:04:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:29 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:29 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 06:04:29 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 06:04:29 INFO - Using env: {'DISPLAY': ':0', 06:04:29 INFO - 'HOME': '/home/cltbld', 06:04:29 INFO - 'LANG': 'en_US.UTF-8', 06:04:29 INFO - 'LANGUAGE': 'en_US:en', 06:04:29 INFO - 'LOGNAME': 'cltbld', 06:04:29 INFO - 'MAIL': '/var/mail/cltbld', 06:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:29 INFO - 'MOZ_NO_REMOTE': '1', 06:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:29 INFO - 'NO_EM_RESTART': '1', 06:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:29 INFO - 'PWD': '/builds/slave/test', 06:04:29 INFO - 'SHELL': '/bin/bash', 06:04:29 INFO - 'SHLVL': '1', 06:04:29 INFO - 'TERM': 'linux', 06:04:29 INFO - 'TMOUT': '86400', 06:04:29 INFO - 'USER': 'cltbld', 06:04:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:29 INFO - '_': '/tools/buildbot/bin/python'} 06:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 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)) 06:04:30 INFO - Cleaning up... 06:04:30 INFO - Return code: 0 06:04:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:04:30 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')]} 06:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:30 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')]} 06:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:30 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:30 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 06:04:30 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 06:04:30 INFO - Using env: {'DISPLAY': ':0', 06:04:30 INFO - 'HOME': '/home/cltbld', 06:04:30 INFO - 'LANG': 'en_US.UTF-8', 06:04:30 INFO - 'LANGUAGE': 'en_US:en', 06:04:30 INFO - 'LOGNAME': 'cltbld', 06:04:30 INFO - 'MAIL': '/var/mail/cltbld', 06:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:30 INFO - 'MOZ_NO_REMOTE': '1', 06:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:30 INFO - 'NO_EM_RESTART': '1', 06:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:30 INFO - 'PWD': '/builds/slave/test', 06:04:30 INFO - 'SHELL': '/bin/bash', 06:04:30 INFO - 'SHLVL': '1', 06:04:30 INFO - 'TERM': 'linux', 06:04:30 INFO - 'TMOUT': '86400', 06:04:30 INFO - 'USER': 'cltbld', 06:04:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:30 INFO - '_': '/tools/buildbot/bin/python'} 06:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:04:30 INFO - Cleaning up... 06:04:30 INFO - Return code: 0 06:04:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:04:30 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')]} 06:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:30 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')]} 06:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:30 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 0x7f2353373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', '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 06:04:30 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 06:04:30 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 06:04:30 INFO - Using env: {'DISPLAY': ':0', 06:04:30 INFO - 'HOME': '/home/cltbld', 06:04:30 INFO - 'LANG': 'en_US.UTF-8', 06:04:30 INFO - 'LANGUAGE': 'en_US:en', 06:04:30 INFO - 'LOGNAME': 'cltbld', 06:04:30 INFO - 'MAIL': '/var/mail/cltbld', 06:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:30 INFO - 'MOZ_NO_REMOTE': '1', 06:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:30 INFO - 'NO_EM_RESTART': '1', 06:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:30 INFO - 'PWD': '/builds/slave/test', 06:04:30 INFO - 'SHELL': '/bin/bash', 06:04:30 INFO - 'SHLVL': '1', 06:04:30 INFO - 'TERM': 'linux', 06:04:30 INFO - 'TMOUT': '86400', 06:04:30 INFO - 'USER': 'cltbld', 06:04:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:30 INFO - '_': '/tools/buildbot/bin/python'} 06:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:30 INFO - Downloading/unpacking flake8 06:04:30 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 06:04:30 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 06:04:30 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 06:04:30 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 06:04:30 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 06:04:30 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 06:04:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:04:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:04:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:32 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 06:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:04:33 INFO - no previously-included directories found matching 'docs/_build' 06:04:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:04:33 INFO - Running setup.py install for pep8 06:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:04:33 INFO - no previously-included directories found matching 'docs/_build' 06:04:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:04:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:04:33 INFO - Cleaning up... 06:04:33 INFO - Return code: 0 06:04:33 INFO - Running post-action listener: _resource_record_post_action 06:04:33 INFO - Running post-action listener: _start_resource_monitoring 06:04:33 INFO - Starting resource monitoring. 06:04:33 INFO - ##### 06:04:33 INFO - ##### Finished create-virtualenv step (success) 06:04:33 INFO - ##### 06:04:33 INFO - ##### 06:04:33 INFO - ##### Running install step. 06:04:33 INFO - ##### 06:04:33 INFO - Running pre-action listener: _resource_record_pre_action 06:04:33 INFO - Running main action method: install 06:04:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:33 INFO - Reading from file tmpfile_stdout 06:04:33 INFO - Detecting whether we're running mozinstall >=1.0... 06:04:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:04:33 INFO - Reading from file tmpfile_stdout 06:04:33 INFO - Output received: 06:04:33 INFO - Usage: mozinstall [options] installer 06:04:33 INFO - Options: 06:04:33 INFO - -h, --help show this help message and exit 06:04:33 INFO - -d DEST, --destination=DEST 06:04:33 INFO - Directory to install application into. [default: 06:04:33 INFO - "/builds/slave/test"] 06:04:33 INFO - --app=APP Application being installed. [default: firefox] 06:04:33 INFO - mkdir: /builds/slave/test/build/application 06:04:33 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'] 06:04:33 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 06:04:50 INFO - Reading from file tmpfile_stdout 06:04:50 INFO - Output received: 06:04:50 INFO - /builds/slave/test/build/application/firefox/firefox 06:04:50 INFO - Running post-action listener: _resource_record_post_action 06:04:50 INFO - ##### 06:04:50 INFO - ##### Finished install step (success) 06:04:50 INFO - ##### 06:04:50 INFO - ##### 06:04:50 INFO - ##### Running run-tests step. 06:04:50 INFO - ##### 06:04:50 INFO - Running pre-action listener: _resource_record_pre_action 06:04:50 INFO - Running main action method: run_tests 06:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:04:50 INFO - Python 2.7.3 06:04:50 INFO - Return code: 0 06:04:50 INFO - grabbing minidump binary from tooltool 06:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:50 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 0x1330110>, '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 0x129c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129c6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:04:50 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 06:04:50 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 06:04:50 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 06:04:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:04:50 INFO - Return code: 0 06:04:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:04:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:04:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:04:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:04:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:04:51 INFO - Return code: 0 06:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 06:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 06:04:51 INFO - Using env: {'DISPLAY': ':0', 06:04:51 INFO - 'HOME': '/home/cltbld', 06:04:51 INFO - 'LANG': 'en_US.UTF-8', 06:04:51 INFO - 'LANGUAGE': 'en_US:en', 06:04:51 INFO - 'LOGNAME': 'cltbld', 06:04:51 INFO - 'MAIL': '/var/mail/cltbld', 06:04:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:04:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:51 INFO - 'MOZ_NO_REMOTE': '1', 06:04:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:51 INFO - 'NO_EM_RESTART': '1', 06:04:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:51 INFO - 'PWD': '/builds/slave/test', 06:04:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:04:51 INFO - 'SHELL': '/bin/bash', 06:04:51 INFO - 'SHLVL': '1', 06:04:51 INFO - 'TERM': 'linux', 06:04:51 INFO - 'TMOUT': '86400', 06:04:51 INFO - 'USER': 'cltbld', 06:04:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816', 06:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:51 INFO - '_': '/tools/buildbot/bin/python'} 06:04:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 06:04:51 INFO - mozversion application_buildid: 20160624030212 06:04:51 INFO - mozversion application_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 06:04:51 INFO - mozversion application_display_name: Nightly 06:04:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:04:51 INFO - mozversion application_name: Firefox 06:04:51 INFO - mozversion application_remotingname: firefox 06:04:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:04:51 INFO - mozversion application_vendor: Mozilla 06:04:51 INFO - mozversion application_version: 50.0a1 06:04:51 INFO - mozversion platform_buildid: 20160624030212 06:04:51 INFO - mozversion platform_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 06:04:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:04:51 INFO - mozversion platform_version: 50.0a1 06:04:51 INFO - using testdate: 1466773491 06:04:51 INFO - actual date: 1466773491 06:04:51 INFO - starting webserver on 'localhost:60846' 06:04:51 INFO - SUITE-START | Running 2 tests 06:04:51 INFO - TEST-START | dromaeo_css 06:04:51 INFO - operating with platform_type : linux_ 06:04:51 INFO - Initialising browser for dromaeo_css test... 06:04:51 INFO - TEST-INFO | started process 4267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZD1aY/profile http://localhost:60846/getInfo.html) 06:04:56 INFO - PROCESS | 4267 | __metrics Screen width/height:1600/1200 06:04:56 INFO - PROCESS | 4267 | colorDepth:24 06:04:56 INFO - PROCESS | 4267 | Browser inner width/height: 1024/697 06:04:56 INFO - PROCESS | 4267 | __metrics 06:04:57 ERROR - PROCESS | 4267 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:04:58 INFO - TEST-INFO | 4267: exit 0 06:04:58 INFO - Browser initialized. 06:04:58 INFO - Running cycle 1/1 for dromaeo_css test... 06:04:58 INFO - TEST-INFO | started process 4388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZD1aY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:10 INFO - PROCESS | 4388 | RSS: Main: 184745984 06:05:10 INFO - PROCESS | 4388 | 06:05:59 INFO - PROCESS | 4388 | 1466773559866 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] 06:08:07 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:60846/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60846/tests/dromaeo/cssquery-ext.html) 06:08:08 INFO - PROCESS | 4388 | RSS: Main: 188084224 06:08:08 INFO - PROCESS | 4388 | 06:11:10 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:60846/tests/dromaeo/cssquery-ext.html (next: http://localhost:60846/tests/dromaeo/cssquery-jquery.html) 06:11:11 INFO - PROCESS | 4388 | RSS: Main: 187916288 06:11:11 INFO - PROCESS | 4388 | 06:14:13 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:60846/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60846/tests/dromaeo/cssquery-mootools.html) 06:14:14 INFO - PROCESS | 4388 | RSS: Main: 188813312 06:14:14 INFO - PROCESS | 4388 | 06:17:15 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:60846/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60846/tests/dromaeo/cssquery-prototype.html) 06:17:16 INFO - PROCESS | 4388 | RSS: Main: 186585088 06:17:16 INFO - PROCESS | 4388 | 06:20:18 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:60846/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60846/tests/dromaeo/cssquery-yui.html) 06:20:19 INFO - PROCESS | 4388 | RSS: Main: 188432384 06:20:19 INFO - PROCESS | 4388 | 06:23:21 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:60846/tests/dromaeo/cssquery-yui.html (next: http://localhost:60846/tests/dromaeo/cssquery-dojo.html) 06:23:22 INFO - PROCESS | 4388 | RSS: Main: 189517824 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | __start_tp_report 06:23:22 INFO - PROCESS | 4388 | _x_x_mozilla_page_load 06:23:22 INFO - PROCESS | 4388 | _x_x_mozilla_page_load_details 06:23:22 INFO - PROCESS | 4388 | |i|pagename|runs| 06:23:22 INFO - PROCESS | 4388 | |0;dojo.html;3092.1187461573454;3139.513375426809;3143.827089510077;3153.968460315396;3158.2262345725285;5446.101393270111;5462.1260598304325;5541.5566754659585;5580.4698553637445;5608.691521966291;5495.368032676243;5507;5606.243157173781;5609.943900560993;5660.518855897243;4901.362822833027;4911.361523002005;5080.263361812535;5162.122439185328;5175.689458632494;531.4212428588085;5005.124103281929;5060.11447996601;5106.489351064883;5119.308893299412;5015.673981191248;5033.723145227011;5059.49405059493;5062.26597143414;5095.235714642815;4870.439899411542;5072;5077.949220507785;5097.541221290102;5098.439171691111;4976.178930476467;4982.377202849644;4989.525995030466;5013.423456302499;5039.596832253411;5473.28847249855;5552.805651802168;5588.972055139739;5607.074832652607;5690.772369105231;5941.435563621492;6014.2181516403025;6015.639061656315;6030.66831324277;6056.303525094627;6103.974138059492;6107.401224262661;6118.192813661917;6119.724203897816;6128.078129754063;5701.0308247598;5701.486866182064;5701.629394089371;5704.201411802351;5732.168835518868;5997.760089596454;6002.579819412599;6007.678310771623;6043.8186854394435;6246.875062498724;5936.614120082181;5953.940460595425;5959.761609535657;5970.164177015221;5984.251968503937;6067.878642427215;6069.150318955261;6081.5742897996715;6081.908771368433;6090.086487026982;5816.302043754692;5868.383819698955;5885.970570147122;5923.644581325134;5934.940650593525;5892.381299963442;5914.822555323347;5935.287765468085;5947.821565353046;6038.426349496791;4536.818527258939;4548.363229147922;4555.589996900295;4571.040081582905;4599.4710608280475;3987.4018897165656;4023.939640905389;4035.8385664573675;4051.7771126132284;4100.671946244293;5672.886542269214;5691.032524470767;5701.971490142523;5709.914351284734;5749.712514374348;5908.793192238251;5958.940410595838;5964.433378829091;5968.761249550056;5970.9701451492465;5551.805686800943;5720.799772007959;5728.026235539968;5729.054705973468;5731.398203188689;5157.793688252503;5163.380394352702;5170.250313704491;5192.688438693691;5206.687598744087;6265.060240963892;6272.247330320391;6275.058741188858;6282.089097080898;6291.842703932347;5887.087501437284;5958.106284057253;6000.819975400745;6033.87932241344;6040.7583696651645;6183.536234782499;6212.335169752679;6250.1874756281395;6256.280527739368;6261.937380626136;5903.439173278532;5919.260092488439;5921.437463440966;5922.318933322723;5943.58394912352;5775.566832487496;6018.699065046818;6044;6065.211522502046;6090.665013424127;5850.882982340415;5854.151148083589;5867.853303667443;5874.206982057539;5919.171316015675;5677.829665110054;5863;5873.853153671022;5880.029795083763;5880.206172166874;5604;5643.71781410936;5650.63270887391;5658.660480371191;5706.258186435903;5745.683987380567;5770.711464426846;5775.422457754191;5803.680797556175;5813.883722325614;5492.890142197054;5685.800996965087;5694.515966142924;5696.259486266758;5717.599768016199 06:23:22 INFO - PROCESS | 4388 | |1;ext.html;583.8423625621083;616.2143267334145;627.2379059442776;631.2046821005533;649.0005391696785;41913;43005.56994430059;43066.7846660767;43381.78309108458;47109;45015.77492112535;45649.7717511412;45900.770496147474;45958.310625340644;46129;8955.820883582324;9062.365634405594;9081.909180908206;9106.544672766368;9120.817583648322;8950.373473856833;9020.323475739313;9032.367734258605;9033.864492032624;9053.456792592433;9004.639814407416;9043.186113249807;9078.364514483988;9106.954465227665;9129.315301352392;8885.955570222171;9020.548972551345;9024.097590240988;9055.59249833759;9064;8889.555522223864;8931.330150238693;8963.641454341818;8965.820683586357;8990.820183596357;43412.78293608543;43666;43700;43735.562644373786;43852.780736096116;3731.7574357666663;4147.199171157868;4176.958230417687;4208.431861698662;4337.327714204303;30223.244418889484;33852.83073584616;33991.4901276481;34077.31845363104;35009.29981400383;4414.779261036935;4448.755318457484;4464.8883777905485;4561.6806823522365;4658.627309815207;328808;329210;332226.33886830654;332343;333117;34510.82744586261;35251;35335.293294133975;37291.4406283906;59103.11345329823;37064.258714825555;37465;37523.81238093792;37603.247935041145;37763;14944.70110597782;14987.32557034936;15031.323590438456;15051.021683590532;15135.848641513665;11963.102767292488;12054.095942804324;12072.758544829054;12078.818817717742;12080.214786039056;8378.455400398954;8431.95784021076;8437.789055273668;8457.703980360659;8551.102134275812;3274.5579346788354;3281.8851340203455;3294.1764558860286;3349.882754103595;3352.6144493383085;960.1982344742079;973.3381300715581;1004.6282875336173;1131.8075927092414;1167.486306025346;31819.681803182135;32035.359292814013;32257.51613725796;32432.83783581067;32889.3422131556;1115.4088333183427;1117.8323251512174;1132.53000004997;1148.3224897310627;1194.964151075469;16874.493765187064;16947.067911265;16981.320747169975;17040.914795425942;17078.402255920984;544308;548743;550397;551863;553995;60254;60733.69633151894;60903.69548152231;60976.085358719654;61003.38996610066;1225.2281062930474;1330.0822432521722;1364.9658758530918;1366.5012270521188;1367.2548461088732;30856.845715772175;30866.826634673605;31057.68942310548;31677;32199.356012879143;53253.201201981225;53415.73292133515;53427;53607.46392536024;53748.19377709416;465276;474334;475409;475454;477042;28354.574681380207;28773.56839647449;28839;28857.278568035967;28931.566026509197;48091.55725328246;49405.50594494153;49702.502974969786;50313;50439.49560504348;40543.391849122876;41316;41368.1726365465;42013.159736805705;42857.57142428536;41313.1737365257;41493.170136597706;42406;42488.57511424846;42753;40046.799766000986;40144.79927600343;40685;41107.177856442104;43897.56102439063;35698.46452303165;37818.62181378261;37831.43252851265;38195.04512387213;38518.42222366611;27579.44841103207;28325.150245492667;28414;28500.714992849807;28622 06:23:22 INFO - PROCESS | 4388 | |2;jquery.html;379.5199073172436;380.3093116202864;383.35213489203244;392.83304595546906;395.00655850535924;17562.47312580623;19498;19974.201031958703;20239.190432382704;20559;18189.272429102853;18569.628607427876;18670.53323666909;18718.157682904268;18873.15070821813;5430.647007944471;5506.311711036121;5625.46558076982;5629.7185140743;5752.36723960364;5551.306086739158;5604;5660.5471562275125;5670.631408958405;5677.403872593381;5596.524295434893;5600.019996500617;5617;5633.126865335879;5687.431256874321;5489.64317319375;5543.722813859331;5557.916631250535;5613.298337707786;5646.463585959327;4846.103470857867;4978.87552811179;4996.225585034325;5015.874603134915;5031.018951304497;22503;22546.774532254796;22849.200277990356;22879.65680514777;23135.305940821803;2325.4651430171157;2334.8832558372183;2347.9060837566476;2408.0969636386353;2484.093305943336;14422.495212667507;14445.92777036108;14572.198529080897;14576.198309092995;14652.560423187322;1930.276146445083;1933.5649478867142;1942.1939894943582;1957.9608407831763;2035.084212104559;76854.61572692101;78148.60925695335;79658.60170699109;79670;80131;10111.848322275171;10137.543810528545;10506.212034097472;10925.125989920787;11312.434378281054;14198.432062717582;14256.928715356564;14286.428542858377;14289.214093224764;14343.211123388106;7904.644291006918;7998.280154786097;8202.138775428613;8211.630476628447;8282.751517454486;7629.122650895107;7739.34215591681;7891.083076124058;7937.563434011185;8111.229433203836;6502.089707440962;6561.9500879859;6568.113304703899;6581.670916454158;6589.209294884645;1851.6389304085574;1893.611809579033;1915.348781414298;1916.2622390379804;1925.6245032218583;950.3490109275168;958.4105774948357;977.2475194100645;977.4282045003611;1021.6168936648756;19042.619147617246;19531.90234048849;19611.117499712545;19828.801711982695;19837.702434463496;974.7855471796194;987.1707765477033;992.2558081438921;1012.9341592796445;1061.580675633136;10763.408012559228;11201.495932683049;11245.325280483197;11289.830652540219;11328;373878.6530336709;376310;378504;499229;505721;97715.51142244243;102797;104723.4763826176;105357.47321263344;106057.46971265248;909.8999110097884;967.274544091931;976.7997560500222;980.6861804222581;984.2224642532319;16264.268107934935;17118.657626847144;17255.7411638823;17413.47759567215;17897;33327.166820829676;39243.80378098205;43217.567824322614;44513.554864452235;45729.771351143034;58818.7059064702;59651.40348596632;59957.40042599518;60881.39118608934;60885.69557152186;7804.9609751950875;8144.30773384269;8221.424500285162;8336.273072814352;8560.700375486827;13396.531121410704;13957.930210348883;13981.091229070078;14154.929225353808;14162.858371416154;11617.419129043345;11766.294022358687;11794.823077653671;12229.93885030569;12550;12128.757424851277;12256.816147757969;12276.202046866925;12316.568920087753;12443.44004519817;12185.268883866996;12276.508939642314;12323.753524929272;12400.937995309965;12663.683407914506;7339;7767.72812951544;8045.517268963881;8087.433879628605;8169.0605580359015;8649.956750216208;11236;11349.262297950607;12021.398930053638;12164.2701437914 06:23:22 INFO - PROCESS | 4388 | |3;mootools.html;1430.6494908747359;1457.7813328000798;1553.3398305720066;1701.7192163293057;1708.743688446732;7829.334506566935;8586.227239548454;8684;9279.582418791153;9324;8653.048164701877;8804.20762131408;8804.943406791193;8932.196102350787;8950.194482496574;2324.651302304655;2356.516914032628;2389.0443822471066;2394.9760502395015;2396.4128788446856;2312.063614236237;2337.474068334628;2362.763723627632;2363.361892289081;2377.7146742390937;2326.232343326698;2336.3224664847176;2346.9061237550477;2349.9765002349927;2371.27676058802;2313.5257272259146;2323.8954247058837;2326.7440581536016;2328.895199716017;2356.2931120663734;2259.943501412478;2272.6704627829035;2288.8397812153157;2325.2907863101746;2342.6251799712136;9055.954720226422;9071.183593476553;9095.090490950852;9116.316276279305;9127.5436228189;5138.58891288696;5143.665661732013;5277.604179686539;5289.682619042831;5293.444188360205;3338.4825352070466;3399.5240666306736;3442.3287458945515;3503.4744788281705;3515.6308587598446;1123.2530367305733;1141.8401423800674;1142.1662186603826;1179.1038810503992;1184.7748927703708;12425.813612795815;12560;12566.30885301308;12571.120021598492;12614.243145411305;4618.976905115453;4693.06138772247;4761.47623761386;4767.261074533453;4767.976160119178;10551.525181366856;10557.894421055844;10627.415492147851;10640.201984851166;10666.893331066745;5188.662736922088;5219.895602087937;5237.319148510669;5245.423003469616;5318.760655770499;4315.525292217853;4623.930641040387;4759.214729569651;4791.089692958327;4866.343043689057;3974.7018973577096;4001.3397789365013;4085.816138273785;4097.85657501986;4098.262312783728;1229.883161099694;1237.7400745843474;1241.1746188784539;1249.331607589935;1254.6988722706485;782.1318336646318;875.0680525240598;885.4465958775766;901.5852707754375;925.4031149908271;6123.938760612336;6280.685965701697;6288.213973253343;6326.841828954313;6417.711202995876;926.5830376330678;947.4599478297305;974.171953839231;975.0103644800533;995.2286977592424;4193.601607847249;4321.114171594815;4321.719088259253;4357.477102747627;4415.249407600716;11047.392393418279;11376.94311528437;11389.373584452935;11397.430128493543;11469.88530114705;11285.322880627189;11311.60409385684;11371.147163962736;11372.48823802931;11390.658280251606;8086.312663423557;8272.759086137008;8456.66173353059;8580.871286930702;8615.78460538504;6108.144859719731;6319.873602528016;6442.871142577216;6484.157059582224;6509.609423434609;10497.947510262706;10624.309419887682;10632.202584806017;10657.626983055556;10762.246642735246;10233.232507562112;10446.373217606968;10792.514336854703;10888.346699198073;10943.726406839893;7176;7489;7680.231976802275;7883.960580197062;8079.232472915063;8462.915370846213;8479.406441549032;8508.957455212932;8521.573921303787;8581.742547723577;7688.615569221628;7878.448508604342;7980.201979801974;8081.959590202011;8087.3125784308995;7528.811779705551;7605.32682809781;7634.541927484369;7759;7764.883526747216;7036.401905838061;7090.893636595559;7103.218645949045;7121.181064177686;7148.535345202546;4974.303597496426;4995.725235112103;5146.099432599355;5199.324087868704;5205.92191117126;5124.538791508782;5154.639175257846;5164.612654050886;5193.039287731782;5214.139666955061 06:23:22 INFO - PROCESS | 4388 | |4;prototype.html;328.6729703944577;332.48962842037474;334.3697130908239;339.9354122716684;343.4059077795412;5476.3702174249975;5620.257720106764;5668.659880407174;5740.282464691913;5763.5389168866495;5527.143292789624;5545.390007099216;5593.74828132734;5638.267025286707;5649.46330098641;4329.870103896888;4363.672724545671;4365.934510982338;4392.428984232045;4427.77861106945;4050.7772072536;4052.7031349968024;4287.1425714857;4295.140971805651;4300.3334483155;4242.766647834368;4259.5740425957465;4268.743875367472;4271.8718438446895;4282.100758840632;4273.978630106845;4289.892752681177;4311.749592618137;4324;4326.480822301312;3694.4643026761237;3729.5524537055458;3738.12154143776;3818.770873747584;3855.9807200964096;5464.972675136639;5471.343438787331;5485.588580856412;5486.149646804752;5497.147942068986;4850.054239423313;4870.366852309213;4874.341963834872;4880.657819099741;4925.26121081837;5560.582956278255;5766.798162064308;5813.779106387664;5815.767369305223;5856.882862342772;4077.2864748668862;4095.1195492968855;4098.938515922264;4112.362583799486;4133.359329303963;5723.885522289573;5863.149843272787;6003.819885403401;6027.849303767397;6036.879262414727;4198.790060497024;4216.873493795191;4221.767802770815;4229.936550951738;4272.700910936267;4254.893627659271;4270.10327831159;4271.124419493996;4285.5928686774705;4287.506936702257;4676.906461870743;4914.729689867092;4939.752412652235;4970.602351811846;4972.353594032753;5856.209411729447;5871.383504732027;5884;5893.381194974551;5897.380775018647;1471.5438214153646;1491.8582734640192;1494.5054945054944;1497.1241823533137;1501.992490037543;907.3693782821008;948.4119845695712;959.2182371367313;963.54023654164;969.7187815533557;4955.4548999610015;5047.848564543069;5053.620978426559;5069.467705890902;5122.745991763612;5241.292425522505;5261.947380526222;5280.9207861882105;5283.577313814885;5330.38700549434;5016.673916195436;5049.358958338555;5072.315237442898;5293.523582877559;5780.653160810365;3208.6630903755236;3215.871365145368;3220.373711275791;3243.6431992480807;3248.3828072666593;6061.242344706911;6284.340144284875;6298;6303.7793677222;6350.237971443364;6066.545009124245;6130.264368275835;6138.066509049635;6144.8771024579255;6161.229846269216;6119.510439164945;6160.784372546939;6176.8764624707255;6210.9068363974575;6247.344028876993;5680.346760122638;5986.431289027535;6010.248718910137;6037.339731573852;6066.120412540069;5959.791407300723;5965.403459654;5972.283326000734;5987.6108052976415;5989;6066.3023752269055;6136.386361363828;6216.027178257285;6266.780662676784;6290.842728931813;4236.830526779017;4277.871663850089;4285.764282964342;4287.614114729689;4300.763458009715;5759.971200143972;6067.757289708539;6094.329623741296;6095.695215239309;6113.877722445615;5859.296884373732;5880.852978675567;5888.205092312483;5891.941080589139;5918.733656985532;5852.561057920588;5881.38245484218;5888.234529511136;5890.14592884038;5902.7343769531335;5562.415946325577;5740.598158128891;5749.741261643152;5773.364929857628;5784.768609255582;5808.709564521672;5872.794452194153;5880.206172166702;5929.154006077021;5949.52403807703;5504.779808807602;5732.971335143297;5762.798302059407;5773.797917072882;5802.912956305574 06:23:22 INFO - PROCESS | 4388 | |5;yui.html;725.6480606905653;767.209773932849;790.6244533846422;819.1194465949104;832.0763952013268;15432.151231682254;16507;16576.336946522155;16619.83380166198;16695.747818913584;15171.089734615904;15358.846411535882;15367.308471118798;15385.384584616602;15418.152001639904;633.4299130782298;758.6965213914451;781.847539729753;785.2187073861516;788.1724189600925;758.370552441475;765.1392183793232;765.1506827421557;766.2337662337662;768.8961990131345;817.9672813087469;824.8597738384459;828.7555171224473;830.0993422136988;833.8624127019035;811.813282944923;817.9550124743137;822.8847961285425;824.4146655874337;826.6734639817298;591.9704014799242;597.0208857473747;597.8505373656586;600.1477901380007;602.6203491800181;14775.556733298019;14852.33164507589;14900.552983410515;14988.850111498854;15030;14246.928765356211;15168.696626067527;15439.845601543953;15610.297536610766;15682.294296756674;11786.882131178665;11858.881411185865;12357.814632780515;12450;12870.227786332756;4626.953730462686;4641.3270075839155;4671.579557839811;4687.437507499088;4705.929411058837;76481.23518764797;77776;78133.82799258073;79103.6044819778;79319;11154.05908199954;11354.432278386048;11403.144764142722;11518.827217591743;11743.706407339885;19803.504912377306;20509.2821751238;20537.48656283605;20549.280775173098;20591.691124633144;8598.656053757904;8971.010512122728;9072.50101244438;9094.954525227331;9161.816763664823;4804.279358096313;4806.95193048072;4863.392075990501;4878.463369029404;5041.8487445376695;3869.690424766012;3974.7217694761666;4002.399640053957;4020.8793736187963;4021.5174179098112;658.8484648530865;663.6482664187988;668.3216535216759;668.358375959075;680.7413182990432;631.9747210111636;691.3639451704444;731.5098883747902;762.2606072110044;783.169839969634;10079.445630490247;10185.898141018495;10191.54138063789;10316.638917637996;10370.637027703995;738.346563291491;744.5681504727245;748.7716246544857;749.7863109013905;777.8288776469168;4963.5780958618925;4974.850754477371;4992.90014199714;4995.925061124086;5075.086484432837;109351.34540582083;110159;110337;110531.44734276277;114437;98615;100075;100194;101248;103233.48383258036;62753.372466275665;86671.56664216639;89784;91106.54446727857;92692.53653731688;9344.543188414496;9428.245740340619;9458.148766611039;9535.666251681158;9750.073742994404;51257.2059977899;51296;51422.97154056973;52732.47267527276;53483.46516534785;73315.26684733084;75556.62221688856;77388.6130569366;77405;77924;12197.878021220029;12343.75312493763;12532.37338133108;13462.461501539829;13536.323183840965;14904.403823846924;15143.848561514244;15274.465393711167;15944;16157.919210403872;14442.350094245574;14491.637709057359;14508.637284067561;14854.702905942037;15012.774808377664;13690.452381904612;14019.50931717385;14623.268836558342;14627.92686036563;14723.116613003254;13749.243791591558;14292.85707142957;14411.42354305816;14582;14863.479778207711;11305;11746.70633234176;12280.447379867748;12440.576427283271;12749.745005100032;10594.576216951236;11133.387663678575;11210.49552770111;11368.54525818958;11692.649220523057 06:23:22 INFO - PROCESS | 4388 | __end_tp_report 06:23:22 INFO - PROCESS | 4388 | __start_cc_report 06:23:22 INFO - PROCESS | 4388 | _x_x_mozilla_cycle_collect,334 06:23:22 INFO - PROCESS | 4388 | __end_cc_report 06:23:22 INFO - PROCESS | 4388 | __startTimestamp1466774602006__endTimestamp 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | ------- Summary: start ------- 06:23:22 INFO - PROCESS | 4388 | Number of tests: 6 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | [#0] dojo.html Cycles:165 Average:5522.55 Median:5729.05 stddev:762.96 (13.3%) stddev-sans-first:741.09 06:23:22 INFO - PROCESS | 4388 | Values: 3092.1 3139.5 3143.8 3154.0 3158.2 5446.1 5462.1 5541.6 5580.5 5608.7 5495.4 5507.0 5606.2 5609.9 5660.5 4901.4 4911.4 5080.3 5162.1 5175.7 531.4 5005.1 5060.1 5106.5 5119.3 5015.7 5033.7 5059.5 5062.3 5095.2 4870.4 5072.0 5077.9 5097.5 5098.4 4976.2 4982.4 4989.5 5013.4 5039.6 5473.3 5552.8 5589.0 5607.1 5690.8 5941.4 6014.2 6015.6 6030.7 6056.3 6104.0 6107.4 6118.2 6119.7 6128.1 5701.0 5701.5 5701.6 5704.2 5732.2 5997.8 6002.6 6007.7 6043.8 6246.9 5936.6 5953.9 5959.8 5970.2 5984.3 6067.9 6069.2 6081.6 6081.9 6090.1 5816.3 5868.4 5886.0 5923.6 5934.9 5892.4 5914.8 5935.3 5947.8 6038.4 4536.8 4548.4 4555.6 4571.0 4599.5 3987.4 4023.9 4035.8 4051.8 4100.7 5672.9 5691.0 5702.0 5709.9 5749.7 5908.8 5958.9 5964.4 5968.8 5971.0 5551.8 5720.8 5728.0 5729.1 5731.4 5157.8 5163.4 5170.3 5192.7 5206.7 6265.1 6272.2 6275.1 6282.1 6291.8 5887.1 5958.1 6000.8 6033.9 6040.8 6183.5 6212.3 6250.2 6256.3 6261.9 5903.4 5919.3 5921.4 5922.3 5943.6 5775.6 6018.7 6044.0 6065.2 6090.7 5850.9 5854.2 5867.9 5874.2 5919.2 5677.8 5863.0 5873.9 5880.0 5880.2 5604.0 5643.7 5650.6 5658.7 5706.3 5745.7 5770.7 5775.4 5803.7 5813.9 5492.9 5685.8 5694.5 5696.3 5717.6 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | [#1] ext.html Cycles:180 Average:59987.27 Median:23110.80 stddev:122510.78 (530.1%) stddev-sans-first:122773.27 06:23:22 INFO - PROCESS | 4388 | Values: 583.8 616.2 627.2 631.2 649.0 41913.0 43005.6 43066.8 43381.8 47109.0 45015.8 45649.8 45900.8 45958.3 46129.0 8955.8 9062.4 9081.9 9106.5 9120.8 8950.4 9020.3 9032.4 9033.9 9053.5 9004.6 9043.2 9078.4 9107.0 9129.3 8886.0 9020.5 9024.1 9055.6 9064.0 8889.6 8931.3 8963.6 8965.8 8990.8 43412.8 43666.0 43700.0 43735.6 43852.8 3731.8 4147.2 4177.0 4208.4 4337.3 30223.2 33852.8 33991.5 34077.3 35009.3 4414.8 4448.8 4464.9 4561.7 4658.6 328808.0 329210.0 332226.3 332343.0 333117.0 34510.8 35251.0 35335.3 37291.4 59103.1 37064.3 37465.0 37523.8 37603.2 37763.0 14944.7 14987.3 15031.3 15051.0 15135.8 11963.1 12054.1 12072.8 12078.8 12080.2 8378.5 8432.0 8437.8 8457.7 8551.1 3274.6 3281.9 3294.2 3349.9 3352.6 960.2 973.3 1004.6 1131.8 1167.5 31819.7 32035.4 32257.5 32432.8 32889.3 1115.4 1117.8 1132.5 1148.3 1195.0 16874.5 16947.1 16981.3 17040.9 17078.4 544308.0 548743.0 550397.0 551863.0 553995.0 60254.0 60733.7 60903.7 60976.1 61003.4 1225.2 1330.1 1365.0 1366.5 1367.3 30856.8 30866.8 31057.7 31677.0 32199.4 53253.2 53415.7 53427.0 53607.5 53748.2 465276.0 474334.0 475409.0 475454.0 477042.0 28354.6 28773.6 28839.0 28857.3 28931.6 48091.6 49405.5 49702.5 50313.0 50439.5 40543.4 41316.0 41368.2 42013.2 42857.6 41313.2 41493.2 42406.0 42488.6 42753.0 40046.8 40144.8 40685.0 41107.2 43897.6 35698.5 37818.6 37831.4 38195.0 38518.4 27579.4 28325.2 28414.0 28500.7 28622.0 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | [#2] jquery.html Cycles:180 Average:27659.64 Median:17905.63 stddev:71776.32 (400.9%) stddev-sans-first:71948.44 06:23:22 INFO - PROCESS | 4388 | Values: 379.5 380.3 383.4 392.8 395.0 17562.5 19498.0 19974.2 20239.2 20559.0 18189.3 18569.6 18670.5 18718.2 18873.2 5430.6 5506.3 5625.5 5629.7 5752.4 5551.3 5604.0 5660.5 5670.6 5677.4 5596.5 5600.0 5617.0 5633.1 5687.4 5489.6 5543.7 5557.9 5613.3 5646.5 4846.1 4978.9 4996.2 5015.9 5031.0 22503.0 22546.8 22849.2 22879.7 23135.3 2325.5 2334.9 2347.9 2408.1 2484.1 14422.5 14445.9 14572.2 14576.2 14652.6 1930.3 1933.6 1942.2 1958.0 2035.1 76854.6 78148.6 79658.6 79670.0 80131.0 10111.8 10137.5 10506.2 10925.1 11312.4 14198.4 14256.9 14286.4 14289.2 14343.2 7904.6 7998.3 8202.1 8211.6 8282.8 7629.1 7739.3 7891.1 7937.6 8111.2 6502.1 6562.0 6568.1 6581.7 6589.2 1851.6 1893.6 1915.3 1916.3 1925.6 950.3 958.4 977.2 977.4 1021.6 19042.6 19531.9 19611.1 19828.8 19837.7 974.8 987.2 992.3 1012.9 1061.6 10763.4 11201.5 11245.3 11289.8 11328.0 373878.7 376310.0 378504.0 499229.0 505721.0 97715.5 102797.0 104723.5 105357.5 106057.5 909.9 967.3 976.8 980.7 984.2 16264.3 17118.7 17255.7 17413.5 17897.0 33327.2 39243.8 43217.6 44513.6 45729.8 58818.7 59651.4 59957.4 60881.4 60885.7 7805.0 8144.3 8221.4 8336.3 8560.7 13396.5 13957.9 13981.1 14154.9 14162.9 11617.4 11766.3 11794.8 12229.9 12550.0 12128.8 12256.8 12276.2 12316.6 12443.4 12185.3 12276.5 12323.8 12400.9 12663.7 7339.0 7767.7 8045.5 8087.4 8169.1 8650.0 11236.0 11349.3 12021.4 12164.3 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | [#3] mootools.html Cycles:180 Average:5921.88 Median:4764.37 stddev:3410.28 (71.6%) stddev-sans-first:3403.15 06:23:22 INFO - PROCESS | 4388 | Values: 1430.6 1457.8 1553.3 1701.7 1708.7 7829.3 8586.2 8684.0 9279.6 9324.0 8653.0 8804.2 8804.9 8932.2 8950.2 2324.7 2356.5 2389.0 2395.0 2396.4 2312.1 2337.5 2362.8 2363.4 2377.7 2326.2 2336.3 2346.9 2350.0 2371.3 2313.5 2323.9 2326.7 2328.9 2356.3 2259.9 2272.7 2288.8 2325.3 2342.6 9056.0 9071.2 9095.1 9116.3 9127.5 5138.6 5143.7 5277.6 5289.7 5293.4 3338.5 3399.5 3442.3 3503.5 3515.6 1123.3 1141.8 1142.2 1179.1 1184.8 12425.8 12560.0 12566.3 12571.1 12614.2 4619.0 4693.1 4761.5 4767.3 4768.0 10551.5 10557.9 10627.4 10640.2 10666.9 5188.7 5219.9 5237.3 5245.4 5318.8 4315.5 4623.9 4759.2 4791.1 4866.3 3974.7 4001.3 4085.8 4097.9 4098.3 1229.9 1237.7 1241.2 1249.3 1254.7 782.1 875.1 885.4 901.6 925.4 6123.9 6280.7 6288.2 6326.8 6417.7 926.6 947.5 974.2 975.0 995.2 4193.6 4321.1 4321.7 4357.5 4415.2 11047.4 11376.9 11389.4 11397.4 11469.9 11285.3 11311.6 11371.1 11372.5 11390.7 8086.3 8272.8 8456.7 8580.9 8615.8 6108.1 6319.9 6442.9 6484.2 6509.6 10497.9 10624.3 10632.2 10657.6 10762.2 10233.2 10446.4 10792.5 10888.3 10943.7 7176.0 7489.0 7680.2 7884.0 8079.2 8462.9 8479.4 8509.0 8521.6 8581.7 7688.6 7878.4 7980.2 8082.0 8087.3 7528.8 7605.3 7634.5 7759.0 7764.9 7036.4 7090.9 7103.2 7121.2 7148.5 4974.3 4995.7 5146.1 5199.3 5205.9 5124.5 5154.6 5164.6 5193.0 5214.1 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | [#4] prototype.html Cycles:180 Average:4868.47 Median:5515.96 stddev:1443.98 (26.2%) stddev-sans-first:1407.25 06:23:22 INFO - PROCESS | 4388 | Values: 328.7 332.5 334.4 339.9 343.4 5476.4 5620.3 5668.7 5740.3 5763.5 5527.1 5545.4 5593.7 5638.3 5649.5 4329.9 4363.7 4365.9 4392.4 4427.8 4050.8 4052.7 4287.1 4295.1 4300.3 4242.8 4259.6 4268.7 4271.9 4282.1 4274.0 4289.9 4311.7 4324.0 4326.5 3694.5 3729.6 3738.1 3818.8 3856.0 5465.0 5471.3 5485.6 5486.1 5497.1 4850.1 4870.4 4874.3 4880.7 4925.3 5560.6 5766.8 5813.8 5815.8 5856.9 4077.3 4095.1 4098.9 4112.4 4133.4 5723.9 5863.1 6003.8 6027.8 6036.9 4198.8 4216.9 4221.8 4229.9 4272.7 4254.9 4270.1 4271.1 4285.6 4287.5 4676.9 4914.7 4939.8 4970.6 4972.4 5856.2 5871.4 5884.0 5893.4 5897.4 1471.5 1491.9 1494.5 1497.1 1502.0 907.4 948.4 959.2 963.5 969.7 4955.5 5047.8 5053.6 5069.5 5122.7 5241.3 5261.9 5280.9 5283.6 5330.4 5016.7 5049.4 5072.3 5293.5 5780.7 3208.7 3215.9 3220.4 3243.6 3248.4 6061.2 6284.3 6298.0 6303.8 6350.2 6066.5 6130.3 6138.1 6144.9 6161.2 6119.5 6160.8 6176.9 6210.9 6247.3 5680.3 5986.4 6010.2 6037.3 6066.1 5959.8 5965.4 5972.3 5987.6 5989.0 6066.3 6136.4 6216.0 6266.8 6290.8 4236.8 4277.9 4285.8 4287.6 4300.8 5760.0 6067.8 6094.3 6095.7 6113.9 5859.3 5880.9 5888.2 5891.9 5918.7 5852.6 5881.4 5888.2 5890.1 5902.7 5562.4 5740.6 5749.7 5773.4 5784.8 5808.7 5872.8 5880.2 5929.2 5949.5 5504.8 5733.0 5762.8 5773.8 5802.9 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - PROCESS | 4388 | [#5] yui.html Cycles:180 Average:21044.60 Median:4656.45 stddev:29787.10 (639.7%) stddev-sans-first:29831.59 06:23:22 INFO - PROCESS | 4388 | Values: 725.6 767.2 790.6 819.1 832.1 15432.2 16507.0 16576.3 16619.8 16695.7 15171.1 15358.8 15367.3 15385.4 15418.2 633.4 758.7 781.8 785.2 788.2 758.4 765.1 765.2 766.2 768.9 818.0 824.9 828.8 830.1 833.9 811.8 818.0 822.9 824.4 826.7 592.0 597.0 597.9 600.1 602.6 14775.6 14852.3 14900.6 14988.9 15030.0 14246.9 15168.7 15439.8 15610.3 15682.3 11786.9 11858.9 12357.8 12450.0 12870.2 4627.0 4641.3 4671.6 4687.4 4705.9 76481.2 77776.0 78133.8 79103.6 79319.0 11154.1 11354.4 11403.1 11518.8 11743.7 19803.5 20509.3 20537.5 20549.3 20591.7 8598.7 8971.0 9072.5 9095.0 9161.8 4804.3 4807.0 4863.4 4878.5 5041.8 3869.7 3974.7 4002.4 4020.9 4021.5 658.8 663.6 668.3 668.4 680.7 632.0 691.4 731.5 762.3 783.2 10079.4 10185.9 10191.5 10316.6 10370.6 738.3 744.6 748.8 749.8 777.8 4963.6 4974.9 4992.9 4995.9 5075.1 109351.3 110159.0 110337.0 110531.4 114437.0 98615.0 100075.0 100194.0 101248.0 103233.5 62753.4 86671.6 89784.0 91106.5 92692.5 9344.5 9428.2 9458.1 9535.7 9750.1 51257.2 51296.0 51423.0 52732.5 53483.5 73315.3 75556.6 77388.6 77405.0 77924.0 12197.9 12343.8 12532.4 13462.5 13536.3 14904.4 15143.8 15274.5 15944.0 16157.9 14442.4 14491.6 14508.6 14854.7 15012.8 13690.5 14019.5 14623.3 14627.9 14723.1 13749.2 14292.9 14411.4 14582.0 14863.5 11305.0 11746.7 12280.4 12440.6 12749.7 10594.6 11133.4 11210.5 11368.5 11692.6 06:23:22 INFO - PROCESS | 4388 | -------- Summary: end -------- 06:23:22 INFO - PROCESS | 4388 | 06:23:22 INFO - TEST-INFO | 4388: exit 0 06:23:22 INFO - TEST-OK | dromaeo_css | took 1110809ms 06:23:22 INFO - TEST-START | kraken 06:23:22 INFO - operating with platform_type : linux_ 06:23:22 INFO - Initialising browser for kraken test... 06:23:22 INFO - TEST-INFO | started process 4627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxP6ppJ/profile http://localhost:60846/getInfo.html) 06:23:27 INFO - PROCESS | 4627 | __metrics Screen width/height:1600/1200 06:23:27 INFO - PROCESS | 4627 | colorDepth:24 06:23:27 INFO - PROCESS | 4627 | Browser inner width/height: 1024/697 06:23:27 INFO - PROCESS | 4627 | __metrics 06:23:28 ERROR - PROCESS | 4627 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:23:29 INFO - TEST-INFO | 4627: exit 0 06:23:29 INFO - Browser initialized. 06:23:29 INFO - Running cycle 1/1 for kraken test... 06:23:29 INFO - TEST-INFO | started process 4747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxP6ppJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:41 INFO - PROCESS | 4747 | RSS: Main: 184705024 06:23:41 INFO - PROCESS | 4747 | 06:23:43 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60846/tests/kraken/driver.html?testName=audio-beat-detection) 06:23:44 INFO - PROCESS | 4747 | RSS: Main: 190017536 06:23:44 INFO - PROCESS | 4747 | 06:23:47 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60846/tests/kraken/driver.html?testName=audio-dft) 06:23:47 INFO - PROCESS | 4747 | RSS: Main: 189476864 06:23:47 INFO - PROCESS | 4747 | 06:23:50 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60846/tests/kraken/driver.html?testName=audio-fft) 06:23:51 INFO - PROCESS | 4747 | RSS: Main: 184094720 06:23:51 INFO - PROCESS | 4747 | 06:23:53 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60846/tests/kraken/driver.html?testName=audio-oscillator) 06:23:54 INFO - PROCESS | 4747 | RSS: Main: 184893440 06:23:54 INFO - PROCESS | 4747 | 06:23:56 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60846/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:23:57 INFO - PROCESS | 4747 | RSS: Main: 185167872 06:23:57 INFO - PROCESS | 4747 | 06:24:00 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60846/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:00 INFO - PROCESS | 4747 | RSS: Main: 185810944 06:24:00 INFO - PROCESS | 4747 | 06:24:04 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60846/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:04 INFO - PROCESS | 4747 | RSS: Main: 183828480 06:24:04 INFO - PROCESS | 4747 | 06:24:07 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60846/tests/kraken/driver.html?testName=json-parse-financial) 06:24:08 INFO - PROCESS | 4747 | RSS: Main: 185139200 06:24:08 INFO - PROCESS | 4747 | 06:24:09 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60846/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:24:10 INFO - PROCESS | 4747 | RSS: Main: 185384960 06:24:10 INFO - PROCESS | 4747 | 06:24:12 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:24:12 INFO - PROCESS | 4747 | RSS: Main: 185200640 06:24:12 INFO - PROCESS | 4747 | 06:24:15 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:24:15 INFO - PROCESS | 4747 | RSS: Main: 185733120 06:24:15 INFO - PROCESS | 4747 | 06:24:18 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:24:18 INFO - PROCESS | 4747 | RSS: Main: 186011648 06:24:18 INFO - PROCESS | 4747 | 06:24:21 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:24:22 INFO - PROCESS | 4747 | RSS: Main: 185802752 06:24:22 INFO - PROCESS | 4747 | 06:24:23 INFO - PROCESS | 4747 | Cycle 1(1): loaded http://localhost:60846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60846/tests/kraken/driver.html?testName=ai-astar) 06:24:24 INFO - PROCESS | 4747 | RSS: Main: 185991168 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | __start_tp_report 06:24:24 INFO - PROCESS | 4747 | _x_x_mozilla_page_load 06:24:24 INFO - PROCESS | 4747 | _x_x_mozilla_page_load_details 06:24:24 INFO - PROCESS | 4747 | |i|pagename|runs| 06:24:24 INFO - PROCESS | 4747 | |0;ai-astar;103;110;105;111;112;111;113;112;110;113 06:24:24 INFO - PROCESS | 4747 | |1;audio-beat-detection;156;132;159;177;134;164;156;129;185;126 06:24:24 INFO - PROCESS | 4747 | |2;audio-dft;162;168;164;162;163;179;162;161;161;163 06:24:24 INFO - PROCESS | 4747 | |3;audio-fft;76;78;76;170;76;75;74;76;164;76 06:24:24 INFO - PROCESS | 4747 | |4;audio-oscillator;84;84;151;86;85;85;140;86;84;142 06:24:24 INFO - PROCESS | 4747 | |5;imaging-gaussian-blur;118;118;118;118;119;119;118;118;118;118 06:24:24 INFO - PROCESS | 4747 | |6;imaging-darkroom;147;147;146;147;150;153;147;148;146;147 06:24:24 INFO - PROCESS | 4747 | |7;imaging-desaturate;96;96;95;97;97;95;95;96;95;96 06:24:24 INFO - PROCESS | 4747 | |8;json-parse-financial;55;54;56;53;54;52;54;56;54;54 06:24:24 INFO - PROCESS | 4747 | |9;json-stringify-tinderbox;65;62;62;64;64;63;63;62;62;63 06:24:24 INFO - PROCESS | 4747 | |10;stanford-crypto-aes;80;78;79;79;83;86;82;81;91;84 06:24:24 INFO - PROCESS | 4747 | |11;stanford-crypto-ccm;124;122;128;134;139;119;140;124;148;124 06:24:24 INFO - PROCESS | 4747 | |12;stanford-crypto-pbkdf2;158;161;161;157;158;159;158;159;157;167 06:24:24 INFO - PROCESS | 4747 | |13;stanford-crypto-sha256-iterative;63;63;62;62;65;65;61;63;61;61 06:24:24 INFO - PROCESS | 4747 | __end_tp_report 06:24:24 INFO - PROCESS | 4747 | __start_cc_report 06:24:24 INFO - PROCESS | 4747 | _x_x_mozilla_cycle_collect,847 06:24:24 INFO - PROCESS | 4747 | __end_cc_report 06:24:24 INFO - PROCESS | 4747 | __startTimestamp1466774664162__endTimestamp 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | ------- Summary: start ------- 06:24:24 INFO - PROCESS | 4747 | Number of tests: 14 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.37 (3.0%) stddev-sans-first:2.44 06:24:24 INFO - PROCESS | 4747 | Values: 103.0 110.0 105.0 111.0 112.0 111.0 113.0 112.0 110.0 113.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:157.50 stddev:20.73 (13.2%) stddev-sans-first:21.93 06:24:24 INFO - PROCESS | 4747 | Values: 156.0 132.0 159.0 177.0 134.0 164.0 156.0 129.0 185.0 126.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:5.48 (3.4%) stddev-sans-first:5.74 06:24:24 INFO - PROCESS | 4747 | Values: 162.0 168.0 164.0 162.0 163.0 179.0 162.0 161.0 161.0 163.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.46 (50.6%) stddev-sans-first:40.23 06:24:24 INFO - PROCESS | 4747 | Values: 76.0 78.0 76.0 170.0 76.0 75.0 74.0 76.0 164.0 76.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.50 stddev:28.87 (34.2%) stddev-sans-first:29.82 06:24:24 INFO - PROCESS | 4747 | Values: 84.0 84.0 151.0 86.0 85.0 85.0 140.0 86.0 84.0 142.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:24:24 INFO - PROCESS | 4747 | Values: 118.0 118.0 118.0 118.0 119.0 119.0 118.0 118.0 118.0 118.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.00 stddev:2.15 (1.5%) stddev-sans-first:2.26 06:24:24 INFO - PROCESS | 4747 | Values: 147.0 147.0 146.0 147.0 150.0 153.0 147.0 148.0 146.0 147.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 06:24:24 INFO - PROCESS | 4747 | Values: 96.0 96.0 95.0 97.0 97.0 95.0 95.0 96.0 95.0 96.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.27 06:24:24 INFO - PROCESS | 4747 | Values: 55.0 54.0 56.0 53.0 54.0 52.0 54.0 56.0 54.0 54.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:0.83 06:24:24 INFO - PROCESS | 4747 | Values: 65.0 62.0 62.0 64.0 64.0 63.0 63.0 62.0 62.0 63.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:3.95 (4.8%) stddev-sans-first:4.10 06:24:24 INFO - PROCESS | 4747 | Values: 80.0 78.0 79.0 79.0 83.0 86.0 82.0 81.0 91.0 84.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:131.00 stddev:9.53 (7.3%) stddev-sans-first:9.84 06:24:24 INFO - PROCESS | 4747 | Values: 124.0 122.0 128.0 134.0 139.0 119.0 140.0 124.0 148.0 124.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.00 stddev:2.99 (1.9%) stddev-sans-first:3.12 06:24:24 INFO - PROCESS | 4747 | Values: 158.0 161.0 161.0 157.0 158.0 159.0 158.0 159.0 157.0 167.0 06:24:24 INFO - PROCESS | 4747 | 06:24:24 INFO - PROCESS | 4747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 06:24:24 INFO - PROCESS | 4747 | Values: 63.0 63.0 62.0 62.0 65.0 65.0 61.0 63.0 61.0 61.0 06:24:24 INFO - PROCESS | 4747 | -------- Summary: end -------- 06:24:24 INFO - PROCESS | 4747 | 06:24:25 INFO - TEST-INFO | 4747: exit 0 06:24:25 INFO - TEST-OK | kraken | took 62421ms 06:24:25 INFO - SUITE-END | took 1173s 06:24:25 INFO - Completed test suite (00:19:33) 06:24:25 INFO - javascript benchmark 06:24:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7337.112822374509, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.1187461573454, 3139.513375426809, 3143.827089510077, 3153.968460315396, 3158.2262345725285, 5446.101393270111, 5462.1260598304325, 5541.5566754659585, 5580.4698553637445, 5608.691521966291, 5495.368032676243, 5507.0, 5606.243157173781, 5609.943900560993, 5660.518855897243, 4901.362822833027, 4911.361523002005, 5080.263361812535, 5162.122439185328, 5175.689458632494, 531.4212428588085, 5005.124103281929, 5060.11447996601, 5106.489351064883, 5119.308893299412, 5015.673981191248, 5033.723145227011, 5059.49405059493, 5062.26597143414, 5095.235714642815, 4870.439899411542, 5072.0, 5077.949220507785, 5097.541221290102, 5098.439171691111, 4976.178930476467, 4982.377202849644, 4989.525995030466, 5013.423456302499, 5039.596832253411, 5473.28847249855, 5552.805651802168, 5588.972055139739, 5607.074832652607, 5690.772369105231, 5941.435563621492, 6014.2181516403025, 6015.639061656315, 6030.66831324277, 6056.303525094627, 6103.974138059492, 6107.401224262661, 6118.192813661917, 6119.724203897816, 6128.078129754063, 5701.0308247598, 5701.486866182064, 5701.629394089371, 5704.201411802351, 5732.168835518868, 5997.760089596454, 6002.579819412599, 6007.678310771623, 6043.8186854394435, 6246.875062498724, 5936.614120082181, 5953.940460595425, 5959.761609535657, 5970.164177015221, 5984.251968503937, 6067.878642427215, 6069.150318955261, 6081.5742897996715, 6081.908771368433, 6090.086487026982, 5816.302043754692, 5868.383819698955, 5885.970570147122, 5923.644581325134, 5934.940650593525, 5892.381299963442, 5914.822555323347, 5935.287765468085, 5947.821565353046, 6038.426349496791, 4536.818527258939, 4548.363229147922, 4555.589996900295, 4571.040081582905, 4599.4710608280475, 3987.4018897165656, 4023.939640905389, 4035.8385664573675, 4051.7771126132284, 4100.671946244293, 5672.886542269214, 5691.032524470767, 5701.971490142523, 5709.914351284734, 5749.712514374348, 5908.793192238251, 5958.940410595838, 5964.433378829091, 5968.761249550056, 5970.9701451492465, 5551.805686800943, 5720.799772007959, 5728.026235539968, 5729.054705973468, 5731.398203188689, 5157.793688252503, 5163.380394352702, 5170.250313704491, 5192.688438693691, 5206.687598744087, 6265.060240963892, 6272.247330320391, 6275.058741188858, 6282.089097080898, 6291.842703932347, 5887.087501437284, 5958.106284057253, 6000.819975400745, 6033.87932241344, 6040.7583696651645, 6183.536234782499, 6212.335169752679, 6250.1874756281395, 6256.280527739368, 6261.937380626136, 5903.439173278532, 5919.260092488439, 5921.437463440966, 5922.318933322723, 5943.58394912352, 5775.566832487496, 6018.699065046818, 6044.0, 6065.211522502046, 6090.665013424127, 5850.882982340415, 5854.151148083589, 5867.853303667443, 5874.206982057539, 5919.171316015675, 5677.829665110054, 5863.0, 5873.853153671022, 5880.029795083763, 5880.206172166874, 5604.0, 5643.71781410936, 5650.63270887391, 5658.660480371191, 5706.258186435903, 5745.683987380567, 5770.711464426846, 5775.422457754191, 5803.680797556175, 5813.883722325614, 5492.890142197054, 5685.800996965087, 5694.515966142924, 5696.259486266758, 5717.599768016199], "value": 5470.7484674867865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8423625621083, 616.2143267334145, 627.2379059442776, 631.2046821005533, 649.0005391696785, 41913.0, 43005.56994430059, 43066.7846660767, 43381.78309108458, 47109.0, 45015.77492112535, 45649.7717511412, 45900.770496147474, 45958.310625340644, 46129.0, 8955.820883582324, 9062.365634405594, 9081.909180908206, 9106.544672766368, 9120.817583648322, 8950.373473856833, 9020.323475739313, 9032.367734258605, 9033.864492032624, 9053.456792592433, 9004.639814407416, 9043.186113249807, 9078.364514483988, 9106.954465227665, 9129.315301352392, 8885.955570222171, 9020.548972551345, 9024.097590240988, 9055.59249833759, 9064.0, 8889.555522223864, 8931.330150238693, 8963.641454341818, 8965.820683586357, 8990.820183596357, 43412.78293608543, 43666.0, 43700.0, 43735.562644373786, 43852.780736096116, 3731.7574357666663, 4147.199171157868, 4176.958230417687, 4208.431861698662, 4337.327714204303, 30223.244418889484, 33852.83073584616, 33991.4901276481, 34077.31845363104, 35009.29981400383, 4414.779261036935, 4448.755318457484, 4464.8883777905485, 4561.6806823522365, 4658.627309815207, 328808.0, 329210.0, 332226.33886830654, 332343.0, 333117.0, 34510.82744586261, 35251.0, 35335.293294133975, 37291.4406283906, 59103.11345329823, 37064.258714825555, 37465.0, 37523.81238093792, 37603.247935041145, 37763.0, 14944.70110597782, 14987.32557034936, 15031.323590438456, 15051.021683590532, 15135.848641513665, 11963.102767292488, 12054.095942804324, 12072.758544829054, 12078.818817717742, 12080.214786039056, 8378.455400398954, 8431.95784021076, 8437.789055273668, 8457.703980360659, 8551.102134275812, 3274.5579346788354, 3281.8851340203455, 3294.1764558860286, 3349.882754103595, 3352.6144493383085, 960.1982344742079, 973.3381300715581, 1004.6282875336173, 1131.8075927092414, 1167.486306025346, 31819.681803182135, 32035.359292814013, 32257.51613725796, 32432.83783581067, 32889.3422131556, 1115.4088333183427, 1117.8323251512174, 1132.53000004997, 1148.3224897310627, 1194.964151075469, 16874.493765187064, 16947.067911265, 16981.320747169975, 17040.914795425942, 17078.402255920984, 544308.0, 548743.0, 550397.0, 551863.0, 553995.0, 60254.0, 60733.69633151894, 60903.69548152231, 60976.085358719654, 61003.38996610066, 1225.2281062930474, 1330.0822432521722, 1364.9658758530918, 1366.5012270521188, 1367.2548461088732, 30856.845715772175, 30866.826634673605, 31057.68942310548, 31677.0, 32199.356012879143, 53253.201201981225, 53415.73292133515, 53427.0, 53607.46392536024, 53748.19377709416, 465276.0, 474334.0, 475409.0, 475454.0, 477042.0, 28354.574681380207, 28773.56839647449, 28839.0, 28857.278568035967, 28931.566026509197, 48091.55725328246, 49405.50594494153, 49702.502974969786, 50313.0, 50439.49560504348, 40543.391849122876, 41316.0, 41368.1726365465, 42013.159736805705, 42857.57142428536, 41313.1737365257, 41493.170136597706, 42406.0, 42488.57511424846, 42753.0, 40046.799766000986, 40144.79927600343, 40685.0, 41107.177856442104, 43897.56102439063, 35698.46452303165, 37818.62181378261, 37831.43252851265, 38195.04512387213, 38518.42222366611, 27579.44841103207, 28325.150245492667, 28414.0, 28500.714992849807, 28622.0], "value": 19095.68965053842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5199073172436, 380.3093116202864, 383.35213489203244, 392.83304595546906, 395.00655850535924, 17562.47312580623, 19498.0, 19974.201031958703, 20239.190432382704, 20559.0, 18189.272429102853, 18569.628607427876, 18670.53323666909, 18718.157682904268, 18873.15070821813, 5430.647007944471, 5506.311711036121, 5625.46558076982, 5629.7185140743, 5752.36723960364, 5551.306086739158, 5604.0, 5660.5471562275125, 5670.631408958405, 5677.403872593381, 5596.524295434893, 5600.019996500617, 5617.0, 5633.126865335879, 5687.431256874321, 5489.64317319375, 5543.722813859331, 5557.916631250535, 5613.298337707786, 5646.463585959327, 4846.103470857867, 4978.87552811179, 4996.225585034325, 5015.874603134915, 5031.018951304497, 22503.0, 22546.774532254796, 22849.200277990356, 22879.65680514777, 23135.305940821803, 2325.4651430171157, 2334.8832558372183, 2347.9060837566476, 2408.0969636386353, 2484.093305943336, 14422.495212667507, 14445.92777036108, 14572.198529080897, 14576.198309092995, 14652.560423187322, 1930.276146445083, 1933.5649478867142, 1942.1939894943582, 1957.9608407831763, 2035.084212104559, 76854.61572692101, 78148.60925695335, 79658.60170699109, 79670.0, 80131.0, 10111.848322275171, 10137.543810528545, 10506.212034097472, 10925.125989920787, 11312.434378281054, 14198.432062717582, 14256.928715356564, 14286.428542858377, 14289.214093224764, 14343.211123388106, 7904.644291006918, 7998.280154786097, 8202.138775428613, 8211.630476628447, 8282.751517454486, 7629.122650895107, 7739.34215591681, 7891.083076124058, 7937.563434011185, 8111.229433203836, 6502.089707440962, 6561.9500879859, 6568.113304703899, 6581.670916454158, 6589.209294884645, 1851.6389304085574, 1893.611809579033, 1915.348781414298, 1916.2622390379804, 1925.6245032218583, 950.3490109275168, 958.4105774948357, 977.2475194100645, 977.4282045003611, 1021.6168936648756, 19042.619147617246, 19531.90234048849, 19611.117499712545, 19828.801711982695, 19837.702434463496, 974.7855471796194, 987.1707765477033, 992.2558081438921, 1012.9341592796445, 1061.580675633136, 10763.408012559228, 11201.495932683049, 11245.325280483197, 11289.830652540219, 11328.0, 373878.6530336709, 376310.0, 378504.0, 499229.0, 505721.0, 97715.51142244243, 102797.0, 104723.4763826176, 105357.47321263344, 106057.46971265248, 909.8999110097884, 967.274544091931, 976.7997560500222, 980.6861804222581, 984.2224642532319, 16264.268107934935, 17118.657626847144, 17255.7411638823, 17413.47759567215, 17897.0, 33327.166820829676, 39243.80378098205, 43217.567824322614, 44513.554864452235, 45729.771351143034, 58818.7059064702, 59651.40348596632, 59957.40042599518, 60881.39118608934, 60885.69557152186, 7804.9609751950875, 8144.30773384269, 8221.424500285162, 8336.273072814352, 8560.700375486827, 13396.531121410704, 13957.930210348883, 13981.091229070078, 14154.929225353808, 14162.858371416154, 11617.419129043345, 11766.294022358687, 11794.823077653671, 12229.93885030569, 12550.0, 12128.757424851277, 12256.816147757969, 12276.202046866925, 12316.568920087753, 12443.44004519817, 12185.268883866996, 12276.508939642314, 12323.753524929272, 12400.937995309965, 12663.683407914506, 7339.0, 7767.72812951544, 8045.517268963881, 8087.433879628605, 8169.0605580359015, 8649.956750216208, 11236.0, 11349.262297950607, 12021.398930053638, 12164.2701437914], "value": 9295.126848649925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.6494908747359, 1457.7813328000798, 1553.3398305720066, 1701.7192163293057, 1708.743688446732, 7829.334506566935, 8586.227239548454, 8684.0, 9279.582418791153, 9324.0, 8653.048164701877, 8804.20762131408, 8804.943406791193, 8932.196102350787, 8950.194482496574, 2324.651302304655, 2356.516914032628, 2389.0443822471066, 2394.9760502395015, 2396.4128788446856, 2312.063614236237, 2337.474068334628, 2362.763723627632, 2363.361892289081, 2377.7146742390937, 2326.232343326698, 2336.3224664847176, 2346.9061237550477, 2349.9765002349927, 2371.27676058802, 2313.5257272259146, 2323.8954247058837, 2326.7440581536016, 2328.895199716017, 2356.2931120663734, 2259.943501412478, 2272.6704627829035, 2288.8397812153157, 2325.2907863101746, 2342.6251799712136, 9055.954720226422, 9071.183593476553, 9095.090490950852, 9116.316276279305, 9127.5436228189, 5138.58891288696, 5143.665661732013, 5277.604179686539, 5289.682619042831, 5293.444188360205, 3338.4825352070466, 3399.5240666306736, 3442.3287458945515, 3503.4744788281705, 3515.6308587598446, 1123.2530367305733, 1141.8401423800674, 1142.1662186603826, 1179.1038810503992, 1184.7748927703708, 12425.813612795815, 12560.0, 12566.30885301308, 12571.120021598492, 12614.243145411305, 4618.976905115453, 4693.06138772247, 4761.47623761386, 4767.261074533453, 4767.976160119178, 10551.525181366856, 10557.894421055844, 10627.415492147851, 10640.201984851166, 10666.893331066745, 5188.662736922088, 5219.895602087937, 5237.319148510669, 5245.423003469616, 5318.760655770499, 4315.525292217853, 4623.930641040387, 4759.214729569651, 4791.089692958327, 4866.343043689057, 3974.7018973577096, 4001.3397789365013, 4085.816138273785, 4097.85657501986, 4098.262312783728, 1229.883161099694, 1237.7400745843474, 1241.1746188784539, 1249.331607589935, 1254.6988722706485, 782.1318336646318, 875.0680525240598, 885.4465958775766, 901.5852707754375, 925.4031149908271, 6123.938760612336, 6280.685965701697, 6288.213973253343, 6326.841828954313, 6417.711202995876, 926.5830376330678, 947.4599478297305, 974.171953839231, 975.0103644800533, 995.2286977592424, 4193.601607847249, 4321.114171594815, 4321.719088259253, 4357.477102747627, 4415.249407600716, 11047.392393418279, 11376.94311528437, 11389.373584452935, 11397.430128493543, 11469.88530114705, 11285.322880627189, 11311.60409385684, 11371.147163962736, 11372.48823802931, 11390.658280251606, 8086.312663423557, 8272.759086137008, 8456.66173353059, 8580.871286930702, 8615.78460538504, 6108.144859719731, 6319.873602528016, 6442.871142577216, 6484.157059582224, 6509.609423434609, 10497.947510262706, 10624.309419887682, 10632.202584806017, 10657.626983055556, 10762.246642735246, 10233.232507562112, 10446.373217606968, 10792.514336854703, 10888.346699198073, 10943.726406839893, 7176.0, 7489.0, 7680.231976802275, 7883.960580197062, 8079.232472915063, 8462.915370846213, 8479.406441549032, 8508.957455212932, 8521.573921303787, 8581.742547723577, 7688.615569221628, 7878.448508604342, 7980.201979801974, 8081.959590202011, 8087.3125784308995, 7528.811779705551, 7605.32682809781, 7634.541927484369, 7759.0, 7764.883526747216, 7036.401905838061, 7090.893636595559, 7103.218645949045, 7121.181064177686, 7148.535345202546, 4974.303597496426, 4995.725235112103, 5146.099432599355, 5199.324087868704, 5205.92191117126, 5124.538791508782, 5154.639175257846, 5164.612654050886, 5193.039287731782, 5214.139666955061], "value": 4706.925877686043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6729703944577, 332.48962842037474, 334.3697130908239, 339.9354122716684, 343.4059077795412, 5476.3702174249975, 5620.257720106764, 5668.659880407174, 5740.282464691913, 5763.5389168866495, 5527.143292789624, 5545.390007099216, 5593.74828132734, 5638.267025286707, 5649.46330098641, 4329.870103896888, 4363.672724545671, 4365.934510982338, 4392.428984232045, 4427.77861106945, 4050.7772072536, 4052.7031349968024, 4287.1425714857, 4295.140971805651, 4300.3334483155, 4242.766647834368, 4259.5740425957465, 4268.743875367472, 4271.8718438446895, 4282.100758840632, 4273.978630106845, 4289.892752681177, 4311.749592618137, 4324.0, 4326.480822301312, 3694.4643026761237, 3729.5524537055458, 3738.12154143776, 3818.770873747584, 3855.9807200964096, 5464.972675136639, 5471.343438787331, 5485.588580856412, 5486.149646804752, 5497.147942068986, 4850.054239423313, 4870.366852309213, 4874.341963834872, 4880.657819099741, 4925.26121081837, 5560.582956278255, 5766.798162064308, 5813.779106387664, 5815.767369305223, 5856.882862342772, 4077.2864748668862, 4095.1195492968855, 4098.938515922264, 4112.362583799486, 4133.359329303963, 5723.885522289573, 5863.149843272787, 6003.819885403401, 6027.849303767397, 6036.879262414727, 4198.790060497024, 4216.873493795191, 4221.767802770815, 4229.936550951738, 4272.700910936267, 4254.893627659271, 4270.10327831159, 4271.124419493996, 4285.5928686774705, 4287.506936702257, 4676.906461870743, 4914.729689867092, 4939.752412652235, 4970.602351811846, 4972.353594032753, 5856.209411729447, 5871.383504732027, 5884.0, 5893.381194974551, 5897.380775018647, 1471.5438214153646, 1491.8582734640192, 1494.5054945054944, 1497.1241823533137, 1501.992490037543, 907.3693782821008, 948.4119845695712, 959.2182371367313, 963.54023654164, 969.7187815533557, 4955.4548999610015, 5047.848564543069, 5053.620978426559, 5069.467705890902, 5122.745991763612, 5241.292425522505, 5261.947380526222, 5280.9207861882105, 5283.577313814885, 5330.38700549434, 5016.673916195436, 5049.358958338555, 5072.315237442898, 5293.523582877559, 5780.653160810365, 3208.6630903755236, 3215.871365145368, 3220.373711275791, 3243.6431992480807, 3248.3828072666593, 6061.242344706911, 6284.340144284875, 6298.0, 6303.7793677222, 6350.237971443364, 6066.545009124245, 6130.264368275835, 6138.066509049635, 6144.8771024579255, 6161.229846269216, 6119.510439164945, 6160.784372546939, 6176.8764624707255, 6210.9068363974575, 6247.344028876993, 5680.346760122638, 5986.431289027535, 6010.248718910137, 6037.339731573852, 6066.120412540069, 5959.791407300723, 5965.403459654, 5972.283326000734, 5987.6108052976415, 5989.0, 6066.3023752269055, 6136.386361363828, 6216.027178257285, 6266.780662676784, 6290.842728931813, 4236.830526779017, 4277.871663850089, 4285.764282964342, 4287.614114729689, 4300.763458009715, 5759.971200143972, 6067.757289708539, 6094.329623741296, 6095.695215239309, 6113.877722445615, 5859.296884373732, 5880.852978675567, 5888.205092312483, 5891.941080589139, 5918.733656985532, 5852.561057920588, 5881.38245484218, 5888.234529511136, 5890.14592884038, 5902.7343769531335, 5562.415946325577, 5740.598158128891, 5749.741261643152, 5773.364929857628, 5784.768609255582, 5808.709564521672, 5872.794452194153, 5880.206172166702, 5929.154006077021, 5949.52403807703, 5504.779808807602, 5732.971335143297, 5762.798302059407, 5773.797917072882, 5802.912956305574], "value": 4404.631396734574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6480606905653, 767.209773932849, 790.6244533846422, 819.1194465949104, 832.0763952013268, 15432.151231682254, 16507.0, 16576.336946522155, 16619.83380166198, 16695.747818913584, 15171.089734615904, 15358.846411535882, 15367.308471118798, 15385.384584616602, 15418.152001639904, 633.4299130782298, 758.6965213914451, 781.847539729753, 785.2187073861516, 788.1724189600925, 758.370552441475, 765.1392183793232, 765.1506827421557, 766.2337662337662, 768.8961990131345, 817.9672813087469, 824.8597738384459, 828.7555171224473, 830.0993422136988, 833.8624127019035, 811.813282944923, 817.9550124743137, 822.8847961285425, 824.4146655874337, 826.6734639817298, 591.9704014799242, 597.0208857473747, 597.8505373656586, 600.1477901380007, 602.6203491800181, 14775.556733298019, 14852.33164507589, 14900.552983410515, 14988.850111498854, 15030.0, 14246.928765356211, 15168.696626067527, 15439.845601543953, 15610.297536610766, 15682.294296756674, 11786.882131178665, 11858.881411185865, 12357.814632780515, 12450.0, 12870.227786332756, 4626.953730462686, 4641.3270075839155, 4671.579557839811, 4687.437507499088, 4705.929411058837, 76481.23518764797, 77776.0, 78133.82799258073, 79103.6044819778, 79319.0, 11154.05908199954, 11354.432278386048, 11403.144764142722, 11518.827217591743, 11743.706407339885, 19803.504912377306, 20509.2821751238, 20537.48656283605, 20549.280775173098, 20591.691124633144, 8598.656053757904, 8971.010512122728, 9072.50101244438, 9094.954525227331, 9161.816763664823, 4804.279358096313, 4806.95193048072, 4863.392075990501, 4878.463369029404, 5041.8487445376695, 3869.690424766012, 3974.7217694761666, 4002.399640053957, 4020.8793736187963, 4021.5174179098112, 658.8484648530865, 663.6482664187988, 668.3216535216759, 668.358375959075, 680.7413182990432, 631.9747210111636, 691.3639451704444, 731.5098883747902, 762.2606072110044, 783.169839969634, 10079.445630490247, 10185.898141018495, 10191.54138063789, 10316.638917637996, 10370.637027703995, 738.346563291491, 744.5681504727245, 748.7716246544857, 749.7863109013905, 777.8288776469168, 4963.5780958618925, 4974.850754477371, 4992.90014199714, 4995.925061124086, 5075.086484432837, 109351.34540582083, 110159.0, 110337.0, 110531.44734276277, 114437.0, 98615.0, 100075.0, 100194.0, 101248.0, 103233.48383258036, 62753.372466275665, 86671.56664216639, 89784.0, 91106.54446727857, 92692.53653731688, 9344.543188414496, 9428.245740340619, 9458.148766611039, 9535.666251681158, 9750.073742994404, 51257.2059977899, 51296.0, 51422.97154056973, 52732.47267527276, 53483.46516534785, 73315.26684733084, 75556.62221688856, 77388.6130569366, 77405.0, 77924.0, 12197.878021220029, 12343.75312493763, 12532.37338133108, 13462.461501539829, 13536.323183840965, 14904.403823846924, 15143.848561514244, 15274.465393711167, 15944.0, 16157.919210403872, 14442.350094245574, 14491.637709057359, 14508.637284067561, 14854.702905942037, 15012.774808377664, 13690.452381904612, 14019.50931717385, 14623.268836558342, 14627.92686036563, 14723.116613003254, 13749.243791591558, 14292.85707142957, 14411.42354305816, 14582.0, 14863.479778207711, 11305.0, 11746.70633234176, 12280.447379867748, 12440.576427283271, 12749.745005100032, 10594.576216951236, 11133.387663678575, 11210.49552770111, 11368.54525818958, 11692.649220523057], "value": 7748.653352421445, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 105.0, 111.0, 112.0, 111.0, 113.0, 112.0, 110.0, 113.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 159.0, 177.0, 134.0, 164.0, 156.0, 129.0, 185.0, 126.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 164.0, 162.0, 163.0, 179.0, 162.0, 161.0, 161.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 170.0, 76.0, 75.0, 74.0, 76.0, 164.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 151.0, 86.0, 85.0, 85.0, 140.0, 86.0, 84.0, 142.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 150.0, 153.0, 147.0, 148.0, 146.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 97.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 53.0, 54.0, 52.0, 54.0, 56.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 64.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 79.0, 83.0, 86.0, 82.0, 81.0, 91.0, 84.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 128.0, 134.0, 139.0, 119.0, 140.0, 124.0, 148.0, 124.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 161.0, 157.0, 158.0, 159.0, 158.0, 159.0, 157.0, 167.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 65.0, 65.0, 61.0, 63.0, 61.0, 61.0], "value": 62.6, "unit": "score"}]}]} 06:24:25 INFO - Return code: 0 06:24:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:24:25 ERROR - # TBPL SUCCESS # 06:24:25 INFO - Running post-action listener: _resource_record_post_action 06:24:25 INFO - ##### 06:24:25 INFO - ##### Finished run-tests step (success) 06:24:25 INFO - ##### 06:24:25 INFO - Running post-run listener: _resource_record_post_run 06:24:25 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 45056; Write bytes: 367939584; Read time: 68; Write time: 417756 06:24:25 INFO - TinderboxPrint: CPU usage
13.4% 06:24:25 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 68 06:24:25 INFO - TinderboxPrint: I/O write bytes / time
367,939,584 / 417,756 06:24:25 INFO - TinderboxPrint: CPU idle
8,224.2 (86.6%) 06:24:25 INFO - TinderboxPrint: CPU user
1,217.2 (12.8%) 06:24:25 INFO - TinderboxPrint: Swap in / out
0 / 0 06:24:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77864960; Read time: 0; Write time: 49676 06:24:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 45056; Write bytes: 290074624; Read time: 68; Write time: 368080 06:24:26 INFO - Running post-run listener: _upload_blobber_files 06:24:26 INFO - Blob upload gear active. 06:24:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:24:26 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 06:24:26 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:24:26 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:24:26 INFO - (blobuploader) - INFO - Open directory for files ... 06:24:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:24:29 INFO - (blobuploader) - INFO - Done attempting. 06:24:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:24:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:24:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:24:30 INFO - (blobuploader) - INFO - Done attempting. 06:24:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:24:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:24:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:24:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:24:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:24:31 INFO - (blobuploader) - INFO - Done attempting. 06:24:31 INFO - (blobuploader) - INFO - Iteration through files over. 06:24:31 INFO - Return code: 0 06:24:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:24:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:24:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ac4fb346a7e0a7e94b3ce718663001736d20e6a91a142c10daf4901e2d4bda826c9ca06a940e1a5105d08709f77906448d39bab7e3647849f637fec2dd624c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a49519ec01bc2a07f8f8323f2b9e65cc35510036cb3facc1caea53328a50d8ff63ba3d74897f6e81be20ff6ac684f0c9168791b9ebb9a2c116be22f6daacb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cad1d3da7a7b2b57d8857dd42ee2a30b2c200fdabdcf3e299d4ecd8ef93a69cf463cde28dbd3c9bc70106c8371866613fc7b13d25603aa77acdd416f85286af"} 06:24:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:24:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:24:31 INFO - Contents: 06:24:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ac4fb346a7e0a7e94b3ce718663001736d20e6a91a142c10daf4901e2d4bda826c9ca06a940e1a5105d08709f77906448d39bab7e3647849f637fec2dd624c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a49519ec01bc2a07f8f8323f2b9e65cc35510036cb3facc1caea53328a50d8ff63ba3d74897f6e81be20ff6ac684f0c9168791b9ebb9a2c116be22f6daacb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cad1d3da7a7b2b57d8857dd42ee2a30b2c200fdabdcf3e299d4ecd8ef93a69cf463cde28dbd3c9bc70106c8371866613fc7b13d25603aa77acdd416f85286af"} 06:24:31 INFO - Running post-run listener: copy_logs_to_upload_dir 06:24:31 INFO - Copying logs to upload dir... 06:24:31 INFO - mkdir: /builds/slave/test/build/upload/logs 06:24:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.722120 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-24 06:24:31.364407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:24:31.370744) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816 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/sha512/0ac4fb346a7e0a7e94b3ce718663001736d20e6a91a142c10daf4901e2d4bda826c9ca06a940e1a5105d08709f77906448d39bab7e3647849f637fec2dd624c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a49519ec01bc2a07f8f8323f2b9e65cc35510036cb3facc1caea53328a50d8ff63ba3d74897f6e81be20ff6ac684f0c9168791b9ebb9a2c116be22f6daacb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cad1d3da7a7b2b57d8857dd42ee2a30b2c200fdabdcf3e299d4ecd8ef93a69cf463cde28dbd3c9bc70106c8371866613fc7b13d25603aa77acdd416f85286af"} build_url:https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/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/sha512/0ac4fb346a7e0a7e94b3ce718663001736d20e6a91a142c10daf4901e2d4bda826c9ca06a940e1a5105d08709f77906448d39bab7e3647849f637fec2dd624c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a49519ec01bc2a07f8f8323f2b9e65cc35510036cb3facc1caea53328a50d8ff63ba3d74897f6e81be20ff6ac684f0c9168791b9ebb9a2c116be22f6daacb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cad1d3da7a7b2b57d8857dd42ee2a30b2c200fdabdcf3e299d4ecd8ef93a69cf463cde28dbd3c9bc70106c8371866613fc7b13d25603aa77acdd416f85286af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:24:31.396549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:24:31.396969) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466773435.957680-623651816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:24:31.480098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:24:31.480515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:24:31.480827) ========= ========= Total master_lag: 0.17 =========