builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1465398998.95 results: success (0) buildid: 20160608053005 builduid: aafcaa010bef433abf41399be340d089 revision: 71d424246fe1149948c8054a4392feea87dfd0ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:38.947539) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:38.948089) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:38.948385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:38.965569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:38.966031) ========= 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=523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 08:16:40-- 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% 45.7M=0s 2016-06-08 08:16:40 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.105188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.105574) ========= 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=523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.159958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.160308) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 71d424246fe1149948c8054a4392feea87dfd0ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 71d424246fe1149948c8054a4392feea87dfd0ad --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=523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 08:16:40,263 truncating revision to first 12 chars 2016-06-08 08:16:40,263 Setting DEBUG logging. 2016-06-08 08:16:40,263 attempt 1/10 2016-06-08 08:16:40,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/71d424246fe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 08:16:40,612 unpacking tar archive at: fx-team-71d424246fe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.900737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.901023) ========= script_repo_revision: 71d424246fe1149948c8054a4392feea87dfd0ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.901411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.901727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 08:16:39.911638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-08 08:16:39.911907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:41 INFO - MultiFileLogger online at 20160608 08:16:41 in /builds/slave/test 08:16:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:16:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:41 INFO - {'append_to_log': False, 08:16:41 INFO - 'base_work_dir': '/builds/slave/test', 08:16:41 INFO - 'blob_upload_branch': 'Fx-Team', 08:16:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:41 INFO - 'branch': 'Fx-Team', 08:16:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:41 INFO - 'config_files': ('talos/linux_config.py',), 08:16:41 INFO - 'default_actions': ('clobber', 08:16:41 INFO - 'read-buildbot-config', 08:16:41 INFO - 'download-and-extract', 08:16:41 INFO - 'populate-webroot', 08:16:41 INFO - 'create-virtualenv', 08:16:41 INFO - 'install', 08:16:41 INFO - 'run-tests'), 08:16:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:41 INFO - 'download_minidump_stackwalk': True, 08:16:41 INFO - 'download_symbols': 'ondemand', 08:16:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:41 INFO - 'installer_path': 'installer.exe', 08:16:41 INFO - 'log_level': 'info', 08:16:41 INFO - 'log_name': 'talos', 08:16:41 INFO - 'log_to_console': True, 08:16:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:41 INFO - 'opt_config_files': (), 08:16:41 INFO - 'pip_index': False, 08:16:41 INFO - 'sps_profile': False, 08:16:41 INFO - 'sps_profile_interval': 0, 08:16:41 INFO - 'suite': 'dromaeojs', 08:16:41 INFO - 'system_bits': '32', 08:16:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:41 INFO - 'title': 'talos-linux64-ix-065', 08:16:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:41 INFO - 'use_talos_json': True, 08:16:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:41 INFO - 'work_dir': 'build'} 08:16:41 INFO - ##### 08:16:41 INFO - ##### Running clobber step. 08:16:41 INFO - ##### 08:16:41 INFO - Running pre-action listener: _resource_record_pre_action 08:16:41 INFO - Running main action method: clobber 08:16:41 INFO - rmtree: /builds/slave/test/build 08:16:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:42 INFO - Running post-action listener: _resource_record_post_action 08:16:42 INFO - ##### 08:16:42 INFO - ##### Finished clobber step (success) 08:16:42 INFO - ##### 08:16:42 INFO - ##### 08:16:42 INFO - ##### Running read-buildbot-config step. 08:16:42 INFO - ##### 08:16:42 INFO - Running pre-action listener: _resource_record_pre_action 08:16:42 INFO - Running main action method: read_buildbot_config 08:16:42 INFO - Using buildbot properties: 08:16:42 INFO - { 08:16:42 INFO - "project": "", 08:16:42 INFO - "product": "firefox", 08:16:42 INFO - "script_repo_revision": "production", 08:16:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:16:42 INFO - "repository": "", 08:16:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:16:42 INFO - "buildid": "20160608053005", 08:16:42 INFO - "pgo_build": "True", 08:16:42 INFO - "basedir": "/builds/slave/test", 08:16:42 INFO - "buildnumber": 1238, 08:16:42 INFO - "slavename": "talos-linux64-ix-065", 08:16:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:16:42 INFO - "platform": "ubuntu64_hw", 08:16:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:16:42 INFO - "branch": "fx-team", 08:16:42 INFO - "repo_path": "integration/fx-team", 08:16:42 INFO - "revision": "71d424246fe1149948c8054a4392feea87dfd0ad", 08:16:42 INFO - "stage_platform": "linux64-pgo", 08:16:42 INFO - "builduid": "aafcaa010bef433abf41399be340d089", 08:16:42 INFO - "slavebuilddir": "test" 08:16:42 INFO - } 08:16:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:16:42 INFO - Running post-action listener: _resource_record_post_action 08:16:42 INFO - ##### 08:16:42 INFO - ##### Finished read-buildbot-config step (success) 08:16:42 INFO - ##### 08:16:42 INFO - ##### 08:16:42 INFO - ##### Running download-and-extract step. 08:16:42 INFO - ##### 08:16:42 INFO - Running pre-action listener: _resource_record_pre_action 08:16:42 INFO - Running main action method: download_and_extract 08:16:42 INFO - mkdir: /builds/slave/test/build/tests 08:16:42 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')]} 08:16:42 INFO - https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:16:49 INFO - Downloaded 1361 bytes. 08:16:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:16:49 INFO - Using the following test package requirements: 08:16:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:16:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:16:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'jsshell-linux-x86_64.zip'], 08:16:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:16:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:16:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:16:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:16:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:16:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:16:49 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')]} 08:16:49 INFO - https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:16:58 INFO - Downloaded 24450994 bytes. 08:16:58 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'] 08:16:58 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 08:16:59 INFO - Return code: 0 08:16:59 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 08:16: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')]} 08:16:59 INFO - https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:17:00 INFO - Downloaded 24450994 bytes. 08:17:00 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'] 08:17:00 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 08:17:02 INFO - Return code: 0 08:17: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')]} 08:17:02 INFO - https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:17:03 INFO - Downloaded 10833369 bytes. 08:17:03 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'] 08:17:03 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 08:17:03 INFO - Return code: 0 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:03 INFO - https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:17:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bb8WlMVyQAezqZwfLOl9hw/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 08:17:04 INFO - Downloaded 59305674 bytes. 08:17:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:04 INFO - mkdir: /builds/slave/test/properties 08:17:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:04 INFO - Contents: 08:17:04 INFO - build_url:https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:05 INFO - Running post-action listener: _resource_record_post_action 08:17:05 INFO - Running post-action listener: set_extra_try_arguments 08:17:05 INFO - ##### 08:17:05 INFO - ##### Finished download-and-extract step (success) 08:17:05 INFO - ##### 08:17:05 INFO - ##### 08:17:05 INFO - ##### Running populate-webroot step. 08:17:05 INFO - ##### 08:17:05 INFO - Running pre-action listener: _resource_record_pre_action 08:17:05 INFO - Running main action method: populate_webroot 08:17:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:17:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:17:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:17:05 INFO - '--tppagecycles', 08:17:05 INFO - '7'], 08:17:05 INFO - 'tests': ['tsvgm']}}, 08:17:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:17:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:17:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['damp', 'tps']}, 08:17:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'tests': ['damp', 'tps']}, 08:17:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['dromaeo_dom']}, 08:17:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['a11yr', 08:17:05 INFO - 'ts_paint', 08:17:05 INFO - 'tpaint', 08:17:05 INFO - 'sessionrestore', 08:17:05 INFO - 'sessionrestore_no_auto_restore', 08:17:05 INFO - 'tabpaint']}, 08:17:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:05 INFO - 'ts_paint', 08:17:05 INFO - 'tpaint', 08:17:05 INFO - 'sessionrestore', 08:17:05 INFO - 'sessionrestore_no_auto_restore', 08:17:05 INFO - 'tabpaint']}, 08:17:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:17:05 INFO - 'ts_paint', 08:17:05 INFO - 'tpaint', 08:17:05 INFO - 'sessionrestore', 08:17:05 INFO - 'sessionrestore_no_auto_restore', 08:17:05 INFO - 'tabpaint']}, 08:17:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:17:05 INFO - 'ts_paint', 08:17:05 INFO - 'tpaint', 08:17:05 INFO - 'sessionrestore', 08:17:05 INFO - 'sessionrestore_no_auto_restore', 08:17:05 INFO - 'tabpaint']}, 08:17:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['a11yr', 08:17:05 INFO - 'ts_paint', 08:17:05 INFO - 'tpaint', 08:17:05 INFO - 'sessionrestore', 08:17:05 INFO - 'sessionrestore_no_auto_restore', 08:17:05 INFO - 'tabpaint']}, 08:17:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['a11yr', 08:17:05 INFO - 'ts_paint', 08:17:05 INFO - 'tpaint', 08:17:05 INFO - 'sessionrestore', 08:17:05 INFO - 'sessionrestore_no_auto_restore', 08:17:05 INFO - 'tabpaint']}, 08:17:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['tsvgx', 08:17:05 INFO - 'tsvgr_opacity', 08:17:05 INFO - 'tart', 08:17:05 INFO - 'tscrollx', 08:17:05 INFO - 'cart']}, 08:17:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:05 INFO - 'tsvgr_opacity', 08:17:05 INFO - 'tart', 08:17:05 INFO - 'tscrollx', 08:17:05 INFO - 'cart']}, 08:17:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'talos_options': ['--disable-e10s'], 08:17:05 INFO - 'tests': ['tp5o']}, 08:17:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'tests': ['tp5o']}, 08:17:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'talos_options': ['--disable-e10s', 08:17:05 INFO - '--xperf_path', 08:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:05 INFO - 'tests': ['tp5n']}, 08:17:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:05 INFO - 'talos_options': ['--xperf_path', 08:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:05 INFO - 'tests': ['tp5n']}}, 08:17:05 INFO - 'talos.zip': {'path': '', 08:17:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:17:05 INFO - Running post-action listener: _resource_record_post_action 08:17:05 INFO - ##### 08:17:05 INFO - ##### Finished populate-webroot step (success) 08:17:05 INFO - ##### 08:17:05 INFO - ##### 08:17:05 INFO - ##### Running create-virtualenv step. 08:17:05 INFO - ##### 08:17:05 INFO - Running pre-action listener: _resource_record_pre_action 08:17:05 INFO - Running main action method: create_virtualenv 08:17:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:05 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 08:17:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:17:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:05 INFO - Using real prefix '/usr' 08:17:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:08 INFO - Installing pip.................done. 08:17:08 INFO - Return code: 0 08:17:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:08 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:08 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 08:17:08 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 08:17:08 INFO - Using env: {'DISPLAY': ':0', 08:17:08 INFO - 'HOME': '/home/cltbld', 08:17:08 INFO - 'LANG': 'en_US.UTF-8', 08:17:08 INFO - 'LANGUAGE': 'en_US:en', 08:17:08 INFO - 'LOGNAME': 'cltbld', 08:17:08 INFO - 'MAIL': '/var/mail/cltbld', 08:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:08 INFO - 'MOZ_NO_REMOTE': '1', 08:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:08 INFO - 'NO_EM_RESTART': '1', 08:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:08 INFO - 'PWD': '/builds/slave/test', 08:17:08 INFO - 'SHELL': '/bin/bash', 08:17:08 INFO - 'SHLVL': '1', 08:17:08 INFO - 'TERM': 'linux', 08:17:08 INFO - 'TMOUT': '86400', 08:17:08 INFO - 'USER': 'cltbld', 08:17:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:08 INFO - '_': '/tools/buildbot/bin/python'} 08:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:08 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 08:17:08 INFO - Cleaning up... 08:17:08 INFO - Return code: 0 08:17:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:08 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:08 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 08:17:08 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 08:17:08 INFO - Using env: {'DISPLAY': ':0', 08:17:08 INFO - 'HOME': '/home/cltbld', 08:17:08 INFO - 'LANG': 'en_US.UTF-8', 08:17:08 INFO - 'LANGUAGE': 'en_US:en', 08:17:08 INFO - 'LOGNAME': 'cltbld', 08:17:08 INFO - 'MAIL': '/var/mail/cltbld', 08:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:08 INFO - 'MOZ_NO_REMOTE': '1', 08:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:08 INFO - 'NO_EM_RESTART': '1', 08:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:08 INFO - 'PWD': '/builds/slave/test', 08:17:08 INFO - 'SHELL': '/bin/bash', 08:17:08 INFO - 'SHLVL': '1', 08:17:08 INFO - 'TERM': 'linux', 08:17:08 INFO - 'TMOUT': '86400', 08:17:08 INFO - 'USER': 'cltbld', 08:17:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:08 INFO - '_': '/tools/buildbot/bin/python'} 08:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:08 INFO - Downloading/unpacking psutil>=3.1.1 08:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:10 INFO - Installing collected packages: psutil 08:17:10 INFO - Running setup.py install for psutil 08:17:10 INFO - building 'psutil._psutil_linux' extension 08:17:10 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 08:17:10 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 08:17:10 INFO - building 'psutil._psutil_posix' extension 08:17:10 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 08:17:10 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 08:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:11 INFO - Successfully installed psutil 08:17:11 INFO - Cleaning up... 08:17:11 INFO - Return code: 0 08:17:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17: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 mozsystemmonitor==0.3 08:17:11 INFO - Using env: {'DISPLAY': ':0', 08:17:11 INFO - 'HOME': '/home/cltbld', 08:17:11 INFO - 'LANG': 'en_US.UTF-8', 08:17:11 INFO - 'LANGUAGE': 'en_US:en', 08:17:11 INFO - 'LOGNAME': 'cltbld', 08:17:11 INFO - 'MAIL': '/var/mail/cltbld', 08:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:11 INFO - 'MOZ_NO_REMOTE': '1', 08:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:11 INFO - 'NO_EM_RESTART': '1', 08:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:11 INFO - 'PWD': '/builds/slave/test', 08:17:11 INFO - 'SHELL': '/bin/bash', 08:17:11 INFO - 'SHLVL': '1', 08:17:11 INFO - 'TERM': 'linux', 08:17:11 INFO - 'TMOUT': '86400', 08:17:11 INFO - 'USER': 'cltbld', 08:17:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:11 INFO - '_': '/tools/buildbot/bin/python'} 08:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:13 INFO - Installing collected packages: mozsystemmonitor 08:17:13 INFO - Running setup.py install for mozsystemmonitor 08:17:13 INFO - Successfully installed mozsystemmonitor 08:17:13 INFO - Cleaning up... 08:17:13 INFO - Return code: 0 08:17:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:13 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')]} 08:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:13 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')]} 08:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:13 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:13 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 08:17:13 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 08:17:13 INFO - Using env: {'DISPLAY': ':0', 08:17:13 INFO - 'HOME': '/home/cltbld', 08:17:13 INFO - 'LANG': 'en_US.UTF-8', 08:17:13 INFO - 'LANGUAGE': 'en_US:en', 08:17:13 INFO - 'LOGNAME': 'cltbld', 08:17:13 INFO - 'MAIL': '/var/mail/cltbld', 08:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:13 INFO - 'MOZ_NO_REMOTE': '1', 08:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:13 INFO - 'NO_EM_RESTART': '1', 08:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:13 INFO - 'PWD': '/builds/slave/test', 08:17:13 INFO - 'SHELL': '/bin/bash', 08:17:13 INFO - 'SHLVL': '1', 08:17:13 INFO - 'TERM': 'linux', 08:17:13 INFO - 'TMOUT': '86400', 08:17:13 INFO - 'USER': 'cltbld', 08:17:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:13 INFO - '_': '/tools/buildbot/bin/python'} 08:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:13 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:13 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 08:17:13 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 08:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:15 INFO - warning: no files found matching '*.txt' 08:17:15 INFO - no previously-included directories found matching 'build' 08:17:15 INFO - no previously-included directories found matching 'dist' 08:17:15 INFO - no previously-included directories found matching '.git*' 08:17:15 INFO - Installing collected packages: jsonschema, functools32 08:17:16 INFO - Running setup.py install for functools32 08:17:16 INFO - warning: no files found matching '*.txt' 08:17:16 INFO - no previously-included directories found matching 'build' 08:17:16 INFO - no previously-included directories found matching 'dist' 08:17:16 INFO - no previously-included directories found matching '.git*' 08:17:16 INFO - Successfully installed jsonschema functools32 08:17:16 INFO - Cleaning up... 08:17:16 INFO - Return code: 0 08:17:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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', '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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17: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 blobuploader==1.2.4 08:17:16 INFO - Using env: {'DISPLAY': ':0', 08:17:16 INFO - 'HOME': '/home/cltbld', 08:17:16 INFO - 'LANG': 'en_US.UTF-8', 08:17:16 INFO - 'LANGUAGE': 'en_US:en', 08:17:16 INFO - 'LOGNAME': 'cltbld', 08:17:16 INFO - 'MAIL': '/var/mail/cltbld', 08:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:16 INFO - 'MOZ_NO_REMOTE': '1', 08:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:16 INFO - 'NO_EM_RESTART': '1', 08:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:16 INFO - 'PWD': '/builds/slave/test', 08:17:16 INFO - 'SHELL': '/bin/bash', 08:17:16 INFO - 'SHLVL': '1', 08:17:16 INFO - 'TERM': 'linux', 08:17:16 INFO - 'TMOUT': '86400', 08:17:16 INFO - 'USER': 'cltbld', 08:17:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:16 INFO - '_': '/tools/buildbot/bin/python'} 08:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:19 INFO - Downloading docopt-0.6.1.tar.gz 08:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:19 INFO - Running setup.py install for blobuploader 08:17:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:19 INFO - Running setup.py install for requests 08:17:19 INFO - Running setup.py install for docopt 08:17:19 INFO - Successfully installed blobuploader requests docopt 08:17:19 INFO - Cleaning up... 08:17:19 INFO - Return code: 0 08:17:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:19 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:19 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 08:17:19 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 08:17:19 INFO - Using env: {'DISPLAY': ':0', 08:17:19 INFO - 'HOME': '/home/cltbld', 08:17:19 INFO - 'LANG': 'en_US.UTF-8', 08:17:19 INFO - 'LANGUAGE': 'en_US:en', 08:17:19 INFO - 'LOGNAME': 'cltbld', 08:17:19 INFO - 'MAIL': '/var/mail/cltbld', 08:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:19 INFO - 'MOZ_NO_REMOTE': '1', 08:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:19 INFO - 'NO_EM_RESTART': '1', 08:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:19 INFO - 'PWD': '/builds/slave/test', 08:17:19 INFO - 'SHELL': '/bin/bash', 08:17:19 INFO - 'SHLVL': '1', 08:17:19 INFO - 'TERM': 'linux', 08:17:19 INFO - 'TMOUT': '86400', 08:17:19 INFO - 'USER': 'cltbld', 08:17:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:19 INFO - '_': '/tools/buildbot/bin/python'} 08:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:19 INFO - Running setup.py (path:/tmp/pip-KLej9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:19 INFO - Running setup.py (path:/tmp/pip-6FrFMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:20 INFO - Running setup.py (path:/tmp/pip-2u6rsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:20 INFO - Running setup.py (path:/tmp/pip-txnyHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:20 INFO - Running setup.py (path:/tmp/pip-x1qi_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:20 INFO - Running setup.py (path:/tmp/pip-3MtWAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:20 INFO - Running setup.py (path:/tmp/pip-K_F114-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:20 INFO - Running setup.py (path:/tmp/pip-ha0xq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:20 INFO - Running setup.py (path:/tmp/pip-a_zB8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:20 INFO - Running setup.py (path:/tmp/pip-XGwSCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:20 INFO - Running setup.py (path:/tmp/pip-0D9PCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:20 INFO - Running setup.py (path:/tmp/pip-2n4AgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:20 INFO - Running setup.py (path:/tmp/pip-60tTJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:20 INFO - Running setup.py (path:/tmp/pip-wRT8Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:20 INFO - Running setup.py (path:/tmp/pip-8ThgCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:21 INFO - Running setup.py (path:/tmp/pip-EyX8Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:21 INFO - Running setup.py (path:/tmp/pip-Ps2hSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:21 INFO - Running setup.py install for manifestparser 08:17:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Running setup.py install for mozcrash 08:17:21 INFO - Running setup.py install for mozdebug 08:17:21 INFO - Running setup.py install for mozdevice 08:17:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Running setup.py install for mozfile 08:17:21 INFO - Running setup.py install for mozhttpd 08:17:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Running setup.py install for mozinfo 08:17:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Running setup.py install for mozInstall 08:17:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:21 INFO - Running setup.py install for mozleak 08:17:22 INFO - Running setup.py install for mozlog 08:17:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Running setup.py install for moznetwork 08:17:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Running setup.py install for mozprocess 08:17:22 INFO - Running setup.py install for mozprofile 08:17:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Running setup.py install for mozrunner 08:17:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Running setup.py install for mozscreenshot 08:17:22 INFO - Running setup.py install for moztest 08:17:22 INFO - Running setup.py install for mozversion 08:17:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:22 INFO - Cleaning up... 08:17:22 INFO - Return code: 0 08:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:22 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:22 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 08:17:22 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 08:17:22 INFO - Using env: {'DISPLAY': ':0', 08:17:22 INFO - 'HOME': '/home/cltbld', 08:17:22 INFO - 'LANG': 'en_US.UTF-8', 08:17:22 INFO - 'LANGUAGE': 'en_US:en', 08:17:22 INFO - 'LOGNAME': 'cltbld', 08:17:22 INFO - 'MAIL': '/var/mail/cltbld', 08:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:22 INFO - 'MOZ_NO_REMOTE': '1', 08:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:22 INFO - 'NO_EM_RESTART': '1', 08:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:22 INFO - 'PWD': '/builds/slave/test', 08:17:22 INFO - 'SHELL': '/bin/bash', 08:17:22 INFO - 'SHLVL': '1', 08:17:22 INFO - 'TERM': 'linux', 08:17:22 INFO - 'TMOUT': '86400', 08:17:22 INFO - 'USER': 'cltbld', 08:17:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:22 INFO - '_': '/tools/buildbot/bin/python'} 08:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:23 INFO - Running setup.py (path:/tmp/pip-lpS0kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:23 INFO - Running setup.py (path:/tmp/pip-ipOLEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:23 INFO - Running setup.py (path:/tmp/pip-2AQZp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:23 INFO - Running setup.py (path:/tmp/pip-Z4tYd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:23 INFO - Running setup.py (path:/tmp/pip-SgWHQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:23 INFO - Running setup.py (path:/tmp/pip-sbGWt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:23 INFO - Running setup.py (path:/tmp/pip-w0EpJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:23 INFO - Running setup.py (path:/tmp/pip-vRsnXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:23 INFO - Running setup.py (path:/tmp/pip-c6pPZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:23 INFO - Running setup.py (path:/tmp/pip-Rr9VgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:23 INFO - Running setup.py (path:/tmp/pip-o_OwIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:23 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)) 08:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:23 INFO - Running setup.py (path:/tmp/pip-hQb3qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:24 INFO - Running setup.py (path:/tmp/pip-A03GLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:24 INFO - Running setup.py (path:/tmp/pip-QOUSKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:24 INFO - Running setup.py (path:/tmp/pip-ofrrHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:24 INFO - Running setup.py (path:/tmp/pip-XCmy6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:24 INFO - Running setup.py (path:/tmp/pip-JVtvO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:24 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)) 08:17:24 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)) 08:17:24 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)) 08:17:24 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)) 08:17:24 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)) 08:17:24 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)) 08:17:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:24 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 08:17:24 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 08:17:24 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 08:17:24 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 08:17:24 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 08:17:24 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 08:17:26 INFO - Downloading blessings-1.6.tar.gz 08:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:26 INFO - Installing collected packages: blessings 08:17:26 INFO - Running setup.py install for blessings 08:17:26 INFO - Successfully installed blessings 08:17:26 INFO - Cleaning up... 08:17:26 INFO - Return code: 0 08:17:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:26 INFO - Reading from file tmpfile_stdout 08:17:26 INFO - Current package versions: 08:17:26 INFO - argparse == 1.2.1 08:17:26 INFO - blessings == 1.6 08:17:26 INFO - blobuploader == 1.2.4 08:17:26 INFO - docopt == 0.6.1 08:17:26 INFO - functools32 == 3.2.3-2 08:17:26 INFO - jsonschema == 2.5.1 08:17:26 INFO - manifestparser == 1.1 08:17:26 INFO - mozInstall == 1.12 08:17:26 INFO - mozcrash == 0.17 08:17:26 INFO - mozdebug == 0.1 08:17:26 INFO - mozdevice == 0.48 08:17:26 INFO - mozfile == 1.2 08:17:26 INFO - mozhttpd == 0.7 08:17:26 INFO - mozinfo == 0.9 08:17:26 INFO - mozleak == 0.1 08:17:26 INFO - mozlog == 3.2 08:17:26 INFO - moznetwork == 0.27 08:17:26 INFO - mozprocess == 0.22 08:17:26 INFO - mozprofile == 0.28 08:17:26 INFO - mozrunner == 6.11 08:17:26 INFO - mozscreenshot == 0.1 08:17:26 INFO - mozsystemmonitor == 0.3 08:17:26 INFO - moztest == 0.7 08:17:26 INFO - mozversion == 1.4 08:17:26 INFO - psutil == 3.1.1 08:17:26 INFO - requests == 1.2.3 08:17:26 INFO - wsgiref == 0.1.2 08:17:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:26 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:26 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 08:17:26 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 08:17:26 INFO - Using env: {'DISPLAY': ':0', 08:17:26 INFO - 'HOME': '/home/cltbld', 08:17:26 INFO - 'LANG': 'en_US.UTF-8', 08:17:26 INFO - 'LANGUAGE': 'en_US:en', 08:17:26 INFO - 'LOGNAME': 'cltbld', 08:17:26 INFO - 'MAIL': '/var/mail/cltbld', 08:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:26 INFO - 'MOZ_NO_REMOTE': '1', 08:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:26 INFO - 'NO_EM_RESTART': '1', 08:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:26 INFO - 'PWD': '/builds/slave/test', 08:17:26 INFO - 'SHELL': '/bin/bash', 08:17:26 INFO - 'SHLVL': '1', 08:17:26 INFO - 'TERM': 'linux', 08:17:26 INFO - 'TMOUT': '86400', 08:17:26 INFO - 'USER': 'cltbld', 08:17:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:26 INFO - '_': '/tools/buildbot/bin/python'} 08:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 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)) 08:17:26 INFO - Cleaning up... 08:17:26 INFO - Return code: 0 08:17:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:26 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:26 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 08:17:26 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 08:17:26 INFO - Using env: {'DISPLAY': ':0', 08:17:26 INFO - 'HOME': '/home/cltbld', 08:17:26 INFO - 'LANG': 'en_US.UTF-8', 08:17:26 INFO - 'LANGUAGE': 'en_US:en', 08:17:26 INFO - 'LOGNAME': 'cltbld', 08:17:26 INFO - 'MAIL': '/var/mail/cltbld', 08:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:26 INFO - 'MOZ_NO_REMOTE': '1', 08:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:26 INFO - 'NO_EM_RESTART': '1', 08:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:26 INFO - 'PWD': '/builds/slave/test', 08:17:26 INFO - 'SHELL': '/bin/bash', 08:17:26 INFO - 'SHLVL': '1', 08:17:26 INFO - 'TERM': 'linux', 08:17:26 INFO - 'TMOUT': '86400', 08:17:26 INFO - 'USER': 'cltbld', 08:17:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:26 INFO - '_': '/tools/buildbot/bin/python'} 08:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:27 INFO - Cleaning up... 08:17:27 INFO - Return code: 0 08:17:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:17:27 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')]} 08:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:27 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')]} 08:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:27 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 0x7f4c595aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2939350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, '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': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', '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 08:17:27 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 08:17:27 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 08:17:27 INFO - Using env: {'DISPLAY': ':0', 08:17:27 INFO - 'HOME': '/home/cltbld', 08:17:27 INFO - 'LANG': 'en_US.UTF-8', 08:17:27 INFO - 'LANGUAGE': 'en_US:en', 08:17:27 INFO - 'LOGNAME': 'cltbld', 08:17:27 INFO - 'MAIL': '/var/mail/cltbld', 08:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:27 INFO - 'MOZ_NO_REMOTE': '1', 08:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:27 INFO - 'NO_EM_RESTART': '1', 08:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:27 INFO - 'PWD': '/builds/slave/test', 08:17:27 INFO - 'SHELL': '/bin/bash', 08:17:27 INFO - 'SHLVL': '1', 08:17:27 INFO - 'TERM': 'linux', 08:17:27 INFO - 'TMOUT': '86400', 08:17:27 INFO - 'USER': 'cltbld', 08:17:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:27 INFO - '_': '/tools/buildbot/bin/python'} 08:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:27 INFO - Downloading/unpacking flake8 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:17:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:17:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:17:30 INFO - no previously-included directories found matching 'docs/_build' 08:17:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:17:30 INFO - Running setup.py install for pep8 08:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:17:30 INFO - no previously-included directories found matching 'docs/_build' 08:17:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:17:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:17:30 INFO - Cleaning up... 08:17:30 INFO - Return code: 0 08:17:30 INFO - Running post-action listener: _resource_record_post_action 08:17:30 INFO - Running post-action listener: _start_resource_monitoring 08:17:30 INFO - Starting resource monitoring. 08:17:30 INFO - ##### 08:17:30 INFO - ##### Finished create-virtualenv step (success) 08:17:30 INFO - ##### 08:17:30 INFO - ##### 08:17:30 INFO - ##### Running install step. 08:17:30 INFO - ##### 08:17:30 INFO - Running pre-action listener: _resource_record_pre_action 08:17:30 INFO - Running main action method: install 08:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:30 INFO - Reading from file tmpfile_stdout 08:17:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:30 INFO - Reading from file tmpfile_stdout 08:17:30 INFO - Output received: 08:17:30 INFO - Usage: mozinstall [options] installer 08:17:30 INFO - Options: 08:17:30 INFO - -h, --help show this help message and exit 08:17:30 INFO - -d DEST, --destination=DEST 08:17:30 INFO - Directory to install application into. [default: 08:17:30 INFO - "/builds/slave/test"] 08:17:30 INFO - --app=APP Application being installed. [default: firefox] 08:17:30 INFO - mkdir: /builds/slave/test/build/application 08:17:30 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'] 08:17:30 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 08:17:47 INFO - Reading from file tmpfile_stdout 08:17:47 INFO - Output received: 08:17:47 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:47 INFO - Running post-action listener: _resource_record_post_action 08:17:47 INFO - ##### 08:17:47 INFO - ##### Finished install step (success) 08:17:47 INFO - ##### 08:17:47 INFO - ##### 08:17:47 INFO - ##### Running run-tests step. 08:17:47 INFO - ##### 08:17:47 INFO - Running pre-action listener: _resource_record_pre_action 08:17:47 INFO - Running main action method: run_tests 08:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:47 INFO - Python 2.7.3 08:17:47 INFO - Return code: 0 08:17:47 INFO - grabbing minidump binary from tooltool 08:17:47 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')]} 08:17:47 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 0x29c81c0>, '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 0x29c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:47 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 08:17:47 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 08:17:47 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 08:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:47 INFO - Return code: 0 08:17:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:17:48 INFO - Return code: 0 08:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:17:48 INFO - Using env: {'DISPLAY': ':0', 08:17:48 INFO - 'HOME': '/home/cltbld', 08:17:48 INFO - 'LANG': 'en_US.UTF-8', 08:17:48 INFO - 'LANGUAGE': 'en_US:en', 08:17:48 INFO - 'LOGNAME': 'cltbld', 08:17:48 INFO - 'MAIL': '/var/mail/cltbld', 08:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:48 INFO - 'MOZ_NO_REMOTE': '1', 08:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:48 INFO - 'NO_EM_RESTART': '1', 08:17:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:48 INFO - 'PWD': '/builds/slave/test', 08:17:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:48 INFO - 'SHELL': '/bin/bash', 08:17:48 INFO - 'SHLVL': '1', 08:17:48 INFO - 'TERM': 'linux', 08:17:48 INFO - 'TMOUT': '86400', 08:17:48 INFO - 'USER': 'cltbld', 08:17:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347', 08:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:48 INFO - '_': '/tools/buildbot/bin/python'} 08:17:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:17:48 INFO - mozversion application_buildid: 20160608053005 08:17:48 INFO - mozversion application_changeset: 71d424246fe1149948c8054a4392feea87dfd0ad 08:17:48 INFO - mozversion application_display_name: Nightly 08:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:48 INFO - mozversion application_name: Firefox 08:17:48 INFO - mozversion application_remotingname: firefox 08:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:17:48 INFO - mozversion application_vendor: Mozilla 08:17:48 INFO - mozversion application_version: 50.0a1 08:17:48 INFO - mozversion platform_buildid: 20160608053005 08:17:48 INFO - mozversion platform_changeset: 71d424246fe1149948c8054a4392feea87dfd0ad 08:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:17:48 INFO - mozversion platform_version: 50.0a1 08:17:48 INFO - using testdate: 1465399068 08:17:48 INFO - actual date: 1465399068 08:17:48 INFO - starting webserver on 'localhost:40961' 08:17:48 INFO - SUITE-START | Running 2 tests 08:17:48 INFO - TEST-START | dromaeo_css 08:17:48 INFO - operating with platform_type : linux_ 08:17:48 INFO - Initialising browser for dromaeo_css test... 08:17:48 INFO - TEST-INFO | started process 11672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMdf4P0/profile http://localhost:40961/getInfo.html) 08:17:52 INFO - PROCESS | 11672 | __metrics Screen width/height:1600/1200 08:17:52 INFO - PROCESS | 11672 | colorDepth:24 08:17:52 INFO - PROCESS | 11672 | Browser inner width/height: 1024/697 08:17:52 INFO - PROCESS | 11672 | __metrics 08:17:53 ERROR - PROCESS | 11672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:17:53 INFO - PROCESS | 11672 | console.error: PushService: 08:17:53 INFO - PROCESS | 11672 | stateChangeProcessEnqueue: Error transitioning state 08:17:53 INFO - PROCESS | 11672 | UnknownError 08:17:54 INFO - TEST-INFO | 11672: exit 0 08:17:54 INFO - Browser initialized. 08:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:54 INFO - TEST-INFO | started process 11756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMdf4P0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:06 INFO - PROCESS | 11756 | RSS: Main: 156049408 08:18:06 INFO - PROCESS | 11756 | 08:18:57 INFO - PROCESS | 11756 | 1465399137451 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] 08:21:05 INFO - PROCESS | 11756 | Cycle 1(1): loaded http://localhost:40961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40961/tests/dromaeo/cssquery-ext.html) 08:21:06 INFO - PROCESS | 11756 | RSS: Main: 260448256 08:21:06 INFO - PROCESS | 11756 | 08:24:08 INFO - PROCESS | 11756 | Cycle 1(1): loaded http://localhost:40961/tests/dromaeo/cssquery-ext.html (next: http://localhost:40961/tests/dromaeo/cssquery-jquery.html) 08:24:09 INFO - PROCESS | 11756 | RSS: Main: 238391296 08:24:09 INFO - PROCESS | 11756 | 08:27:11 INFO - PROCESS | 11756 | Cycle 1(1): loaded http://localhost:40961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40961/tests/dromaeo/cssquery-mootools.html) 08:27:11 INFO - PROCESS | 11756 | RSS: Main: 246988800 08:27:11 INFO - PROCESS | 11756 | 08:30:13 INFO - PROCESS | 11756 | Cycle 1(1): loaded http://localhost:40961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40961/tests/dromaeo/cssquery-prototype.html) 08:30:14 INFO - PROCESS | 11756 | RSS: Main: 240816128 08:30:14 INFO - PROCESS | 11756 | 08:33:16 INFO - PROCESS | 11756 | Cycle 1(1): loaded http://localhost:40961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40961/tests/dromaeo/cssquery-yui.html) 08:33:17 INFO - PROCESS | 11756 | RSS: Main: 220327936 08:33:17 INFO - PROCESS | 11756 | 08:36:19 INFO - PROCESS | 11756 | Cycle 1(1): loaded http://localhost:40961/tests/dromaeo/cssquery-yui.html (next: http://localhost:40961/tests/dromaeo/cssquery-dojo.html) 08:36:20 INFO - PROCESS | 11756 | RSS: Main: 287068160 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | __start_tp_report 08:36:20 INFO - PROCESS | 11756 | _x_x_mozilla_page_load 08:36:20 INFO - PROCESS | 11756 | _x_x_mozilla_page_load_details 08:36:20 INFO - PROCESS | 11756 | |i|pagename|runs| 08:36:20 INFO - PROCESS | 11756 | |0;dojo.html;3178.6662400447954;3193.3294008258263;3213.8393080345986;3227.5158726191084;3254.4304746669327;5300.072487314724;5377.247185394048;5397.514223719864;5520.66875987441;5546.389897111315;5394.541463975557;5416.566674666027;5461.9453805462035;5470.425605311445;5490.3411590609085;4896.804127834891;4966.553010229079;4987.675801072919;4995.900081998358;5140.357455318085;5034.949650503485;5040.823571175009;5077.49225077493;5095.847124586268;5103.311053007834;4834.057358815033;4847.854564363057;4879.975600122012;4892.779824907888;4899.853004409873;4880.2435622478215;4896.804127834882;4943.1102401567705;4966.5778408835295;4981.526754958273;4825.131476334259;4925.655204135712;4934.580560652349;4941.604671626261;4963.106640804654;5274.97362513185;5354.678719276856;5358.035553600351;5428.212909128154;5455.290812194429;5914.467697907209;5916.083007133901;5939.554533410012;5939.762409503614;5945.672987985659;5671.7731290748325;5708.971455142698;5911.320198177222;5918.852028699274;5984.162217289583;5360.91958620621;5422.322209723785;5466.289382380305;5470.206820011116;5478.890422191534;5958.821235362946;5976;5978.222831031938;5978.850528736816;5979.222701048836;5597.720113994284;5685.687287199244;5721.685307308138;5724.313082430135;5729.942700573024;5773.24947756789;5820;5826.388229235954;5827.7668893244645;5839.532837373;5707.34365547959;5737.569682273846;5752.165935939265;5754.683492407874;5755.539556835443;5634.04221282383;5735.627184233012;5753.568482363839;5811.767529298781;5821.767129314865;4474.194644963873;4474.6867719259335;4479.731216127043;4480.32795080734;4510.684252102321;3980.900477488086;3987.282289187916;3994.3609022556834;4009.318415869251;4026.1947610478023;5382.569394448435;5432.13085906261;5438.972805135949;5454;5496.697681627549;5815.534757219412;5863.472287494146;5870.236869207061;5874.530037596982;5915.319738230159;5304.787808487617;5530.557555395559;5543.556515478752;5550.6669599823335;5552.833414997556;4859.465458799529;4908.288298196813;4909.26361045846;4912.263160525878;4935.629827762932;6052.697365131726;6054.455099041107;6059.424354686298;6061.090836374579;6061.1514387984835;5677;5684.801031964027;5838.854028649318;5851.912221316768;5852.4440178183;5887.941120588739;5960.225170727777;5965.075413310944;5979;6026.819195423969;5634.098544232903;5675.659460432387;5683.261176047087;5688.687122208153;5693.572982026281;5726;5750.367459579526;5760.683162426107;5770.076787713946;5796.072628379439;5639.013172694844;5650.378458369658;5653.745581448762;5658.971705141613;5687.090065589486;5596.636218645775;5635.408282130481;5650.830475085754;5651;5653.830385088454;5451.427600102091;5542.196381524575;5553.500184983371;5648.57635677334;5655;5780.913286300624;5801.158831969426;5844.415558444121;5848.093545500455;5858.414158584107;5606.467385598362;5666.631668941505;5670.631408958405;5676.34722006958;5711.143328500758 08:36:20 INFO - PROCESS | 11756 | |1;ext.html;580.5210701171532;621.937806219378;632.7310892870529;640.6604499615204;647.1910112359551;30218.395632087373;41335.79332103339;41776.164476710444;41829;41853.372199417;44631.77684111583;45386.54613453864;45393.54606453943;45446.77276613621;45472.54527454724;8356.582170891477;8520.488770673748;8523.360747943898;8531.06158322584;8536.530490823003;8604.225619694227;8756.124387561256;8765.517896515721;8771.166739159802;8771.605277762485;8758.124187581254;8813.074627164151;8816.955915220415;8817.470951742884;8823.95588022059;8709.259712924377;8757.56212189388;8765.123487651248;8767.991680956677;8769.693060742844;8627.6980305689;8742.30061595071;8748.518831464267;8750.256228220609;8754.124587541259;41766.79116604428;42176;42209.577904220874;42238.366424503656;42258.36612450816;3424.74314426419;3428.777129486575;3510.7893526388243;3512.473129030666;3816.5229346331707;30678;30950.0714978551;31409.685903140904;31482.842585787155;31508.527372089437;4138.213739389506;4230.2174097792;4257.76582287974;4305.63402110821;4374.387585737967;331178;335950;336792;336944;337214;55627.72186139043;55856.72071639616;55982.16026759602;56077.598060048826;56143.71928140333;59347.70326148428;59396.109058364156;59453.70273148607;59475.405245947855;59503.40496594978;16622.168891555375;16922;16925.915370423314;16927.407540736014;16934;13085.869141308656;13181.60455186346;13209;13216.73566528664;13224.669383265495;15415.306311216022;15504.457343992906;15647.843521564866;15713.607159821097;15848.841511584968;5331.1470164773455;5948.122539517554;6145.477634401037;6151.384861513902;6238.812835614939;975.9463229522303;1053.4574694032578;1099.8570185875944;1143.6511863881597;1184.810430331143;31158.22104447407;31272.84363578213;31442.685573143975;31809.681903181136;32285.192870178435;1132.3206076354286;1173.5833779008499;1206.1436380170003;1243.7015116372186;1254.1095821966323;15526.543265074946;16078.750618048365;16220.188990550425;16457.42399016029;16487;512822;516202;516812;517692;520329;56476.43523564712;56749.71625141848;56754.71622641943;56756;56760.716196418754;1265.3483456020158;1362.4413990263945;1395.386030146732;1395.5673741140279;1395.874371306567;31358.37283254368;32230.516542251415;32464;32603.673963260062;32619.673803262613;47723.28415073846;47856.76071619619;48085.5191448081;48261.276080858115;48301.5169848297;398706;399568;399976;400207;401233;34585.827070864485;38571.80714096411;39006.219875602896;39103.2179356417;42096.57903421049;46306.30540541962;46348;47003.29495057509;47118.29322560233;47392.28911566398;37970.24059518739;39141.41287880741;39448.802755986035;39570.208595827346;40064.39903401393;36962.8151859239;38849.22301553896;38927.221455570165;39099.413508796824;39201.607983920934;38725.61274387333;39530;39848.60151398449;39924.40113398359;39985.80007100062;32636.184095397806;34640.30719385648;34979.12552186216;35061.29877402387;35231.11922201965;26953.78707958186;27234.863825680746;27264.59103113415;27483.725162748116;27735.58396624012 08:36:20 INFO - PROCESS | 11756 | |2;jquery.html;399.43679412029036;399.7062159312906;403.58430816259244;405.66532610596266;413.4453615673428;17700.203490842912;19239.71140432893;19241.32655357061;19351.903240483814;20078.799212007874;18384.356547520838;18755.624887502243;19049.333273335436;19130.904345478288;19309.710354344697;5548.195511650808;5595.776168953237;5701.828945131652;5843.328017278003;5906.143609176666;5898.734556944926;5917.763289468416;5922.88154236915;5928.911066334009;5955.076963070731;5933.3473317934995;6341.5877967932165;6471.708773105222;6476.676166191695;6505.544611877171;5965.313988891289;6165.32181460039;6415.358464153594;6469.223693156804;6470.288268290507;5632.3804381518;5721.9427805721825;5750.769969201268;5774.364819869811;5776.566757493163;13986.580402587939;17120.828791712047;21729.567608097976;22815.657765133536;22854.428639283986;2228.732552093743;2259.5932732108213;2292.1404473322505;2292.6561015847587;2323.8605683659034;9855.605775768961;10034.799304013879;10061.446620435872;10156.187504999582;10489.58041678332;1907.3229003703764;1915.1357341270832;1957.6769832977684;1993.6810110382414;2002.7997200280001;80940.59529702314;81027;81557.59221203915;81892.59053704752;83314.16685833124;10890;11052.557897684002;11094.5562177512;11135.888641113646;11218.943905280421;15512.689746205013;15519.5256450637;15584.610384740472;15671.294791734399;15697.194822595548;7985.760427187193;8226.588670566567;8239.299659529008;8313.542755148404;8372.706955256659;7768.611569421506;7876.369890408868;7894.842103157905;8025.879611805827;8042.075161356402;4686.437627484655;4747.264174053027;4791.98736530658;4812.663113582015;4856.1987272099705;1940.62157879215;1943.2129987355145;1957.0899531717535;1973.940781776549;2002.5694475687505;926.9629214831466;975.9463229522303;983.6245467196783;991.3506653142204;1023.3808545829814;18214.17680259562;18224.179911903997;18965.43103706891;19210.423687289403;19289.421317360502;965.4882912056621;1005.1255407795265;1006.8942761009988;1015.304516406264;1044.6239353832614;10326.48367581618;10665.786684266272;10719.571217151226;10743.301685390425;10782.245242832927;465461;500785;503269;504316;509388;92935;94933;95173.5241323789;96150;96156.51921740487;963.8939716631165;971.582219645545;993.6770549571419;999.3504222255447;1006.1799633298838;16531;16594.58513537171;16729.91255568384;16950.57623559421;17124.743128852828;31620.209494762814;39199.41200882046;39280.607193927695;41484;41968.79015604902;56278;56835;59482.70258648679;59797.40202597919;59947.305006024355;12404.19372740769;12411.255324680547;12636.431360588611;12981.480740770263;13053.08628396041;13611.931940340235;14090.22503762303;14112.858871411565;14133.363998619881;14305.713885722436;7791.571463569559;11831.881681183078;11890.583829565923;12300.384980751105;12687.555935542212;11646.767064658829;11718.765624687629;11792.23350482216;12014.579489717818;12392.132550721724;12045.819312710491;12151.210171338835;12193.939030304791;12240.387980600755;12273.140880138662;12219.203302005695;12342.382880855741;12396.752064958831;12428.254304741744;12601.684957876127;11666.824997624874;11793.292402455538;11937.164398492023;11959.162858599815;12510.437030333838 08:36:20 INFO - PROCESS | 11756 | |3;mootools.html;1322.0547308674295;1518.0208765346351;1547.9829841561148;1661.3354658136743;1792.2920446423655;8572.099929507405;8888.911110888897;8899.866502002475;9230.67692630758;9257.76855578611;8993.23557497612;9197.90802091979;9198;9198.724038278862;9199;2406.8676222807694;2445;2446.706395232575;2447.8286519943613;2449.155041510685;2392.4856155926473;2439.5974664180476;2464.199135281032;2464.963025554618;2469.592517234654;2432.1823839939098;2445.7921076708412;2447.1068060158004;2453.55835949529;2454.104251948044;2364.9645255321184;2367.585672507313;2392.1507864708037;2404.963925541127;2426.5268272686835;2324.5118525109747;2365.751596082404;2414.4567472318763;2415.3961509622595;2418.504206637635;7913.129555748863;8347.332213422973;8992.550372481415;9080.228180604656;9090.2273306769;5362.973185134088;5555.833325000216;5620.269364982567;5621.381648018714;5628.662280263197;3278.459054256045;3346.130006198406;3406.591209054929;3417.79493230407;3436.1066122808;1156.7166044319113;1171.6367925942984;1201.2072032458623;1204.680759598707;1215.629233083909;12835.743285134338;12981.87018129816;12991.61025169237;12997.15518491295;12998.635143310006;4877.756112194447;4934.777934992934;5002.299678045077;5009.674371165863;5047.545720885138;10945.233833631728;10994.28537145083;11006.889931100586;11030.06244469229;11031.393273369882;5469.972650136803;5483.725813709299;5527.364353099445;5533.667979921218;5534.667919924817;4918.5573298403315;4987.650864439527;5049;5076.74616269185;5144.2283657450935;3969.7221194516683;4000.9399859002137;4083.7549747015273;4094.406311084876;4111.527174374985;1270.7966725323904;1273.923564586128;1278.5397256987478;1289.155603079984;1315.6842357834241;835.2107258640526;835.2858306148278;983.4148681534475;985.472772066955;1025.6974192613197;6051.213342265477;6151.231096112986;6167.599106058092;6253.3121356651645;6359.427651511386;466.95330466953715;475.25385145321513;475.79540797457423;476.9785359658824;488.03369328729315;4213.220554197422;4290.141971605692;4312.89217769552;4316.395704601358;4341.565843415633;11093.223474356879;11377.488013039432;11430.828537571942;11445.313281203154;11460.828087578693;11480.655580332603;11509.71225719347;11526.308421494738;11538.653840384803;11578.826317605242;8141.674333026613;8463.026751923484;8559.74320770378;8567.186117318844;8580.14198580137;6293.811185664437;6359.904601431075;6453.580517266362;6507.28419873823;6559.967200163968;10478.947605261925;10548.261621686408;10719.035286824223;10740.409277489813;10757;10832.5125369357;10949.83575246356;10957.83563246568;11010.834837477283;11114.333140011626;8260.421770476009;8264.545450000307;8284.50292982423;8312.21034001769;8352.0812710603;8827.779305517413;8906.287497000354;8919.152680495343;8991.325650576102;9047.457152570867;8009;8106.47307924983;8140.674373025013;8227.465214761021;8254.380921431037;7748.302652761278;7845.215478452109;7930.722424715107;7988.121306656147;8120.959395202986;7182.820429489305;7517.02278703765;7517.135529414188;7518.736844210426;7524.623768811647;5191.558717509054;5259.42146363892;5329.440408757025;5331.413544510178;5431.131019036935;5403.6217464778665;5418.078926582411;5445.101558243004;5499.477549632778;5521.509192517918 08:36:20 INFO - PROCESS | 11756 | |4;prototype.html;331.9369319829232;337.69101272335814;339.67900334184174;341.5082281514619;344.6381299635384;5302.8144014959435;5304.602154838388;5345.652532585379;5348.545373643245;5354.839354819362;5263.210518422238;5271.472852714726;5287;5296.25852380667;5298.947010529893;3835.753380151448;3969.940450893246;4043.5147782266167;4050.574689657588;4174.35297528882;4055.71609987301;4143.958560414402;4179.979100104495;4184.811683474236;4189.224993376235;4093.9181216375655;4104.507459104897;4107.17856428714;4116.938245926299;4134.855280065199;3880.555250192375;4031.395290706388;4069.491313585802;4092.856750013735;4133.73130746502;3610.801405922673;3626.256617393428;3639.1448009717697;3642.5446819147605;3654.196076863086;5063.392392912837;5078.162103252959;5088.669236499616;5092.719900405476;5098.158803797369;4575.794089265958;4609.884752881171;4700.929486057677;4730.219513780222;4732.219183834663;5455.481729235756;5487.533559647435;5490.56075513958;5507.421720719307;5544.722763861791;3965.8499035279733;3966.8099570129134;3974.145558704892;3981.064449854282;3982.8691649967127;5471.671699698031;5652.547796176296;5733.569982251306;5764.769409223626;5793.913091303634;4048.6963477739287;4052.169305292408;4055;4075.083106301118;4077.245709543744;4081.2041651878194;4084.81618327176;4090.8159132839096;4098.139390727981;4115.855945041909;4524.258160608189;4657.836975705834;4667.346571479996;4673.621281721832;4684.789184486706;5524.315083899369;5553.805616803393;5554.389017208104;5557.3331200256225;5573.637713548606;1399.167495340271;1420.808190894216;1426.265473281261;1433.8351089624828;1435.2034620785564;880.0419067574724;887.5961437545901;918.8116436130578;921.7142086788892;933.7758937855002;5253.632245742761;5333.200019997032;5339.439358867263;5364.91952620711;5399.460053994648;5564.638298510584;5655.349634792052;5673.347565030074;5676.943230567724;5693.146028095819;5113.718745469035;5331.600129990266;5354.330708661418;5364.8122315718765;5405.567554595623;3005.353848922492;3014.593029940974;3028.8182709037087;3044.939101217963;3060.556219348182;5874.676892770939;5897.2333596633025;5901.911471327933;5913.586048976616;5915.497182739516;5544.972275138679;5758.798442054508;5765.88468230633;5797.971010144923;5853.0635098384055;5880.353161152269;5898.64608123514;5924.289085309791;5928.822135335947;5942.524598032147;5426.2674538936735;5622.522085622604;5664.448840136607;5691.459311365414;5734.598578099493;5605.775768969195;5632.239647647515;5638.335082196605;5697.6296540724725;5712.7714891403875;5917.615355002084;5919.69766651336;5946.513371657085;5950.702464876826;5961.940380596138;3997.2804895119157;4078.6125318094732;4078.6125318094732;4091.6726661866383;4104.507459104927;5728.226689396878;5741.339745929272;5757.625754325955;5772.278465191851;5814.273215848019;5422.403535611001;5648.491635752802;5655.349634792052;5665.235193249024;5666;5560.082586373203;5572.637778544544;5580.720963951705;5590.937721832839;5612.214289999321;5237.8786591430535;5434.592405569677;5442.340086273724;5458.808941687022;5473;5384.623076384615;5492.505674489315;5512.39363670004;5535.280413546213;5654.134135735279;5516.696581688046;5522.0336441123445;5524.447555244444;5529.336479622471;5548.445155484419 08:36:20 INFO - PROCESS | 11756 | |5;yui.html;704.6018999265415;748.1396394146734;752.3980815347722;754.6340025087832;800.2757504458467;14712.485063022796;15504.844951550482;15652.295646695897;15678.608034799121;15696.607584810385;12767.936160319208;12775.680607984805;12794.296313702742;12795.272638193841;12807.935960320208;660.28689015863;764.9770506884774;771.2326235395789;786.5516655506364;792.9762107136795;777.1024466740895;783.2402569507568;785.0971382909671;786.1038416205502;786.2059320086724;825.0923983618032;825.4428260923852;825.8348330333927;826.3348004856089;826.5536610230469;690.6995456976232;706.3783870194247;711.4415184080524;786.1195461083565;823.3166471828398;589.0310439327283;589.0457458916583;589.0869152813123;589.1516216648013;594.895893218685;13637;13651.453941842314;13670.794938075936;13674.589762307147;13698.178109313472;12951.48194072236;13423.48662377915;13428.19430834153;13527.029773145212;13866.4453421863;11827.645170644895;11916.761664766656;11967.521299148024;12194.207376520586;12338.5064597416;3856.46009558662;3859.453873365394;3921.2353591049755;3923.293807114718;3959.9604003960167;75193.62403188004;76294;78251;78353.60823195905;78384.60807695982;10927.125829933586;11150.49822757978;11236.66290011301;11317.151213659008;11502.769944601228;20326.288579899632;20499.38501844947;20500.38498845037;20516.17935282572;20526;8448.11294814048;8543.743548057346;8602.612882420306;8724.214820666171;8853.203211710848;4795.352627395327;4796.872734907294;4856.660033797671;4949.059678661043;4950.925736113961;3372.325534893031;3510.78935263885;3512.7892326459983;3516.5955915069585;3522.894313170609;512.5950499105664;610.7068607068632;613.15078616117;616.309733098932;617.4874853871275;665.9067730517731;680.5848432456198;691.993080069203;699.622204009829;708.7696498637963;8667.219950204511;8868.955655221811;8955.776105597412;8958.417702849294;8982.236509896731;627.7489004398186;638.556203438615;640.9455196308367;645.7610684046932;669.3306693306694;3966.3058964681063;3984.4620976168426;4056.472658554428;4075.2460794753065;4081.0817566047403;105636.47181764041;111562.44218778855;111630;114749;115737.42131289458;94984.52507737417;97080;97216;97831.51084244534;101079;84225.15774842296;87540.56229718811;87696.561517192;87788.12211877799;87809.56095219484;8017;8145.918540814753;8174.692049272088;8281.089080201293;8391.832163356577;51009.744951275;51043.489565103875;52044.73977630088;52262.21606675979;53807;71402.64298678681;72891.63554182195;75013.12467188363;75690.62154689191;76412.23587764052;10148.695539133838;10353.275270730977;10447.529861156114;10497.012358198888;11202.271852329572;11474.440807284127;11524;11825.46785394642;12232.694182645506;12574.371281436075;10912.563497460013;10926.838986005469;10929.398883061507;11383.715407114889;11444.656660300205;10725.30285531438;11305.943470282597;11323.943380283376;11374.488148033193;11636.592719254786;10636.627718029831;10784.676459706221;10974.625572471841;11166.05088567481;11204.327740335606;8444.577771111297;8555.61499732501;8978.461292322481;9436.896097766905;9560.091791280096;8894.599743011451;8991.41555798871;9645;9651.613935442785;9713.611455541699 08:36:20 INFO - PROCESS | 11756 | __end_tp_report 08:36:20 INFO - PROCESS | 11756 | __start_cc_report 08:36:20 INFO - PROCESS | 11756 | _x_x_mozilla_cycle_collect,908 08:36:20 INFO - PROCESS | 11756 | __end_cc_report 08:36:20 INFO - PROCESS | 11756 | __startTimestamp1465400180154__endTimestamp 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | ------- Summary: start ------- 08:36:20 INFO - PROCESS | 11756 | Number of tests: 6 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | [#0] dojo.html Cycles:165 Average:5400.91 Median:5634.10 stddev:603.69 (10.7%) stddev-sans-first:579.83 08:36:20 INFO - PROCESS | 11756 | Values: 3178.7 3193.3 3213.8 3227.5 3254.4 5300.1 5377.2 5397.5 5520.7 5546.4 5394.5 5416.6 5461.9 5470.4 5490.3 4896.8 4966.6 4987.7 4995.9 5140.4 5034.9 5040.8 5077.5 5095.8 5103.3 4834.1 4847.9 4880.0 4892.8 4899.9 4880.2 4896.8 4943.1 4966.6 4981.5 4825.1 4925.7 4934.6 4941.6 4963.1 5275.0 5354.7 5358.0 5428.2 5455.3 5914.5 5916.1 5939.6 5939.8 5945.7 5671.8 5709.0 5911.3 5918.9 5984.2 5360.9 5422.3 5466.3 5470.2 5478.9 5958.8 5976.0 5978.2 5978.9 5979.2 5597.7 5685.7 5721.7 5724.3 5729.9 5773.2 5820.0 5826.4 5827.8 5839.5 5707.3 5737.6 5752.2 5754.7 5755.5 5634.0 5735.6 5753.6 5811.8 5821.8 4474.2 4474.7 4479.7 4480.3 4510.7 3980.9 3987.3 3994.4 4009.3 4026.2 5382.6 5432.1 5439.0 5454.0 5496.7 5815.5 5863.5 5870.2 5874.5 5915.3 5304.8 5530.6 5543.6 5550.7 5552.8 4859.5 4908.3 4909.3 4912.3 4935.6 6052.7 6054.5 6059.4 6061.1 6061.2 5677.0 5684.8 5838.9 5851.9 5852.4 5887.9 5960.2 5965.1 5979.0 6026.8 5634.1 5675.7 5683.3 5688.7 5693.6 5726.0 5750.4 5760.7 5770.1 5796.1 5639.0 5650.4 5653.7 5659.0 5687.1 5596.6 5635.4 5650.8 5651.0 5653.8 5451.4 5542.2 5553.5 5648.6 5655.0 5780.9 5801.2 5844.4 5848.1 5858.4 5606.5 5666.6 5670.6 5676.3 5711.1 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | [#1] ext.html Cycles:180 Average:57846.73 Median:400091.50 stddev:112293.37 (28.1%) stddev-sans-first:112526.07 08:36:20 INFO - PROCESS | 11756 | Values: 580.5 621.9 632.7 640.7 647.2 30218.4 41335.8 41776.2 41829.0 41853.4 44631.8 45386.5 45393.5 45446.8 45472.5 8356.6 8520.5 8523.4 8531.1 8536.5 8604.2 8756.1 8765.5 8771.2 8771.6 8758.1 8813.1 8817.0 8817.5 8824.0 8709.3 8757.6 8765.1 8768.0 8769.7 8627.7 8742.3 8748.5 8750.3 8754.1 41766.8 42176.0 42209.6 42238.4 42258.4 3424.7 3428.8 3510.8 3512.5 3816.5 30678.0 30950.1 31409.7 31482.8 31508.5 4138.2 4230.2 4257.8 4305.6 4374.4 331178.0 335950.0 336792.0 336944.0 337214.0 55627.7 55856.7 55982.2 56077.6 56143.7 59347.7 59396.1 59453.7 59475.4 59503.4 16622.2 16922.0 16925.9 16927.4 16934.0 13085.9 13181.6 13209.0 13216.7 13224.7 15415.3 15504.5 15647.8 15713.6 15848.8 5331.1 5948.1 6145.5 6151.4 6238.8 975.9 1053.5 1099.9 1143.7 1184.8 31158.2 31272.8 31442.7 31809.7 32285.2 1132.3 1173.6 1206.1 1243.7 1254.1 15526.5 16078.8 16220.2 16457.4 16487.0 512822.0 516202.0 516812.0 517692.0 520329.0 56476.4 56749.7 56754.7 56756.0 56760.7 1265.3 1362.4 1395.4 1395.6 1395.9 31358.4 32230.5 32464.0 32603.7 32619.7 47723.3 47856.8 48085.5 48261.3 48301.5 398706.0 399568.0 399976.0 400207.0 401233.0 34585.8 38571.8 39006.2 39103.2 42096.6 46306.3 46348.0 47003.3 47118.3 47392.3 37970.2 39141.4 39448.8 39570.2 40064.4 36962.8 38849.2 38927.2 39099.4 39201.6 38725.6 39530.0 39848.6 39924.4 39985.8 32636.2 34640.3 34979.1 35061.3 35231.1 26953.8 27234.9 27264.6 27483.7 27735.6 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | [#2] jquery.html Cycles:180 Average:29400.95 Median:20904.18 stddev:81913.62 (391.9%) stddev-sans-first:82114.47 08:36:20 INFO - PROCESS | 11756 | Values: 399.4 399.7 403.6 405.7 413.4 17700.2 19239.7 19241.3 19351.9 20078.8 18384.4 18755.6 19049.3 19130.9 19309.7 5548.2 5595.8 5701.8 5843.3 5906.1 5898.7 5917.8 5922.9 5928.9 5955.1 5933.3 6341.6 6471.7 6476.7 6505.5 5965.3 6165.3 6415.4 6469.2 6470.3 5632.4 5721.9 5750.8 5774.4 5776.6 13986.6 17120.8 21729.6 22815.7 22854.4 2228.7 2259.6 2292.1 2292.7 2323.9 9855.6 10034.8 10061.4 10156.2 10489.6 1907.3 1915.1 1957.7 1993.7 2002.8 80940.6 81027.0 81557.6 81892.6 83314.2 10890.0 11052.6 11094.6 11135.9 11218.9 15512.7 15519.5 15584.6 15671.3 15697.2 7985.8 8226.6 8239.3 8313.5 8372.7 7768.6 7876.4 7894.8 8025.9 8042.1 4686.4 4747.3 4792.0 4812.7 4856.2 1940.6 1943.2 1957.1 1973.9 2002.6 927.0 975.9 983.6 991.4 1023.4 18214.2 18224.2 18965.4 19210.4 19289.4 965.5 1005.1 1006.9 1015.3 1044.6 10326.5 10665.8 10719.6 10743.3 10782.2 465461.0 500785.0 503269.0 504316.0 509388.0 92935.0 94933.0 95173.5 96150.0 96156.5 963.9 971.6 993.7 999.4 1006.2 16531.0 16594.6 16729.9 16950.6 17124.7 31620.2 39199.4 39280.6 41484.0 41968.8 56278.0 56835.0 59482.7 59797.4 59947.3 12404.2 12411.3 12636.4 12981.5 13053.1 13611.9 14090.2 14112.9 14133.4 14305.7 7791.6 11831.9 11890.6 12300.4 12687.6 11646.8 11718.8 11792.2 12014.6 12392.1 12045.8 12151.2 12193.9 12240.4 12273.1 12219.2 12342.4 12396.8 12428.3 12601.7 11666.8 11793.3 11937.2 11959.2 12510.4 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | [#3] mootools.html Cycles:180 Average:6063.05 Median:2682.89 stddev:3498.04 (130.4%) stddev-sans-first:3489.70 08:36:20 INFO - PROCESS | 11756 | Values: 1322.1 1518.0 1548.0 1661.3 1792.3 8572.1 8888.9 8899.9 9230.7 9257.8 8993.2 9197.9 9198.0 9198.7 9199.0 2406.9 2445.0 2446.7 2447.8 2449.2 2392.5 2439.6 2464.2 2465.0 2469.6 2432.2 2445.8 2447.1 2453.6 2454.1 2365.0 2367.6 2392.2 2405.0 2426.5 2324.5 2365.8 2414.5 2415.4 2418.5 7913.1 8347.3 8992.6 9080.2 9090.2 5363.0 5555.8 5620.3 5621.4 5628.7 3278.5 3346.1 3406.6 3417.8 3436.1 1156.7 1171.6 1201.2 1204.7 1215.6 12835.7 12981.9 12991.6 12997.2 12998.6 4877.8 4934.8 5002.3 5009.7 5047.5 10945.2 10994.3 11006.9 11030.1 11031.4 5470.0 5483.7 5527.4 5533.7 5534.7 4918.6 4987.7 5049.0 5076.7 5144.2 3969.7 4000.9 4083.8 4094.4 4111.5 1270.8 1273.9 1278.5 1289.2 1315.7 835.2 835.3 983.4 985.5 1025.7 6051.2 6151.2 6167.6 6253.3 6359.4 467.0 475.3 475.8 477.0 488.0 4213.2 4290.1 4312.9 4316.4 4341.6 11093.2 11377.5 11430.8 11445.3 11460.8 11480.7 11509.7 11526.3 11538.7 11578.8 8141.7 8463.0 8559.7 8567.2 8580.1 6293.8 6359.9 6453.6 6507.3 6560.0 10478.9 10548.3 10719.0 10740.4 10757.0 10832.5 10949.8 10957.8 11010.8 11114.3 8260.4 8264.5 8284.5 8312.2 8352.1 8827.8 8906.3 8919.2 8991.3 9047.5 8009.0 8106.5 8140.7 8227.5 8254.4 7748.3 7845.2 7930.7 7988.1 8121.0 7182.8 7517.0 7517.1 7518.7 7524.6 5191.6 5259.4 5329.4 5331.4 5431.1 5403.6 5418.1 5445.1 5499.5 5521.5 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | [#4] prototype.html Cycles:180 Average:4669.39 Median:5354.59 stddev:1380.34 (25.8%) stddev-sans-first:1345.27 08:36:20 INFO - PROCESS | 11756 | Values: 331.9 337.7 339.7 341.5 344.6 5302.8 5304.6 5345.7 5348.5 5354.8 5263.2 5271.5 5287.0 5296.3 5298.9 3835.8 3969.9 4043.5 4050.6 4174.4 4055.7 4144.0 4180.0 4184.8 4189.2 4093.9 4104.5 4107.2 4116.9 4134.9 3880.6 4031.4 4069.5 4092.9 4133.7 3610.8 3626.3 3639.1 3642.5 3654.2 5063.4 5078.2 5088.7 5092.7 5098.2 4575.8 4609.9 4700.9 4730.2 4732.2 5455.5 5487.5 5490.6 5507.4 5544.7 3965.8 3966.8 3974.1 3981.1 3982.9 5471.7 5652.5 5733.6 5764.8 5793.9 4048.7 4052.2 4055.0 4075.1 4077.2 4081.2 4084.8 4090.8 4098.1 4115.9 4524.3 4657.8 4667.3 4673.6 4684.8 5524.3 5553.8 5554.4 5557.3 5573.6 1399.2 1420.8 1426.3 1433.8 1435.2 880.0 887.6 918.8 921.7 933.8 5253.6 5333.2 5339.4 5364.9 5399.5 5564.6 5655.3 5673.3 5676.9 5693.1 5113.7 5331.6 5354.3 5364.8 5405.6 3005.4 3014.6 3028.8 3044.9 3060.6 5874.7 5897.2 5901.9 5913.6 5915.5 5545.0 5758.8 5765.9 5798.0 5853.1 5880.4 5898.6 5924.3 5928.8 5942.5 5426.3 5622.5 5664.4 5691.5 5734.6 5605.8 5632.2 5638.3 5697.6 5712.8 5917.6 5919.7 5946.5 5950.7 5961.9 3997.3 4078.6 4078.6 4091.7 4104.5 5728.2 5741.3 5757.6 5772.3 5814.3 5422.4 5648.5 5655.3 5665.2 5666.0 5560.1 5572.6 5580.7 5590.9 5612.2 5237.9 5434.6 5442.3 5458.8 5473.0 5384.6 5492.5 5512.4 5535.3 5654.1 5516.7 5522.0 5524.4 5529.3 5548.4 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - PROCESS | 11756 | [#5] yui.html Cycles:180 Average:20049.66 Median:53034.61 stddev:29858.64 (56.3%) stddev-sans-first:29907.07 08:36:20 INFO - PROCESS | 11756 | Values: 704.6 748.1 752.4 754.6 800.3 14712.5 15504.8 15652.3 15678.6 15696.6 12767.9 12775.7 12794.3 12795.3 12807.9 660.3 765.0 771.2 786.6 793.0 777.1 783.2 785.1 786.1 786.2 825.1 825.4 825.8 826.3 826.6 690.7 706.4 711.4 786.1 823.3 589.0 589.0 589.1 589.2 594.9 13637.0 13651.5 13670.8 13674.6 13698.2 12951.5 13423.5 13428.2 13527.0 13866.4 11827.6 11916.8 11967.5 12194.2 12338.5 3856.5 3859.5 3921.2 3923.3 3960.0 75193.6 76294.0 78251.0 78353.6 78384.6 10927.1 11150.5 11236.7 11317.2 11502.8 20326.3 20499.4 20500.4 20516.2 20526.0 8448.1 8543.7 8602.6 8724.2 8853.2 4795.4 4796.9 4856.7 4949.1 4950.9 3372.3 3510.8 3512.8 3516.6 3522.9 512.6 610.7 613.2 616.3 617.5 665.9 680.6 692.0 699.6 708.8 8667.2 8869.0 8955.8 8958.4 8982.2 627.7 638.6 640.9 645.8 669.3 3966.3 3984.5 4056.5 4075.2 4081.1 105636.5 111562.4 111630.0 114749.0 115737.4 94984.5 97080.0 97216.0 97831.5 101079.0 84225.2 87540.6 87696.6 87788.1 87809.6 8017.0 8145.9 8174.7 8281.1 8391.8 51009.7 51043.5 52044.7 52262.2 53807.0 71402.6 72891.6 75013.1 75690.6 76412.2 10148.7 10353.3 10447.5 10497.0 11202.3 11474.4 11524.0 11825.5 12232.7 12574.4 10912.6 10926.8 10929.4 11383.7 11444.7 10725.3 11305.9 11323.9 11374.5 11636.6 10636.6 10784.7 10974.6 11166.1 11204.3 8444.6 8555.6 8978.5 9436.9 9560.1 8894.6 8991.4 9645.0 9651.6 9713.6 08:36:20 INFO - PROCESS | 11756 | -------- Summary: end -------- 08:36:20 INFO - PROCESS | 11756 | 08:36:20 INFO - TEST-INFO | 11756: exit 0 08:36:20 INFO - TEST-OK | dromaeo_css | took 1112261ms 08:36:20 INFO - TEST-START | kraken 08:36:20 INFO - operating with platform_type : linux_ 08:36:20 INFO - Initialising browser for kraken test... 08:36:20 INFO - TEST-INFO | started process 11940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXpCrS/profile http://localhost:40961/getInfo.html) 08:36:24 INFO - PROCESS | 11940 | __metrics Screen width/height:1600/1200 08:36:24 INFO - PROCESS | 11940 | colorDepth:24 08:36:24 INFO - PROCESS | 11940 | Browser inner width/height: 1024/697 08:36:24 INFO - PROCESS | 11940 | __metrics 08:36:25 ERROR - PROCESS | 11940 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:36:25 INFO - PROCESS | 11940 | console.error: PushService: 08:36:25 INFO - PROCESS | 11940 | stateChangeProcessEnqueue: Error transitioning state 08:36:25 INFO - PROCESS | 11940 | UnknownError 08:36:26 INFO - TEST-INFO | 11940: exit 0 08:36:26 INFO - Browser initialized. 08:36:26 INFO - Running cycle 1/1 for kraken test... 08:36:26 INFO - TEST-INFO | started process 12023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXpCrS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:38 INFO - PROCESS | 12023 | RSS: Main: 156622848 08:36:38 INFO - PROCESS | 12023 | 08:36:40 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40961/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:41 INFO - PROCESS | 12023 | RSS: Main: 214331392 08:36:41 INFO - PROCESS | 12023 | 08:36:44 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40961/tests/kraken/driver.html?testName=audio-dft) 08:36:44 INFO - PROCESS | 12023 | RSS: Main: 201850880 08:36:44 INFO - PROCESS | 12023 | 08:36:48 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40961/tests/kraken/driver.html?testName=audio-fft) 08:36:48 INFO - PROCESS | 12023 | RSS: Main: 268619776 08:36:48 INFO - PROCESS | 12023 | 08:36:50 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40961/tests/kraken/driver.html?testName=audio-oscillator) 08:36:51 INFO - PROCESS | 12023 | RSS: Main: 179523584 08:36:51 INFO - PROCESS | 12023 | 08:36:53 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:54 INFO - PROCESS | 12023 | RSS: Main: 183484416 08:36:54 INFO - PROCESS | 12023 | 08:36:57 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40961/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:57 INFO - PROCESS | 12023 | RSS: Main: 217808896 08:36:57 INFO - PROCESS | 12023 | 08:37:01 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40961/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:01 INFO - PROCESS | 12023 | RSS: Main: 220160000 08:37:01 INFO - PROCESS | 12023 | 08:37:04 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40961/tests/kraken/driver.html?testName=json-parse-financial) 08:37:05 INFO - PROCESS | 12023 | RSS: Main: 220565504 08:37:05 INFO - PROCESS | 12023 | 08:37:06 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:07 INFO - PROCESS | 12023 | RSS: Main: 205737984 08:37:07 INFO - PROCESS | 12023 | 08:37:09 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:09 INFO - PROCESS | 12023 | RSS: Main: 210575360 08:37:09 INFO - PROCESS | 12023 | 08:37:11 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:12 INFO - PROCESS | 12023 | RSS: Main: 217989120 08:37:12 INFO - PROCESS | 12023 | 08:37:14 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:15 INFO - PROCESS | 12023 | RSS: Main: 222834688 08:37:15 INFO - PROCESS | 12023 | 08:37:18 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:18 INFO - PROCESS | 12023 | RSS: Main: 220356608 08:37:18 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | Cycle 1(1): loaded http://localhost:40961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40961/tests/kraken/driver.html?testName=ai-astar) 08:37:20 INFO - PROCESS | 12023 | RSS: Main: 262635520 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | __start_tp_report 08:37:20 INFO - PROCESS | 12023 | _x_x_mozilla_page_load 08:37:20 INFO - PROCESS | 12023 | _x_x_mozilla_page_load_details 08:37:20 INFO - PROCESS | 12023 | |i|pagename|runs| 08:37:20 INFO - PROCESS | 12023 | |0;ai-astar;111;106;112;112;110;110;110;111;111;110 08:37:20 INFO - PROCESS | 12023 | |1;audio-beat-detection;149;125;125;172;125;125;155;124;175;128 08:37:20 INFO - PROCESS | 12023 | |2;audio-dft;162;161;162;161;161;161;162;160;161;161 08:37:20 INFO - PROCESS | 12023 | |3;audio-fft;74;75;75;134;75;75;75;75;99;75 08:37:20 INFO - PROCESS | 12023 | |4;audio-oscillator;86;86;119;85;86;85;124;85;86;131 08:37:20 INFO - PROCESS | 12023 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 08:37:20 INFO - PROCESS | 12023 | |6;imaging-darkroom;146;147;146;145;146;146;146;146;145;147 08:37:20 INFO - PROCESS | 12023 | |7;imaging-desaturate;95;95;94;95;95;94;94;95;96;95 08:37:20 INFO - PROCESS | 12023 | |8;json-parse-financial;54;53;53;53;52;53;54;53;54;53 08:37:20 INFO - PROCESS | 12023 | |9;json-stringify-tinderbox;71;63;62;63;63;62;62;62;64;63 08:37:20 INFO - PROCESS | 12023 | |10;stanford-crypto-aes;79;79;78;79;79;85;83;81;140;79 08:37:20 INFO - PROCESS | 12023 | |11;stanford-crypto-ccm;122;124;131;132;122;130;121;123;128;123 08:37:20 INFO - PROCESS | 12023 | |12;stanford-crypto-pbkdf2;161;163;158;162;157;161;164;164;160;159 08:37:20 INFO - PROCESS | 12023 | |13;stanford-crypto-sha256-iterative;63;64;65;64;64;65;62;64;64;62 08:37:20 INFO - PROCESS | 12023 | __end_tp_report 08:37:20 INFO - PROCESS | 12023 | __start_cc_report 08:37:20 INFO - PROCESS | 12023 | _x_x_mozilla_cycle_collect,1603 08:37:20 INFO - PROCESS | 12023 | __end_cc_report 08:37:20 INFO - PROCESS | 12023 | __startTimestamp1465400240750__endTimestamp 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | ------- Summary: start ------- 08:37:20 INFO - PROCESS | 12023 | Number of tests: 14 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.70 (1.5%) stddev-sans-first:1.79 08:37:20 INFO - PROCESS | 12023 | Values: 111.0 106.0 112.0 112.0 110.0 110.0 110.0 111.0 111.0 110.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:138.50 stddev:20.69 (14.9%) stddev-sans-first:21.71 08:37:20 INFO - PROCESS | 12023 | Values: 149.0 125.0 125.0 172.0 125.0 125.0 155.0 124.0 175.0 128.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:37:20 INFO - PROCESS | 12023 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 162.0 160.0 161.0 161.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:19.40 (25.9%) stddev-sans-first:20.28 08:37:20 INFO - PROCESS | 12023 | Values: 74.0 75.0 75.0 134.0 75.0 75.0 75.0 75.0 99.0 75.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.50 stddev:19.10 (22.3%) stddev-sans-first:19.82 08:37:20 INFO - PROCESS | 12023 | Values: 86.0 86.0 119.0 85.0 86.0 85.0 124.0 85.0 86.0 131.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:37:20 INFO - PROCESS | 12023 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:37:20 INFO - PROCESS | 12023 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:37:20 INFO - PROCESS | 12023 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 08:37:20 INFO - PROCESS | 12023 | Values: 54.0 53.0 53.0 53.0 52.0 53.0 54.0 53.0 54.0 53.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.00 stddev:2.72 (4.3%) stddev-sans-first:0.71 08:37:20 INFO - PROCESS | 12023 | Values: 71.0 63.0 62.0 63.0 63.0 62.0 62.0 62.0 64.0 63.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:79.00 stddev:19.03 (24.1%) stddev-sans-first:20.01 08:37:20 INFO - PROCESS | 12023 | Values: 79.0 79.0 78.0 79.0 79.0 85.0 83.0 81.0 140.0 79.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.00 stddev:4.20 (3.3%) stddev-sans-first:4.24 08:37:20 INFO - PROCESS | 12023 | Values: 122.0 124.0 131.0 132.0 122.0 130.0 121.0 123.0 128.0 123.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:2.42 (1.5%) stddev-sans-first:2.57 08:37:20 INFO - PROCESS | 12023 | Values: 161.0 163.0 158.0 162.0 157.0 161.0 164.0 164.0 160.0 159.0 08:37:20 INFO - PROCESS | 12023 | 08:37:20 INFO - PROCESS | 12023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.09 08:37:20 INFO - PROCESS | 12023 | Values: 63.0 64.0 65.0 64.0 64.0 65.0 62.0 64.0 64.0 62.0 08:37:20 INFO - PROCESS | 12023 | -------- Summary: end -------- 08:37:20 INFO - PROCESS | 12023 | 08:37:21 INFO - TEST-INFO | 12023: exit 0 08:37:21 INFO - TEST-OK | kraken | took 60815ms 08:37:21 INFO - SUITE-END | took 1173s 08:37:21 INFO - Completed test suite (00:19:33) 08:37:21 INFO - javascript benchmark 08:37:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3178.6662400447954, 3193.3294008258263, 3213.8393080345986, 3227.5158726191084, 3254.4304746669327, 5300.072487314724, 5377.247185394048, 5397.514223719864, 5520.66875987441, 5546.389897111315, 5394.541463975557, 5416.566674666027, 5461.9453805462035, 5470.425605311445, 5490.3411590609085, 4896.804127834891, 4966.553010229079, 4987.675801072919, 4995.900081998358, 5140.357455318085, 5034.949650503485, 5040.823571175009, 5077.49225077493, 5095.847124586268, 5103.311053007834, 4834.057358815033, 4847.854564363057, 4879.975600122012, 4892.779824907888, 4899.853004409873, 4880.2435622478215, 4896.804127834882, 4943.1102401567705, 4966.5778408835295, 4981.526754958273, 4825.131476334259, 4925.655204135712, 4934.580560652349, 4941.604671626261, 4963.106640804654, 5274.97362513185, 5354.678719276856, 5358.035553600351, 5428.212909128154, 5455.290812194429, 5914.467697907209, 5916.083007133901, 5939.554533410012, 5939.762409503614, 5945.672987985659, 5671.7731290748325, 5708.971455142698, 5911.320198177222, 5918.852028699274, 5984.162217289583, 5360.91958620621, 5422.322209723785, 5466.289382380305, 5470.206820011116, 5478.890422191534, 5958.821235362946, 5976.0, 5978.222831031938, 5978.850528736816, 5979.222701048836, 5597.720113994284, 5685.687287199244, 5721.685307308138, 5724.313082430135, 5729.942700573024, 5773.24947756789, 5820.0, 5826.388229235954, 5827.7668893244645, 5839.532837373, 5707.34365547959, 5737.569682273846, 5752.165935939265, 5754.683492407874, 5755.539556835443, 5634.04221282383, 5735.627184233012, 5753.568482363839, 5811.767529298781, 5821.767129314865, 4474.194644963873, 4474.6867719259335, 4479.731216127043, 4480.32795080734, 4510.684252102321, 3980.900477488086, 3987.282289187916, 3994.3609022556834, 4009.318415869251, 4026.1947610478023, 5382.569394448435, 5432.13085906261, 5438.972805135949, 5454.0, 5496.697681627549, 5815.534757219412, 5863.472287494146, 5870.236869207061, 5874.530037596982, 5915.319738230159, 5304.787808487617, 5530.557555395559, 5543.556515478752, 5550.6669599823335, 5552.833414997556, 4859.465458799529, 4908.288298196813, 4909.26361045846, 4912.263160525878, 4935.629827762932, 6052.697365131726, 6054.455099041107, 6059.424354686298, 6061.090836374579, 6061.1514387984835, 5677.0, 5684.801031964027, 5838.854028649318, 5851.912221316768, 5852.4440178183, 5887.941120588739, 5960.225170727777, 5965.075413310944, 5979.0, 6026.819195423969, 5634.098544232903, 5675.659460432387, 5683.261176047087, 5688.687122208153, 5693.572982026281, 5726.0, 5750.367459579526, 5760.683162426107, 5770.076787713946, 5796.072628379439, 5639.013172694844, 5650.378458369658, 5653.745581448762, 5658.971705141613, 5687.090065589486, 5596.636218645775, 5635.408282130481, 5650.830475085754, 5651.0, 5653.830385088454, 5451.427600102091, 5542.196381524575, 5553.500184983371, 5648.57635677334, 5655.0, 5780.913286300624, 5801.158831969426, 5844.415558444121, 5848.093545500455, 5858.414158584107, 5606.467385598362, 5666.631668941505, 5670.631408958405, 5676.34722006958, 5711.143328500758], "value": 5361.239744539291, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5210701171532, 621.937806219378, 632.7310892870529, 640.6604499615204, 647.1910112359551, 30218.395632087373, 41335.79332103339, 41776.164476710444, 41829.0, 41853.372199417, 44631.77684111583, 45386.54613453864, 45393.54606453943, 45446.77276613621, 45472.54527454724, 8356.582170891477, 8520.488770673748, 8523.360747943898, 8531.06158322584, 8536.530490823003, 8604.225619694227, 8756.124387561256, 8765.517896515721, 8771.166739159802, 8771.605277762485, 8758.124187581254, 8813.074627164151, 8816.955915220415, 8817.470951742884, 8823.95588022059, 8709.259712924377, 8757.56212189388, 8765.123487651248, 8767.991680956677, 8769.693060742844, 8627.6980305689, 8742.30061595071, 8748.518831464267, 8750.256228220609, 8754.124587541259, 41766.79116604428, 42176.0, 42209.577904220874, 42238.366424503656, 42258.36612450816, 3424.74314426419, 3428.777129486575, 3510.7893526388243, 3512.473129030666, 3816.5229346331707, 30678.0, 30950.0714978551, 31409.685903140904, 31482.842585787155, 31508.527372089437, 4138.213739389506, 4230.2174097792, 4257.76582287974, 4305.63402110821, 4374.387585737967, 331178.0, 335950.0, 336792.0, 336944.0, 337214.0, 55627.72186139043, 55856.72071639616, 55982.16026759602, 56077.598060048826, 56143.71928140333, 59347.70326148428, 59396.109058364156, 59453.70273148607, 59475.405245947855, 59503.40496594978, 16622.168891555375, 16922.0, 16925.915370423314, 16927.407540736014, 16934.0, 13085.869141308656, 13181.60455186346, 13209.0, 13216.73566528664, 13224.669383265495, 15415.306311216022, 15504.457343992906, 15647.843521564866, 15713.607159821097, 15848.841511584968, 5331.1470164773455, 5948.122539517554, 6145.477634401037, 6151.384861513902, 6238.812835614939, 975.9463229522303, 1053.4574694032578, 1099.8570185875944, 1143.6511863881597, 1184.810430331143, 31158.22104447407, 31272.84363578213, 31442.685573143975, 31809.681903181136, 32285.192870178435, 1132.3206076354286, 1173.5833779008499, 1206.1436380170003, 1243.7015116372186, 1254.1095821966323, 15526.543265074946, 16078.750618048365, 16220.188990550425, 16457.42399016029, 16487.0, 512822.0, 516202.0, 516812.0, 517692.0, 520329.0, 56476.43523564712, 56749.71625141848, 56754.71622641943, 56756.0, 56760.716196418754, 1265.3483456020158, 1362.4413990263945, 1395.386030146732, 1395.5673741140279, 1395.874371306567, 31358.37283254368, 32230.516542251415, 32464.0, 32603.673963260062, 32619.673803262613, 47723.28415073846, 47856.76071619619, 48085.5191448081, 48261.276080858115, 48301.5169848297, 398706.0, 399568.0, 399976.0, 400207.0, 401233.0, 34585.827070864485, 38571.80714096411, 39006.219875602896, 39103.2179356417, 42096.57903421049, 46306.30540541962, 46348.0, 47003.29495057509, 47118.29322560233, 47392.28911566398, 37970.24059518739, 39141.41287880741, 39448.802755986035, 39570.208595827346, 40064.39903401393, 36962.8151859239, 38849.22301553896, 38927.221455570165, 39099.413508796824, 39201.607983920934, 38725.61274387333, 39530.0, 39848.60151398449, 39924.40113398359, 39985.80007100062, 32636.184095397806, 34640.30719385648, 34979.12552186216, 35061.29877402387, 35231.11922201965, 26953.78707958186, 27234.863825680746, 27264.59103113415, 27483.725162748116, 27735.58396624012], "value": 19747.018917174442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.43679412029036, 399.7062159312906, 403.58430816259244, 405.66532610596266, 413.4453615673428, 17700.203490842912, 19239.71140432893, 19241.32655357061, 19351.903240483814, 20078.799212007874, 18384.356547520838, 18755.624887502243, 19049.333273335436, 19130.904345478288, 19309.710354344697, 5548.195511650808, 5595.776168953237, 5701.828945131652, 5843.328017278003, 5906.143609176666, 5898.734556944926, 5917.763289468416, 5922.88154236915, 5928.911066334009, 5955.076963070731, 5933.3473317934995, 6341.5877967932165, 6471.708773105222, 6476.676166191695, 6505.544611877171, 5965.313988891289, 6165.32181460039, 6415.358464153594, 6469.223693156804, 6470.288268290507, 5632.3804381518, 5721.9427805721825, 5750.769969201268, 5774.364819869811, 5776.566757493163, 13986.580402587939, 17120.828791712047, 21729.567608097976, 22815.657765133536, 22854.428639283986, 2228.732552093743, 2259.5932732108213, 2292.1404473322505, 2292.6561015847587, 2323.8605683659034, 9855.605775768961, 10034.799304013879, 10061.446620435872, 10156.187504999582, 10489.58041678332, 1907.3229003703764, 1915.1357341270832, 1957.6769832977684, 1993.6810110382414, 2002.7997200280001, 80940.59529702314, 81027.0, 81557.59221203915, 81892.59053704752, 83314.16685833124, 10890.0, 11052.557897684002, 11094.5562177512, 11135.888641113646, 11218.943905280421, 15512.689746205013, 15519.5256450637, 15584.610384740472, 15671.294791734399, 15697.194822595548, 7985.760427187193, 8226.588670566567, 8239.299659529008, 8313.542755148404, 8372.706955256659, 7768.611569421506, 7876.369890408868, 7894.842103157905, 8025.879611805827, 8042.075161356402, 4686.437627484655, 4747.264174053027, 4791.98736530658, 4812.663113582015, 4856.1987272099705, 1940.62157879215, 1943.2129987355145, 1957.0899531717535, 1973.940781776549, 2002.5694475687505, 926.9629214831466, 975.9463229522303, 983.6245467196783, 991.3506653142204, 1023.3808545829814, 18214.17680259562, 18224.179911903997, 18965.43103706891, 19210.423687289403, 19289.421317360502, 965.4882912056621, 1005.1255407795265, 1006.8942761009988, 1015.304516406264, 1044.6239353832614, 10326.48367581618, 10665.786684266272, 10719.571217151226, 10743.301685390425, 10782.245242832927, 465461.0, 500785.0, 503269.0, 504316.0, 509388.0, 92935.0, 94933.0, 95173.5241323789, 96150.0, 96156.51921740487, 963.8939716631165, 971.582219645545, 993.6770549571419, 999.3504222255447, 1006.1799633298838, 16531.0, 16594.58513537171, 16729.91255568384, 16950.57623559421, 17124.743128852828, 31620.209494762814, 39199.41200882046, 39280.607193927695, 41484.0, 41968.79015604902, 56278.0, 56835.0, 59482.70258648679, 59797.40202597919, 59947.305006024355, 12404.19372740769, 12411.255324680547, 12636.431360588611, 12981.480740770263, 13053.08628396041, 13611.931940340235, 14090.22503762303, 14112.858871411565, 14133.363998619881, 14305.713885722436, 7791.571463569559, 11831.881681183078, 11890.583829565923, 12300.384980751105, 12687.555935542212, 11646.767064658829, 11718.765624687629, 11792.23350482216, 12014.579489717818, 12392.132550721724, 12045.819312710491, 12151.210171338835, 12193.939030304791, 12240.387980600755, 12273.140880138662, 12219.203302005695, 12342.382880855741, 12396.752064958831, 12428.254304741744, 12601.684957876127, 11666.824997624874, 11793.292402455538, 11937.164398492023, 11959.162858599815, 12510.437030333838], "value": 9455.234916305764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.0547308674295, 1518.0208765346351, 1547.9829841561148, 1661.3354658136743, 1792.2920446423655, 8572.099929507405, 8888.911110888897, 8899.866502002475, 9230.67692630758, 9257.76855578611, 8993.23557497612, 9197.90802091979, 9198.0, 9198.724038278862, 9199.0, 2406.8676222807694, 2445.0, 2446.706395232575, 2447.8286519943613, 2449.155041510685, 2392.4856155926473, 2439.5974664180476, 2464.199135281032, 2464.963025554618, 2469.592517234654, 2432.1823839939098, 2445.7921076708412, 2447.1068060158004, 2453.55835949529, 2454.104251948044, 2364.9645255321184, 2367.585672507313, 2392.1507864708037, 2404.963925541127, 2426.5268272686835, 2324.5118525109747, 2365.751596082404, 2414.4567472318763, 2415.3961509622595, 2418.504206637635, 7913.129555748863, 8347.332213422973, 8992.550372481415, 9080.228180604656, 9090.2273306769, 5362.973185134088, 5555.833325000216, 5620.269364982567, 5621.381648018714, 5628.662280263197, 3278.459054256045, 3346.130006198406, 3406.591209054929, 3417.79493230407, 3436.1066122808, 1156.7166044319113, 1171.6367925942984, 1201.2072032458623, 1204.680759598707, 1215.629233083909, 12835.743285134338, 12981.87018129816, 12991.61025169237, 12997.15518491295, 12998.635143310006, 4877.756112194447, 4934.777934992934, 5002.299678045077, 5009.674371165863, 5047.545720885138, 10945.233833631728, 10994.28537145083, 11006.889931100586, 11030.06244469229, 11031.393273369882, 5469.972650136803, 5483.725813709299, 5527.364353099445, 5533.667979921218, 5534.667919924817, 4918.5573298403315, 4987.650864439527, 5049.0, 5076.74616269185, 5144.2283657450935, 3969.7221194516683, 4000.9399859002137, 4083.7549747015273, 4094.406311084876, 4111.527174374985, 1270.7966725323904, 1273.923564586128, 1278.5397256987478, 1289.155603079984, 1315.6842357834241, 835.2107258640526, 835.2858306148278, 983.4148681534475, 985.472772066955, 1025.6974192613197, 6051.213342265477, 6151.231096112986, 6167.599106058092, 6253.3121356651645, 6359.427651511386, 466.95330466953715, 475.25385145321513, 475.79540797457423, 476.9785359658824, 488.03369328729315, 4213.220554197422, 4290.141971605692, 4312.89217769552, 4316.395704601358, 4341.565843415633, 11093.223474356879, 11377.488013039432, 11430.828537571942, 11445.313281203154, 11460.828087578693, 11480.655580332603, 11509.71225719347, 11526.308421494738, 11538.653840384803, 11578.826317605242, 8141.674333026613, 8463.026751923484, 8559.74320770378, 8567.186117318844, 8580.14198580137, 6293.811185664437, 6359.904601431075, 6453.580517266362, 6507.28419873823, 6559.967200163968, 10478.947605261925, 10548.261621686408, 10719.035286824223, 10740.409277489813, 10757.0, 10832.5125369357, 10949.83575246356, 10957.83563246568, 11010.834837477283, 11114.333140011626, 8260.421770476009, 8264.545450000307, 8284.50292982423, 8312.21034001769, 8352.0812710603, 8827.779305517413, 8906.287497000354, 8919.152680495343, 8991.325650576102, 9047.457152570867, 8009.0, 8106.47307924983, 8140.674373025013, 8227.465214761021, 8254.380921431037, 7748.302652761278, 7845.215478452109, 7930.722424715107, 7988.121306656147, 8120.959395202986, 7182.820429489305, 7517.02278703765, 7517.135529414188, 7518.736844210426, 7524.623768811647, 5191.558717509054, 5259.42146363892, 5329.440408757025, 5331.413544510178, 5431.131019036935, 5403.6217464778665, 5418.078926582411, 5445.101558243004, 5499.477549632778, 5521.509192517918], "value": 4743.449882506429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.9369319829232, 337.69101272335814, 339.67900334184174, 341.5082281514619, 344.6381299635384, 5302.8144014959435, 5304.602154838388, 5345.652532585379, 5348.545373643245, 5354.839354819362, 5263.210518422238, 5271.472852714726, 5287.0, 5296.25852380667, 5298.947010529893, 3835.753380151448, 3969.940450893246, 4043.5147782266167, 4050.574689657588, 4174.35297528882, 4055.71609987301, 4143.958560414402, 4179.979100104495, 4184.811683474236, 4189.224993376235, 4093.9181216375655, 4104.507459104897, 4107.17856428714, 4116.938245926299, 4134.855280065199, 3880.555250192375, 4031.395290706388, 4069.491313585802, 4092.856750013735, 4133.73130746502, 3610.801405922673, 3626.256617393428, 3639.1448009717697, 3642.5446819147605, 3654.196076863086, 5063.392392912837, 5078.162103252959, 5088.669236499616, 5092.719900405476, 5098.158803797369, 4575.794089265958, 4609.884752881171, 4700.929486057677, 4730.219513780222, 4732.219183834663, 5455.481729235756, 5487.533559647435, 5490.56075513958, 5507.421720719307, 5544.722763861791, 3965.8499035279733, 3966.8099570129134, 3974.145558704892, 3981.064449854282, 3982.8691649967127, 5471.671699698031, 5652.547796176296, 5733.569982251306, 5764.769409223626, 5793.913091303634, 4048.6963477739287, 4052.169305292408, 4055.0, 4075.083106301118, 4077.245709543744, 4081.2041651878194, 4084.81618327176, 4090.8159132839096, 4098.139390727981, 4115.855945041909, 4524.258160608189, 4657.836975705834, 4667.346571479996, 4673.621281721832, 4684.789184486706, 5524.315083899369, 5553.805616803393, 5554.389017208104, 5557.3331200256225, 5573.637713548606, 1399.167495340271, 1420.808190894216, 1426.265473281261, 1433.8351089624828, 1435.2034620785564, 880.0419067574724, 887.5961437545901, 918.8116436130578, 921.7142086788892, 933.7758937855002, 5253.632245742761, 5333.200019997032, 5339.439358867263, 5364.91952620711, 5399.460053994648, 5564.638298510584, 5655.349634792052, 5673.347565030074, 5676.943230567724, 5693.146028095819, 5113.718745469035, 5331.600129990266, 5354.330708661418, 5364.8122315718765, 5405.567554595623, 3005.353848922492, 3014.593029940974, 3028.8182709037087, 3044.939101217963, 3060.556219348182, 5874.676892770939, 5897.2333596633025, 5901.911471327933, 5913.586048976616, 5915.497182739516, 5544.972275138679, 5758.798442054508, 5765.88468230633, 5797.971010144923, 5853.0635098384055, 5880.353161152269, 5898.64608123514, 5924.289085309791, 5928.822135335947, 5942.524598032147, 5426.2674538936735, 5622.522085622604, 5664.448840136607, 5691.459311365414, 5734.598578099493, 5605.775768969195, 5632.239647647515, 5638.335082196605, 5697.6296540724725, 5712.7714891403875, 5917.615355002084, 5919.69766651336, 5946.513371657085, 5950.702464876826, 5961.940380596138, 3997.2804895119157, 4078.6125318094732, 4078.6125318094732, 4091.6726661866383, 4104.507459104927, 5728.226689396878, 5741.339745929272, 5757.625754325955, 5772.278465191851, 5814.273215848019, 5422.403535611001, 5648.491635752802, 5655.349634792052, 5665.235193249024, 5666.0, 5560.082586373203, 5572.637778544544, 5580.720963951705, 5590.937721832839, 5612.214289999321, 5237.8786591430535, 5434.592405569677, 5442.340086273724, 5458.808941687022, 5473.0, 5384.623076384615, 5492.505674489315, 5512.39363670004, 5535.280413546213, 5654.134135735279, 5516.696581688046, 5522.0336441123445, 5524.447555244444, 5529.336479622471, 5548.445155484419], "value": 4229.4276156687665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.6018999265415, 748.1396394146734, 752.3980815347722, 754.6340025087832, 800.2757504458467, 14712.485063022796, 15504.844951550482, 15652.295646695897, 15678.608034799121, 15696.607584810385, 12767.936160319208, 12775.680607984805, 12794.296313702742, 12795.272638193841, 12807.935960320208, 660.28689015863, 764.9770506884774, 771.2326235395789, 786.5516655506364, 792.9762107136795, 777.1024466740895, 783.2402569507568, 785.0971382909671, 786.1038416205502, 786.2059320086724, 825.0923983618032, 825.4428260923852, 825.8348330333927, 826.3348004856089, 826.5536610230469, 690.6995456976232, 706.3783870194247, 711.4415184080524, 786.1195461083565, 823.3166471828398, 589.0310439327283, 589.0457458916583, 589.0869152813123, 589.1516216648013, 594.895893218685, 13637.0, 13651.453941842314, 13670.794938075936, 13674.589762307147, 13698.178109313472, 12951.48194072236, 13423.48662377915, 13428.19430834153, 13527.029773145212, 13866.4453421863, 11827.645170644895, 11916.761664766656, 11967.521299148024, 12194.207376520586, 12338.5064597416, 3856.46009558662, 3859.453873365394, 3921.2353591049755, 3923.293807114718, 3959.9604003960167, 75193.62403188004, 76294.0, 78251.0, 78353.60823195905, 78384.60807695982, 10927.125829933586, 11150.49822757978, 11236.66290011301, 11317.151213659008, 11502.769944601228, 20326.288579899632, 20499.38501844947, 20500.38498845037, 20516.17935282572, 20526.0, 8448.11294814048, 8543.743548057346, 8602.612882420306, 8724.214820666171, 8853.203211710848, 4795.352627395327, 4796.872734907294, 4856.660033797671, 4949.059678661043, 4950.925736113961, 3372.325534893031, 3510.78935263885, 3512.7892326459983, 3516.5955915069585, 3522.894313170609, 512.5950499105664, 610.7068607068632, 613.15078616117, 616.309733098932, 617.4874853871275, 665.9067730517731, 680.5848432456198, 691.993080069203, 699.622204009829, 708.7696498637963, 8667.219950204511, 8868.955655221811, 8955.776105597412, 8958.417702849294, 8982.236509896731, 627.7489004398186, 638.556203438615, 640.9455196308367, 645.7610684046932, 669.3306693306694, 3966.3058964681063, 3984.4620976168426, 4056.472658554428, 4075.2460794753065, 4081.0817566047403, 105636.47181764041, 111562.44218778855, 111630.0, 114749.0, 115737.42131289458, 94984.52507737417, 97080.0, 97216.0, 97831.51084244534, 101079.0, 84225.15774842296, 87540.56229718811, 87696.561517192, 87788.12211877799, 87809.56095219484, 8017.0, 8145.918540814753, 8174.692049272088, 8281.089080201293, 8391.832163356577, 51009.744951275, 51043.489565103875, 52044.73977630088, 52262.21606675979, 53807.0, 71402.64298678681, 72891.63554182195, 75013.12467188363, 75690.62154689191, 76412.23587764052, 10148.695539133838, 10353.275270730977, 10447.529861156114, 10497.012358198888, 11202.271852329572, 11474.440807284127, 11524.0, 11825.46785394642, 12232.694182645506, 12574.371281436075, 10912.563497460013, 10926.838986005469, 10929.398883061507, 11383.715407114889, 11444.656660300205, 10725.30285531438, 11305.943470282597, 11323.943380283376, 11374.488148033193, 11636.592719254786, 10636.627718029831, 10784.676459706221, 10974.625572471841, 11166.05088567481, 11204.327740335606, 8444.577771111297, 8555.61499732501, 8978.461292322481, 9436.896097766905, 9560.091791280096, 8894.599743011451, 8991.41555798871, 9645.0, 9651.613935442785, 9713.611455541699], "value": 7024.2881705048685, "unit": "score"}], "name": "dromaeo_css", "value": 7215.119472825706, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 112.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 125.0, 172.0, 125.0, 125.0, 155.0, 124.0, 175.0, 128.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 134.0, 75.0, 75.0, 75.0, 75.0, 99.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 119.0, 85.0, 86.0, 85.0, 124.0, 85.0, 86.0, 131.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 52.0, 53.0, 54.0, 53.0, 54.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 79.0, 85.0, 83.0, 81.0, 140.0, 79.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 131.0, 132.0, 122.0, 130.0, 121.0, 123.0, 128.0, 123.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 158.0, 162.0, 157.0, 161.0, 164.0, 164.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 62.0, 64.0, 64.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1503.0, "alertThreshold": 2.0}]} 08:37:21 INFO - Return code: 0 08:37:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:22 ERROR - # TBPL SUCCESS # 08:37:22 INFO - Running post-action listener: _resource_record_post_action 08:37:22 INFO - ##### 08:37:22 INFO - ##### Finished run-tests step (success) 08:37:22 INFO - ##### 08:37:22 INFO - Running post-run listener: _resource_record_post_run 08:37:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 543432704; Read time: 48; Write time: 463520 08:37:22 INFO - TinderboxPrint: CPU usage
13.1% 08:37:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 48 08:37:22 INFO - TinderboxPrint: I/O write bytes / time
543,432,704 / 463,520 08:37:22 INFO - TinderboxPrint: CPU idle
8,257.8 (86.9%) 08:37:22 INFO - TinderboxPrint: CPU user
1,203.8 (12.7%) 08:37:22 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248967168; Read time: 0; Write time: 275344 08:37:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294465536; Read time: 48; Write time: 188176 08:37:22 INFO - Running post-run listener: _upload_blobber_files 08:37:22 INFO - Blob upload gear active. 08:37:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:22 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 08:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:26 INFO - (blobuploader) - INFO - Done attempting. 08:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:27 INFO - (blobuploader) - INFO - Done attempting. 08:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:28 INFO - (blobuploader) - INFO - Done attempting. 08:37:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:28 INFO - Return code: 0 08:37:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcec7ed9aa76b3ac272cef5ad2957bfa214714e25ca9efc1125566e7632f54ddf8da6c27d7a23e048a1fe3c629253396b53f5cf1729181e878dfd0afdd5c55f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d42ef9a3fdc19535c0d3bc343d691ef2d2b658cedc10233018f2312190e486c6b9f92f257aea65b25232eab7612b3fd8504c1da331cc84f949814a7d6c17220", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62ffb4673f1e1747adff60e986225922b732e9df33404d02eb959b125fc56e1acf420bc0a34248a8249f5d165210a96c0f7d374f653419105884008bd1a56377"} 08:37:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:28 INFO - Contents: 08:37:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcec7ed9aa76b3ac272cef5ad2957bfa214714e25ca9efc1125566e7632f54ddf8da6c27d7a23e048a1fe3c629253396b53f5cf1729181e878dfd0afdd5c55f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d42ef9a3fdc19535c0d3bc343d691ef2d2b658cedc10233018f2312190e486c6b9f92f257aea65b25232eab7612b3fd8504c1da331cc84f949814a7d6c17220", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62ffb4673f1e1747adff60e986225922b732e9df33404d02eb959b125fc56e1acf420bc0a34248a8249f5d165210a96c0f7d374f653419105884008bd1a56377"} 08:37:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:28 INFO - Copying logs to upload dir... 08:37:28 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.502586 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-08 08:37:27.417585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 08:37:27.420948) ========= 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=523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcec7ed9aa76b3ac272cef5ad2957bfa214714e25ca9efc1125566e7632f54ddf8da6c27d7a23e048a1fe3c629253396b53f5cf1729181e878dfd0afdd5c55f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d42ef9a3fdc19535c0d3bc343d691ef2d2b658cedc10233018f2312190e486c6b9f92f257aea65b25232eab7612b3fd8504c1da331cc84f949814a7d6c17220", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62ffb4673f1e1747adff60e986225922b732e9df33404d02eb959b125fc56e1acf420bc0a34248a8249f5d165210a96c0f7d374f653419105884008bd1a56377"} build_url:https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/bb8WlMVyQAezqZwfLOl9hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcec7ed9aa76b3ac272cef5ad2957bfa214714e25ca9efc1125566e7632f54ddf8da6c27d7a23e048a1fe3c629253396b53f5cf1729181e878dfd0afdd5c55f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d42ef9a3fdc19535c0d3bc343d691ef2d2b658cedc10233018f2312190e486c6b9f92f257aea65b25232eab7612b3fd8504c1da331cc84f949814a7d6c17220", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62ffb4673f1e1747adff60e986225922b732e9df33404d02eb959b125fc56e1acf420bc0a34248a8249f5d165210a96c0f7d374f653419105884008bd1a56377"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 08:37:27.445989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:37:27.446323) ========= 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=523ca41ca1e0623de333ad52000001bf-1465395659.668589-1037890347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:37:27.532691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 08:37:27.533072) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 08:37:27.533492) ========= ========= Total master_lag: 0.17 =========