builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1465313173.66 results: success (0) buildid: 20160607053456 builduid: d3833be84c8d4486a7e37de4eaed1379 revision: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.655737) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.656381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.656807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.672431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.672837) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 08:26:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-06-07 08:26:14 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.807206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.807604) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014482 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:13.857916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 08:26:13.858299) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 --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 d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 --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=337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 08:26:14,199 truncating revision to first 12 chars 2016-06-07 08:26:14,200 Setting DEBUG logging. 2016-06-07 08:26:14,200 attempt 1/10 2016-06-07 08:26:14,200 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d6e0d9a0319f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 08:26:15,376 unpacking tar archive at: fx-team-d6e0d9a0319f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 08:26:15.379725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:15.380212) ========= script_repo_revision: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:15.380999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:15.381441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:26:15.392114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-07 08:26:15.392508) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:26:15 INFO - MultiFileLogger online at 20160607 08:26:15 in /builds/slave/test 08:26:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:26:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:15 INFO - {'append_to_log': False, 08:26:15 INFO - 'base_work_dir': '/builds/slave/test', 08:26:15 INFO - 'blob_upload_branch': 'Fx-Team', 08:26:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:15 INFO - 'branch': 'Fx-Team', 08:26:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:15 INFO - 'config_files': ('talos/linux_config.py',), 08:26:15 INFO - 'default_actions': ('clobber', 08:26:15 INFO - 'read-buildbot-config', 08:26:15 INFO - 'download-and-extract', 08:26:15 INFO - 'populate-webroot', 08:26:15 INFO - 'create-virtualenv', 08:26:15 INFO - 'install', 08:26:15 INFO - 'run-tests'), 08:26:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:15 INFO - 'download_minidump_stackwalk': True, 08:26:15 INFO - 'download_symbols': 'ondemand', 08:26:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:15 INFO - 'installer_path': 'installer.exe', 08:26:15 INFO - 'log_level': 'info', 08:26:15 INFO - 'log_name': 'talos', 08:26:15 INFO - 'log_to_console': True, 08:26:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:26:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:26:15 INFO - 'opt_config_files': (), 08:26:15 INFO - 'pip_index': False, 08:26:15 INFO - 'sps_profile': False, 08:26:15 INFO - 'sps_profile_interval': 0, 08:26:15 INFO - 'suite': 'dromaeojs-e10s', 08:26:15 INFO - 'system_bits': '32', 08:26:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:15 INFO - 'title': 'talos-linux64-ix-060', 08:26:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:15 INFO - 'use_talos_json': True, 08:26:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:15 INFO - 'work_dir': 'build'} 08:26:15 INFO - ##### 08:26:15 INFO - ##### Running clobber step. 08:26:15 INFO - ##### 08:26:15 INFO - Running pre-action listener: _resource_record_pre_action 08:26:15 INFO - Running main action method: clobber 08:26:15 INFO - rmtree: /builds/slave/test/build 08:26:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:16 INFO - Running post-action listener: _resource_record_post_action 08:26:16 INFO - ##### 08:26:16 INFO - ##### Finished clobber step (success) 08:26:16 INFO - ##### 08:26:16 INFO - ##### 08:26:16 INFO - ##### Running read-buildbot-config step. 08:26:16 INFO - ##### 08:26:16 INFO - Running pre-action listener: _resource_record_pre_action 08:26:16 INFO - Running main action method: read_buildbot_config 08:26:16 INFO - Using buildbot properties: 08:26:16 INFO - { 08:26:16 INFO - "project": "", 08:26:16 INFO - "product": "firefox", 08:26:16 INFO - "script_repo_revision": "production", 08:26:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:26:16 INFO - "repository": "", 08:26:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:26:16 INFO - "buildid": "20160607053456", 08:26:16 INFO - "pgo_build": "True", 08:26:16 INFO - "basedir": "/builds/slave/test", 08:26:16 INFO - "buildnumber": 436, 08:26:16 INFO - "slavename": "talos-linux64-ix-060", 08:26:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:26:16 INFO - "platform": "ubuntu64_hw", 08:26:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:26:16 INFO - "branch": "fx-team", 08:26:16 INFO - "repo_path": "integration/fx-team", 08:26:16 INFO - "revision": "d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079", 08:26:16 INFO - "stage_platform": "linux64-pgo", 08:26:16 INFO - "builduid": "d3833be84c8d4486a7e37de4eaed1379", 08:26:16 INFO - "slavebuilddir": "test" 08:26:16 INFO - } 08:26:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:26:16 INFO - Running post-action listener: _resource_record_post_action 08:26:16 INFO - ##### 08:26:16 INFO - ##### Finished read-buildbot-config step (success) 08:26:16 INFO - ##### 08:26:16 INFO - ##### 08:26:16 INFO - ##### Running download-and-extract step. 08:26:16 INFO - ##### 08:26:16 INFO - Running pre-action listener: _resource_record_pre_action 08:26:16 INFO - Running main action method: download_and_extract 08:26:16 INFO - mkdir: /builds/slave/test/build/tests 08:26: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:26:16 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:17 INFO - Downloaded 1361 bytes. 08:26:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:26:17 INFO - Using the following test package requirements: 08:26:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:26:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:26:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'jsshell-linux-x86_64.zip'], 08:26:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:26:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:26:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:26:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:26:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:26:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:26:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:26:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:17 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:26:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:18 INFO - Downloaded 24443862 bytes. 08:26:18 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:26:18 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:26:19 INFO - Return code: 0 08:26:19 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:26: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:26:19 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:20 INFO - Downloaded 24443862 bytes. 08:26:20 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:26:20 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:26:22 INFO - Return code: 0 08:26: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:26:22 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:23 INFO - Downloaded 10833369 bytes. 08:26:23 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:26:23 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:26:23 INFO - Return code: 0 08:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:23 INFO - https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/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:26:24 INFO - Downloaded 59185931 bytes. 08:26:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:24 INFO - mkdir: /builds/slave/test/properties 08:26:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:24 INFO - Contents: 08:26:24 INFO - build_url:https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:26:25 INFO - Running post-action listener: _resource_record_post_action 08:26:25 INFO - Running post-action listener: set_extra_try_arguments 08:26:25 INFO - ##### 08:26:25 INFO - ##### Finished download-and-extract step (success) 08:26:25 INFO - ##### 08:26:25 INFO - ##### 08:26:25 INFO - ##### Running populate-webroot step. 08:26:25 INFO - ##### 08:26:25 INFO - Running pre-action listener: _resource_record_pre_action 08:26:25 INFO - Running main action method: populate_webroot 08:26:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:25 INFO - '--tppagecycles', 08:26:25 INFO - '7'], 08:26:25 INFO - 'tests': ['tsvgm']}}, 08:26:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['damp', 'tps']}, 08:26:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'tests': ['damp', 'tps']}, 08:26:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['dromaeo_dom']}, 08:26:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['a11yr', 08:26:25 INFO - 'ts_paint', 08:26:25 INFO - 'tpaint', 08:26:25 INFO - 'sessionrestore', 08:26:25 INFO - 'sessionrestore_no_auto_restore', 08:26:25 INFO - 'tabpaint']}, 08:26:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:25 INFO - 'ts_paint', 08:26:25 INFO - 'tpaint', 08:26:25 INFO - 'sessionrestore', 08:26:25 INFO - 'sessionrestore_no_auto_restore', 08:26:25 INFO - 'tabpaint']}, 08:26:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:25 INFO - 'ts_paint', 08:26:25 INFO - 'tpaint', 08:26:25 INFO - 'sessionrestore', 08:26:25 INFO - 'sessionrestore_no_auto_restore', 08:26:25 INFO - 'tabpaint']}, 08:26:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:25 INFO - 'ts_paint', 08:26:25 INFO - 'tpaint', 08:26:25 INFO - 'sessionrestore', 08:26:25 INFO - 'sessionrestore_no_auto_restore', 08:26:25 INFO - 'tabpaint']}, 08:26:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['a11yr', 08:26:25 INFO - 'ts_paint', 08:26:25 INFO - 'tpaint', 08:26:25 INFO - 'sessionrestore', 08:26:25 INFO - 'sessionrestore_no_auto_restore', 08:26:25 INFO - 'tabpaint']}, 08:26:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['a11yr', 08:26:25 INFO - 'ts_paint', 08:26:25 INFO - 'tpaint', 08:26:25 INFO - 'sessionrestore', 08:26:25 INFO - 'sessionrestore_no_auto_restore', 08:26:25 INFO - 'tabpaint']}, 08:26:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['tsvgx', 08:26:25 INFO - 'tsvgr_opacity', 08:26:25 INFO - 'tart', 08:26:25 INFO - 'tscrollx', 08:26:25 INFO - 'cart']}, 08:26:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:25 INFO - 'tsvgr_opacity', 08:26:25 INFO - 'tart', 08:26:25 INFO - 'tscrollx', 08:26:25 INFO - 'cart']}, 08:26:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'talos_options': ['--disable-e10s'], 08:26:25 INFO - 'tests': ['tp5o']}, 08:26:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'tests': ['tp5o']}, 08:26:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'talos_options': ['--disable-e10s', 08:26:25 INFO - '--xperf_path', 08:26:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:25 INFO - 'tests': ['tp5n']}, 08:26:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:25 INFO - 'talos_options': ['--xperf_path', 08:26:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:25 INFO - 'tests': ['tp5n']}}, 08:26:25 INFO - 'talos.zip': {'path': '', 08:26:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:25 INFO - Running post-action listener: _resource_record_post_action 08:26:25 INFO - ##### 08:26:25 INFO - ##### Finished populate-webroot step (success) 08:26:25 INFO - ##### 08:26:25 INFO - ##### 08:26:25 INFO - ##### Running create-virtualenv step. 08:26:25 INFO - ##### 08:26:25 INFO - Running pre-action listener: _resource_record_pre_action 08:26:25 INFO - Running main action method: create_virtualenv 08:26:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:25 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:26:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:25 INFO - Using real prefix '/usr' 08:26:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:28 INFO - Installing pip.................done. 08:26:28 INFO - Return code: 0 08:26:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:28 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:28 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:26:28 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:26:28 INFO - Using env: {'DISPLAY': ':0', 08:26:28 INFO - 'HOME': '/home/cltbld', 08:26:28 INFO - 'LANG': 'en_US.UTF-8', 08:26:28 INFO - 'LANGUAGE': 'en_US:en', 08:26:28 INFO - 'LOGNAME': 'cltbld', 08:26:28 INFO - 'MAIL': '/var/mail/cltbld', 08:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:28 INFO - 'MOZ_NO_REMOTE': '1', 08:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:28 INFO - 'NO_EM_RESTART': '1', 08:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:28 INFO - 'PWD': '/builds/slave/test', 08:26:28 INFO - 'SHELL': '/bin/bash', 08:26:28 INFO - 'SHLVL': '1', 08:26:28 INFO - 'TERM': 'linux', 08:26:28 INFO - 'TMOUT': '86400', 08:26:28 INFO - 'USER': 'cltbld', 08:26:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:28 INFO - '_': '/tools/buildbot/bin/python'} 08:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:28 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:26:28 INFO - Cleaning up... 08:26:28 INFO - Return code: 0 08:26:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:28 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:28 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:26:28 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:26:28 INFO - Using env: {'DISPLAY': ':0', 08:26:28 INFO - 'HOME': '/home/cltbld', 08:26:28 INFO - 'LANG': 'en_US.UTF-8', 08:26:28 INFO - 'LANGUAGE': 'en_US:en', 08:26:28 INFO - 'LOGNAME': 'cltbld', 08:26:28 INFO - 'MAIL': '/var/mail/cltbld', 08:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:28 INFO - 'MOZ_NO_REMOTE': '1', 08:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:28 INFO - 'NO_EM_RESTART': '1', 08:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:28 INFO - 'PWD': '/builds/slave/test', 08:26:28 INFO - 'SHELL': '/bin/bash', 08:26:28 INFO - 'SHLVL': '1', 08:26:28 INFO - 'TERM': 'linux', 08:26:28 INFO - 'TMOUT': '86400', 08:26:28 INFO - 'USER': 'cltbld', 08:26:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:28 INFO - '_': '/tools/buildbot/bin/python'} 08:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:28 INFO - Downloading/unpacking psutil>=3.1.1 08:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:30 INFO - Installing collected packages: psutil 08:26:30 INFO - Running setup.py install for psutil 08:26:30 INFO - building 'psutil._psutil_linux' extension 08:26:30 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:26:30 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:26:30 INFO - building 'psutil._psutil_posix' extension 08:26:30 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:26:31 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:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:31 INFO - Successfully installed psutil 08:26:31 INFO - Cleaning up... 08:26:31 INFO - Return code: 0 08:26:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:26:31 INFO - Using env: {'DISPLAY': ':0', 08:26:31 INFO - 'HOME': '/home/cltbld', 08:26:31 INFO - 'LANG': 'en_US.UTF-8', 08:26:31 INFO - 'LANGUAGE': 'en_US:en', 08:26:31 INFO - 'LOGNAME': 'cltbld', 08:26:31 INFO - 'MAIL': '/var/mail/cltbld', 08:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:31 INFO - 'MOZ_NO_REMOTE': '1', 08:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:31 INFO - 'NO_EM_RESTART': '1', 08:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:31 INFO - 'PWD': '/builds/slave/test', 08:26:31 INFO - 'SHELL': '/bin/bash', 08:26:31 INFO - 'SHLVL': '1', 08:26:31 INFO - 'TERM': 'linux', 08:26:31 INFO - 'TMOUT': '86400', 08:26:31 INFO - 'USER': 'cltbld', 08:26:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:31 INFO - '_': '/tools/buildbot/bin/python'} 08:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:33 INFO - Installing collected packages: mozsystemmonitor 08:26:33 INFO - Running setup.py install for mozsystemmonitor 08:26:33 INFO - Successfully installed mozsystemmonitor 08:26:33 INFO - Cleaning up... 08:26:33 INFO - Return code: 0 08:26:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:26:33 INFO - Using env: {'DISPLAY': ':0', 08:26:33 INFO - 'HOME': '/home/cltbld', 08:26:33 INFO - 'LANG': 'en_US.UTF-8', 08:26:33 INFO - 'LANGUAGE': 'en_US:en', 08:26:33 INFO - 'LOGNAME': 'cltbld', 08:26:33 INFO - 'MAIL': '/var/mail/cltbld', 08:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:33 INFO - 'MOZ_NO_REMOTE': '1', 08:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:33 INFO - 'NO_EM_RESTART': '1', 08:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:33 INFO - 'PWD': '/builds/slave/test', 08:26:33 INFO - 'SHELL': '/bin/bash', 08:26:33 INFO - 'SHLVL': '1', 08:26:33 INFO - 'TERM': 'linux', 08:26:33 INFO - 'TMOUT': '86400', 08:26:33 INFO - 'USER': 'cltbld', 08:26:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:33 INFO - '_': '/tools/buildbot/bin/python'} 08:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:33 INFO - Downloading/unpacking jsonschema==2.5.1 08:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:35 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:35 INFO - warning: no files found matching '*.txt' 08:26:35 INFO - no previously-included directories found matching 'build' 08:26:35 INFO - no previously-included directories found matching 'dist' 08:26:35 INFO - no previously-included directories found matching '.git*' 08:26:35 INFO - Installing collected packages: jsonschema, functools32 08:26:35 INFO - Running setup.py install for functools32 08:26:36 INFO - warning: no files found matching '*.txt' 08:26:36 INFO - no previously-included directories found matching 'build' 08:26:36 INFO - no previously-included directories found matching 'dist' 08:26:36 INFO - no previously-included directories found matching '.git*' 08:26:36 INFO - Successfully installed jsonschema functools32 08:26:36 INFO - Cleaning up... 08:26:36 INFO - Return code: 0 08:26:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:36 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:36 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:26:36 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:26:36 INFO - Using env: {'DISPLAY': ':0', 08:26:36 INFO - 'HOME': '/home/cltbld', 08:26:36 INFO - 'LANG': 'en_US.UTF-8', 08:26:36 INFO - 'LANGUAGE': 'en_US:en', 08:26:36 INFO - 'LOGNAME': 'cltbld', 08:26:36 INFO - 'MAIL': '/var/mail/cltbld', 08:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:36 INFO - 'MOZ_NO_REMOTE': '1', 08:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:36 INFO - 'NO_EM_RESTART': '1', 08:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:36 INFO - 'PWD': '/builds/slave/test', 08:26:36 INFO - 'SHELL': '/bin/bash', 08:26:36 INFO - 'SHLVL': '1', 08:26:36 INFO - 'TERM': 'linux', 08:26:36 INFO - 'TMOUT': '86400', 08:26:36 INFO - 'USER': 'cltbld', 08:26:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:36 INFO - '_': '/tools/buildbot/bin/python'} 08:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 INFO - Downloading docopt-0.6.1.tar.gz 08:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:38 INFO - Running setup.py install for blobuploader 08:26:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:39 INFO - Running setup.py install for requests 08:26:39 INFO - Running setup.py install for docopt 08:26:39 INFO - Successfully installed blobuploader requests docopt 08:26:39 INFO - Cleaning up... 08:26:39 INFO - Return code: 0 08:26:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:39 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:39 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:26:39 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:26:39 INFO - Using env: {'DISPLAY': ':0', 08:26:39 INFO - 'HOME': '/home/cltbld', 08:26:39 INFO - 'LANG': 'en_US.UTF-8', 08:26:39 INFO - 'LANGUAGE': 'en_US:en', 08:26:39 INFO - 'LOGNAME': 'cltbld', 08:26:39 INFO - 'MAIL': '/var/mail/cltbld', 08:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:39 INFO - 'MOZ_NO_REMOTE': '1', 08:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:39 INFO - 'NO_EM_RESTART': '1', 08:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:39 INFO - 'PWD': '/builds/slave/test', 08:26:39 INFO - 'SHELL': '/bin/bash', 08:26:39 INFO - 'SHLVL': '1', 08:26:39 INFO - 'TERM': 'linux', 08:26:39 INFO - 'TMOUT': '86400', 08:26:39 INFO - 'USER': 'cltbld', 08:26:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:39 INFO - '_': '/tools/buildbot/bin/python'} 08:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:39 INFO - Running setup.py (path:/tmp/pip-XyI6sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:39 INFO - Running setup.py (path:/tmp/pip-TjS0zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:39 INFO - Running setup.py (path:/tmp/pip-2jrSrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:40 INFO - Running setup.py (path:/tmp/pip-dXOVwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:40 INFO - Running setup.py (path:/tmp/pip-PqR6i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:40 INFO - Running setup.py (path:/tmp/pip-OEKRDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:40 INFO - Running setup.py (path:/tmp/pip-00UgQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:40 INFO - Running setup.py (path:/tmp/pip-qwAihB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:40 INFO - Running setup.py (path:/tmp/pip-bwo9Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:40 INFO - Running setup.py (path:/tmp/pip-Xz7bAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:40 INFO - Running setup.py (path:/tmp/pip-bx3xtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:40 INFO - Running setup.py (path:/tmp/pip-Mh_6yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:40 INFO - Running setup.py (path:/tmp/pip-yf_jsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:40 INFO - Running setup.py (path:/tmp/pip-Dz3Gpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:40 INFO - Running setup.py (path:/tmp/pip-YWngnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:40 INFO - Running setup.py (path:/tmp/pip-CGYabt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:40 INFO - Running setup.py (path:/tmp/pip-XSJh7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:41 INFO - Running setup.py install for manifestparser 08:26:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Running setup.py install for mozcrash 08:26:41 INFO - Running setup.py install for mozdebug 08:26:41 INFO - Running setup.py install for mozdevice 08:26:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Running setup.py install for mozfile 08:26:41 INFO - Running setup.py install for mozhttpd 08:26:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Running setup.py install for mozinfo 08:26:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Running setup.py install for mozInstall 08:26:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:41 INFO - Running setup.py install for mozleak 08:26:41 INFO - Running setup.py install for mozlog 08:26:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Running setup.py install for moznetwork 08:26:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Running setup.py install for mozprocess 08:26:42 INFO - Running setup.py install for mozprofile 08:26:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Running setup.py install for mozrunner 08:26:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Running setup.py install for mozscreenshot 08:26:42 INFO - Running setup.py install for moztest 08:26:42 INFO - Running setup.py install for mozversion 08:26:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:42 INFO - Cleaning up... 08:26:42 INFO - Return code: 0 08:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26: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:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:42 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:42 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:26:42 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:26:42 INFO - Using env: {'DISPLAY': ':0', 08:26:42 INFO - 'HOME': '/home/cltbld', 08:26:42 INFO - 'LANG': 'en_US.UTF-8', 08:26:42 INFO - 'LANGUAGE': 'en_US:en', 08:26:42 INFO - 'LOGNAME': 'cltbld', 08:26:42 INFO - 'MAIL': '/var/mail/cltbld', 08:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:42 INFO - 'MOZ_NO_REMOTE': '1', 08:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:42 INFO - 'NO_EM_RESTART': '1', 08:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:42 INFO - 'PWD': '/builds/slave/test', 08:26:42 INFO - 'SHELL': '/bin/bash', 08:26:42 INFO - 'SHLVL': '1', 08:26:42 INFO - 'TERM': 'linux', 08:26:42 INFO - 'TMOUT': '86400', 08:26:42 INFO - 'USER': 'cltbld', 08:26:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:42 INFO - '_': '/tools/buildbot/bin/python'} 08:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:43 INFO - Running setup.py (path:/tmp/pip-99gwny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:43 INFO - Running setup.py (path:/tmp/pip-dqBrw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:43 INFO - Running setup.py (path:/tmp/pip-6_NUh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:43 INFO - Running setup.py (path:/tmp/pip-oorEjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:43 INFO - Running setup.py (path:/tmp/pip-dPrzET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:43 INFO - Running setup.py (path:/tmp/pip-AAJQ4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:43 INFO - Running setup.py (path:/tmp/pip-Mgp_Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:43 INFO - Running setup.py (path:/tmp/pip-sVV9yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:43 INFO - Running setup.py (path:/tmp/pip-cIluVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:43 INFO - Running setup.py (path:/tmp/pip-osMXnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:43 INFO - Running setup.py (path:/tmp/pip-wizzm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:43 INFO - Running setup.py (path:/tmp/pip-5gecQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:43 INFO - Running setup.py (path:/tmp/pip-qXlaen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:43 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:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:43 INFO - Running setup.py (path:/tmp/pip-Bc43Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:44 INFO - Running setup.py (path:/tmp/pip-PZlo_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:44 INFO - Running setup.py (path:/tmp/pip-qAJxyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:44 INFO - Running setup.py (path:/tmp/pip-_0F_dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:46 INFO - Downloading blessings-1.6.tar.gz 08:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:26:46 INFO - Installing collected packages: blessings 08:26:46 INFO - Running setup.py install for blessings 08:26:46 INFO - Successfully installed blessings 08:26:46 INFO - Cleaning up... 08:26:46 INFO - Return code: 0 08:26:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:26:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:46 INFO - Reading from file tmpfile_stdout 08:26:46 INFO - Current package versions: 08:26:46 INFO - argparse == 1.2.1 08:26:46 INFO - blessings == 1.6 08:26:46 INFO - blobuploader == 1.2.4 08:26:46 INFO - docopt == 0.6.1 08:26:46 INFO - functools32 == 3.2.3-2 08:26:46 INFO - jsonschema == 2.5.1 08:26:46 INFO - manifestparser == 1.1 08:26:46 INFO - mozInstall == 1.12 08:26:46 INFO - mozcrash == 0.17 08:26:46 INFO - mozdebug == 0.1 08:26:46 INFO - mozdevice == 0.48 08:26:46 INFO - mozfile == 1.2 08:26:46 INFO - mozhttpd == 0.7 08:26:46 INFO - mozinfo == 0.9 08:26:46 INFO - mozleak == 0.1 08:26:46 INFO - mozlog == 3.2 08:26:46 INFO - moznetwork == 0.27 08:26:46 INFO - mozprocess == 0.22 08:26:46 INFO - mozprofile == 0.28 08:26:46 INFO - mozrunner == 6.11 08:26:46 INFO - mozscreenshot == 0.1 08:26:46 INFO - mozsystemmonitor == 0.3 08:26:46 INFO - moztest == 0.7 08:26:46 INFO - mozversion == 1.4 08:26:46 INFO - psutil == 3.1.1 08:26:46 INFO - requests == 1.2.3 08:26:46 INFO - wsgiref == 0.1.2 08:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:46 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:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:46 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:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:46 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:46 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:26:46 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:26:46 INFO - Using env: {'DISPLAY': ':0', 08:26:46 INFO - 'HOME': '/home/cltbld', 08:26:46 INFO - 'LANG': 'en_US.UTF-8', 08:26:46 INFO - 'LANGUAGE': 'en_US:en', 08:26:46 INFO - 'LOGNAME': 'cltbld', 08:26:46 INFO - 'MAIL': '/var/mail/cltbld', 08:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:46 INFO - 'MOZ_NO_REMOTE': '1', 08:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:46 INFO - 'NO_EM_RESTART': '1', 08:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:46 INFO - 'PWD': '/builds/slave/test', 08:26:46 INFO - 'SHELL': '/bin/bash', 08:26:46 INFO - 'SHLVL': '1', 08:26:46 INFO - 'TERM': 'linux', 08:26:46 INFO - 'TMOUT': '86400', 08:26:46 INFO - 'USER': 'cltbld', 08:26:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:46 INFO - '_': '/tools/buildbot/bin/python'} 08:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 INFO - Cleaning up... 08:26:46 INFO - Return code: 0 08:26:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:26:46 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:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:46 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:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:46 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:46 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:26:46 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:26:46 INFO - Using env: {'DISPLAY': ':0', 08:26:46 INFO - 'HOME': '/home/cltbld', 08:26:46 INFO - 'LANG': 'en_US.UTF-8', 08:26:46 INFO - 'LANGUAGE': 'en_US:en', 08:26:46 INFO - 'LOGNAME': 'cltbld', 08:26:46 INFO - 'MAIL': '/var/mail/cltbld', 08:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:46 INFO - 'MOZ_NO_REMOTE': '1', 08:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:46 INFO - 'NO_EM_RESTART': '1', 08:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:46 INFO - 'PWD': '/builds/slave/test', 08:26:46 INFO - 'SHELL': '/bin/bash', 08:26:46 INFO - 'SHLVL': '1', 08:26:46 INFO - 'TERM': 'linux', 08:26:46 INFO - 'TMOUT': '86400', 08:26:46 INFO - 'USER': 'cltbld', 08:26:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:46 INFO - '_': '/tools/buildbot/bin/python'} 08:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:26:47 INFO - Cleaning up... 08:26:47 INFO - Return code: 0 08:26:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:26: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:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:47 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 0x7fa1513b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, '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': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', '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:26:47 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:26:47 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:26:47 INFO - Using env: {'DISPLAY': ':0', 08:26:47 INFO - 'HOME': '/home/cltbld', 08:26:47 INFO - 'LANG': 'en_US.UTF-8', 08:26:47 INFO - 'LANGUAGE': 'en_US:en', 08:26:47 INFO - 'LOGNAME': 'cltbld', 08:26:47 INFO - 'MAIL': '/var/mail/cltbld', 08:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:47 INFO - 'MOZ_NO_REMOTE': '1', 08:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:47 INFO - 'NO_EM_RESTART': '1', 08:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:47 INFO - 'PWD': '/builds/slave/test', 08:26:47 INFO - 'SHELL': '/bin/bash', 08:26:47 INFO - 'SHLVL': '1', 08:26:47 INFO - 'TERM': 'linux', 08:26:47 INFO - 'TMOUT': '86400', 08:26:47 INFO - 'USER': 'cltbld', 08:26:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:47 INFO - '_': '/tools/buildbot/bin/python'} 08:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:47 INFO - Downloading/unpacking flake8 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:26:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:26:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:26:49 INFO - no previously-included directories found matching 'docs/_build' 08:26:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:26:49 INFO - Running setup.py install for pep8 08:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:26:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:26:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:26:50 INFO - no previously-included directories found matching 'docs/_build' 08:26:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:26:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:26:50 INFO - Cleaning up... 08:26:50 INFO - Return code: 0 08:26:50 INFO - Running post-action listener: _resource_record_post_action 08:26:50 INFO - Running post-action listener: _start_resource_monitoring 08:26:50 INFO - Starting resource monitoring. 08:26:50 INFO - ##### 08:26:50 INFO - ##### Finished create-virtualenv step (success) 08:26:50 INFO - ##### 08:26:50 INFO - ##### 08:26:50 INFO - ##### Running install step. 08:26:50 INFO - ##### 08:26:50 INFO - Running pre-action listener: _resource_record_pre_action 08:26:50 INFO - Running main action method: install 08:26:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:50 INFO - Reading from file tmpfile_stdout 08:26:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:26:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:26:50 INFO - Reading from file tmpfile_stdout 08:26:50 INFO - Output received: 08:26:50 INFO - Usage: mozinstall [options] installer 08:26:50 INFO - Options: 08:26:50 INFO - -h, --help show this help message and exit 08:26:50 INFO - -d DEST, --destination=DEST 08:26:50 INFO - Directory to install application into. [default: 08:26:50 INFO - "/builds/slave/test"] 08:26:50 INFO - --app=APP Application being installed. [default: firefox] 08:26:50 INFO - mkdir: /builds/slave/test/build/application 08:26:50 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:26:50 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:27:07 INFO - Reading from file tmpfile_stdout 08:27:07 INFO - Output received: 08:27:07 INFO - /builds/slave/test/build/application/firefox/firefox 08:27:07 INFO - Running post-action listener: _resource_record_post_action 08:27:07 INFO - ##### 08:27:07 INFO - ##### Finished install step (success) 08:27:07 INFO - ##### 08:27:07 INFO - ##### 08:27:07 INFO - ##### Running run-tests step. 08:27:07 INFO - ##### 08:27:07 INFO - Running pre-action listener: _resource_record_pre_action 08:27:07 INFO - Running main action method: run_tests 08:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:07 INFO - Python 2.7.3 08:27:07 INFO - Return code: 0 08:27:07 INFO - grabbing minidump binary from tooltool 08:27:07 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:27:07 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 0x1755d00>, '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 0x1756ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1756f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:07 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:27:07 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:27:07 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:27:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:07 INFO - Return code: 0 08:27:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:27:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:27:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:27:08 INFO - Return code: 0 08:27:08 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:27:08 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:27:08 INFO - Using env: {'DISPLAY': ':0', 08:27:08 INFO - 'HOME': '/home/cltbld', 08:27:08 INFO - 'LANG': 'en_US.UTF-8', 08:27:08 INFO - 'LANGUAGE': 'en_US:en', 08:27:08 INFO - 'LOGNAME': 'cltbld', 08:27:08 INFO - 'MAIL': '/var/mail/cltbld', 08:27:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:08 INFO - 'MOZ_NO_REMOTE': '1', 08:27:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:08 INFO - 'NO_EM_RESTART': '1', 08:27:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:08 INFO - 'PWD': '/builds/slave/test', 08:27:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:08 INFO - 'SHELL': '/bin/bash', 08:27:08 INFO - 'SHLVL': '1', 08:27:08 INFO - 'TERM': 'linux', 08:27:08 INFO - 'TMOUT': '86400', 08:27:08 INFO - 'USER': 'cltbld', 08:27:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013', 08:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:08 INFO - '_': '/tools/buildbot/bin/python'} 08:27:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:27:08 INFO - mozversion application_buildid: 20160607053456 08:27:08 INFO - mozversion application_changeset: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 08:27:08 INFO - mozversion application_display_name: Nightly 08:27:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:08 INFO - mozversion application_name: Firefox 08:27:08 INFO - mozversion application_remotingname: firefox 08:27:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:27:08 INFO - mozversion application_vendor: Mozilla 08:27:08 INFO - mozversion application_version: 50.0a1 08:27:08 INFO - mozversion platform_buildid: 20160607053456 08:27:08 INFO - mozversion platform_changeset: d6e0d9a0319f4d52cfdb15b691b50b4e1bd36079 08:27:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:27:08 INFO - mozversion platform_version: 50.0a1 08:27:08 INFO - using testdate: 1465313228 08:27:08 INFO - actual date: 1465313228 08:27:08 INFO - starting webserver on 'localhost:41999' 08:27:08 INFO - SUITE-START | Running 2 tests 08:27:08 INFO - TEST-START | dromaeo_css 08:27:08 INFO - operating with platform_type : linux_ 08:27:08 INFO - Initialising browser for dromaeo_css test... 08:27:08 INFO - TEST-INFO | started process 24538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7hw2gt/profile http://localhost:41999/getInfo.html) 08:27:13 INFO - PROCESS | 24538 | __metrics Screen width/height:1600/1200 08:27:13 INFO - PROCESS | 24538 | colorDepth:24 08:27:13 INFO - PROCESS | 24538 | Browser inner width/height: 1024/697 08:27:13 INFO - PROCESS | 24538 | __metrics 08:27:13 ERROR - PROCESS | 24538 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 08:27:14 INFO - TEST-INFO | 24538: exit 0 08:27:14 INFO - Browser initialized. 08:27:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:14 INFO - TEST-INFO | started process 24663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7hw2gt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:26 INFO - PROCESS | 24663 | RSS: Main: 167452672 08:27:26 INFO - PROCESS | 24663 | 08:28:16 INFO - PROCESS | 24663 | 1465313296258 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:30:23 INFO - PROCESS | 24663 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41999/tests/dromaeo/cssquery-ext.html) 08:30:24 INFO - PROCESS | 24663 | RSS: Main: 171401216 08:30:24 INFO - PROCESS | 24663 | 08:33:26 INFO - PROCESS | 24663 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-ext.html (next: http://localhost:41999/tests/dromaeo/cssquery-jquery.html) 08:33:27 INFO - PROCESS | 24663 | RSS: Main: 169971712 08:33:27 INFO - PROCESS | 24663 | 08:36:29 INFO - PROCESS | 24663 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41999/tests/dromaeo/cssquery-mootools.html) 08:36:29 INFO - PROCESS | 24663 | RSS: Main: 171204608 08:36:29 INFO - PROCESS | 24663 | 08:39:31 INFO - PROCESS | 24663 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41999/tests/dromaeo/cssquery-prototype.html) 08:39:32 INFO - PROCESS | 24663 | RSS: Main: 169365504 08:39:32 INFO - PROCESS | 24663 | 08:42:34 INFO - PROCESS | 24663 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41999/tests/dromaeo/cssquery-yui.html) 08:42:35 INFO - PROCESS | 24663 | RSS: Main: 171057152 08:42:35 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-yui.html (next: http://localhost:41999/tests/dromaeo/cssquery-dojo.html) 08:45:38 INFO - PROCESS | 24663 | RSS: Main: 172359680 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | __start_tp_report 08:45:38 INFO - PROCESS | 24663 | _x_x_mozilla_page_load 08:45:38 INFO - PROCESS | 24663 | _x_x_mozilla_page_load_details 08:45:38 INFO - PROCESS | 24663 | |i|pagename|runs| 08:45:38 INFO - PROCESS | 24663 | |0;dojo.html;3127.624685037795;3185.5699480570115;3215.0354893531944;3229.2895562976137;3229.983850080749;5424.783008679653;5425.0506161421745;5459.426760190182;5496.890062198753;5528.778848846041;5348.358197016363;5478.945210547893;5501.449855014496;5529;5584.972075139619;4978.502149785028;5006.374203224597;5112.97443512782;5146.073706732786;5199.298094757216;816.2539738199683;4963.032208719301;5095;5138.768755406016;5171.095058364771;5073.467285934979;5080.1363768159135;5104.132297509433;5113.795448182068;5150.1759718445055;5031.647784655075;5112.846614601568;5113.82101626445;5133.101707201225;5137.3064636274;5022.321986531808;5024.773885175176;5024.799008039674;5042.42012168598;5128.897422051576;5459.426760190163;5461.644993075477;5497.230387745719;5515.834524964257;5541.141123125922;5727.140928860705;5850.590458667895;5894.4989675877605;6042.9395706042815;6048.425399587032;6002.909956350658;6007.729652165663;6012.488938440238;6018.247719035121;6036.9698151508965;5561.833145005657;5563.972180139114;5578.693171875586;5581.2186293918885;5585.469380408855;5870.882582348329;6002.399760023963;6027.186329845503;6067.302260240129;6132.816015519542;5848.385919478478;5849.795257165979;5865.149553314745;5870.970645146747;5910.763569457174;5867.735951882176;5916.171735956969;5916.645001299849;5918.911216331759;5921.792737254262;5786.1610066540115;5891.675957822361;5893.705314734332;5940.79207227745;5972.193753843176;5686.516646085129;5879.764809407576;5941.257342832146;5977.073553599199;6003.459688628044;4537.2059889519205;4540.455145382509;4550.180967425829;4552.7723613819835;4567.063751930847;3923.2938071146896;3972.0864201233876;3974.2250261199365;3992.6007399260425;4051.0277533391773;5776.191333213354;5789.797357092481;5790.247267855152;5791.88416231673;5815.912761308584;6023.156758053876;6041.6375017499095;6091.269047714302;6093.146959425684;6093.847653808691;5474.206240095244;5674.460926212003;5685.886282274414;5724.3130824300515;5724.570657200727;5081.644284900021;5115.693058416507;5154.639175257771;5156.175011998137;5158.92261616076;5913.46778789911;6231.283402408691;6240.563160578716;6250;6255.40573645503;5909.438603332676;5933.970330148321;5941.881162376641;5989.131575921554;5995.160677505066;6092.634441933498;6138.969305153446;6147.815565533041;6151.630902145886;6154.753809847735;5619.241402410622;5766.221560089334;5767.884642307215;5778.768849245983;5819.272590926134;5954.10688396744;5988.311344195473;5991.281046274475;6018.157457955977;6055.061465472859;5770.9711451444155;5788.710564471844;5838.824835254949;5839.912401313899;5850.531957443309;5630.971845140748;5733.541316694571;5762.4525670061275;5811.912821307599;5833.300003999547;5542.0855558832345;5684.261046064151;5699.059655156852;5736.512396446182;5772.249607550992;5858;5863.589548731547;5892.705364731832;5892.852678683067;5917.852053698692;5528.226048353315;5597.6641401516035;5612.635178713371;5717.542596592346;5767.0196066669605 08:45:38 INFO - PROCESS | 24663 | |1;ext.html;578.1876463568685;606.865162146785;610.929743079546;616.082037763732;635.9777407790726;42779.35830962534;43300.566994330045;43879.561204387945;43891.122177556426;47166.76416617921;44702.776486117524;45185.77407112968;45425.54574454254;45493.31760023602;45512.77243613777;8610.095939926296;8759.211670949613;8795.164459376349;8828.911710882905;8853.026167121612;8756.737297881042;8853.335999800009;8853.690120845771;8860.911390886105;8871.733847984571;8882.733517994471;8945.105489451067;8957.104289571056;8958.283337332998;8969.058248883872;8488.108748581402;8630.525321107369;8653.610587523577;8694.869576956318;8858.601362938683;8724.563771811447;8801.779955501099;8864.73405797827;8883.022867484571;8895.4662720237;41685.58314416847;41698;41978;42226.15547689029;42293.15413691709;3595.388783906742;3671.1005803578028;3672.7429079964413;3693.778373297611;3695.4087346024776;32547.349053019043;32782;32838.507422388684;34253.828730856185;34322.14194645154;4044.8027423742583;4160.126373461577;4211.263028969948;4251.043515209084;4294.484661840599;369714;371405;374477;375146.12426937965;375833;33907.83046084754;34822.82588587041;57136.42863571394;57609;57944;36525;36569.26861462756;36719.26561468756;36724.81637591795;36725.81637091797;14257.92871035659;14316.355763990645;14375.353109110116;14431.278436078153;14440.566782996317;11928.582499612472;12014.699632509082;12024.098192635412;12108.21296615717;12161.939190303992;8229.917700822914;8315.251627353568;8336.749897503085;8411.663533458594;8418.831623367498;3201.199700074981;3241;3266.6733326667145;3285.917852053718;3291.5556399886186;1041.2763129624839;1063.9680809575725;1066.1843689577324;1074.9423960266924;1109.9999999999839;32618.673813262038;32656.414723598555;32848.17879552983;32904.67095329016;33026;1102.2284400919227;1154.440096553171;1181.2499063094997;1184.5557915781583;1196.6948428150765;16717.247723852455;17052.48842534726;17157.313707451813;17233;17236.82763172352;547063;552599;553528;553751;554446;56252.43747562472;57215.14177287344;57348;57453.42546574564;57507.13739293914;1304.4847285322244;1338.2305174524688;1396.406527225925;1402.2988505747126;1407.6129064507343;30669.693303066684;31406.37187256288;31741;31859.20351991126;32020;49731.502684972686;49829.75085124551;50141;50197.74901125471;50370;428661;432559;434683;436937;438083;27301.86349068242;27507.724922750516;27668;27743.583846242727;27748.722512774613;46311.53688463207;47630.28554571615;47947;48790.5120948786;49116.75441622769;40102.65898713704;40987;41250.38124428076;41381;41617;38968.41547376735;39889.81099801549;39964.60035399725;40101.19797603973;40144;40437.39343909785;40837;40868;41554.168916622104;44495.777521112184;33906.83046584751;37084.258314833016;37380.626193738804;37888;38428;28652.137611055216;28681.713182868738;28910.566341504473;28926.855365723037;29269.41461170807 08:45:38 INFO - PROCESS | 24663 | |2;jquery.html;388.615270881827;390.1436347217858;390.32084173538044;391.56536244768284;413.6112054668611;17823.28706851726;19274.807251927476;19683;19743.901280493577;20162.59674806503;18345;18882;18987.240510379605;19061.523461913424;19116.23535058596;5550.084236101038;5578.776848926038;5700;5740.512056475204;5753.712314384285;5622.522085622706;5631.2960879890015;5644.8024319148835;5649.435056494359;5650.971745141289;5440.700761458118;5609.551235901138;5629.774809007635;5695.202671625976;5702.344230413514;5648.350439699446;5663.093904975205;5668.121441176624;5670.971645141748;5689.886202275952;4868.634852386085;4966.106100901836;4996.775145118479;5014.824481143142;5075.670081444694;22012.339629811133;22057.669134962987;22699.432514187112;23028.272879534103;23101;2444.2300675287406;2501.9874900625564;2543.872806359693;2634.6443230163873;2712.9457410851674;14077;14467.71064578713;14496.85503144976;14620;14663.193524356157;1924.0956750327323;2012.255465477768;2021.9494512637302;2041.7141600175987;2042.8876411797346;61030.69484652593;67448.32551674519;69101;78469.60765196195;80392;10300.175985921109;10473.214508911862;10828.512716927757;10883.564657413615;11013.944930275296;14853.925730371495;14947.925260373628;14948.32732527039;14987.850121498863;15002.399904003936;7758.534487930742;8119.959400202961;8220.671173153127;8255.463394879314;8295.917040829514;7895.512913432251;7922.920770792333;8023.117457079717;8033.7991550210545;8141.18588141193;6587.637679927554;6610;6638.634875081917;6793.5244532882225;6897.379235868796;1891.7635295588052;1900.686386746199;1913.7129430585524;1922.3848368522217;1930.7683078030727;800.4316934976232;976.9267304952015;1029.6807989523272;1034.374203606822;1050.3067975136373;19381.344368974176;20108.798912010694;20132.496687582927;20399.796002040086;20417.285395011102;933.4725879877848;975.8097171051719;1048.2819268800895;1071.45891324882;1126.2679258482053;10310.948445257725;10788.56845726178;10822.51298691545;10866.511007004703;10868;458965;461400;468783;469267;473849;78513;88405;91764;92008;93388.53305733428;1042.4475028235047;1070.3043022035738;1071.8070747265567;1081.6809041332826;1087.9891201087887;17698.8495747776;17988;18110.456686299432;18175.45473635793;18371.173297201924;41559;42615.14769704651;42716.14567708566;44048.779756101016;44355.33466998062;59514.70242648759;60716.39283607107;61161;61301.38698613135;61988.69005654943;5488.588355873405;7873.84252314939;7914.960425197837;7965.641546130322;8036.1160272368825;8547.95726021366;11716.765664686829;12509.43707533145;12963.22220666763;13164.539241126515;11310.095192384424;11377.691565469746;11656.18406711522;11704.356260405419;12020.63938081859;9290.860637090314;11148.163887708291;11233.943830280796;11305.71735706614;11335.263207891461;11452.541898323974;11596.76806463849;11596.88403115958;11736.589219377282;12267.877321226673;8111.269985701079;8132.454833581601;8137.349012078901;8280.337572994267;8350.665973360998;11302.208845380745;11797.587084452003;11857.525698971944;11892.10809189297;11980.880191198325 08:45:38 INFO - PROCESS | 24663 | |3;mootools.html;1469.8750606198469;1474.9115053096814;1629.226117594143;1756.3062590276834;1765.373292481169;7676.501027433227;8156.796080098001;8200.876986845202;8720.171583699546;8734.126587341263;8194.426390152692;8304.667813287477;8410.327173826094;8446.113158118402;8487.745367638981;2279.065583110929;2314.467672435341;2318.652202169671;2322.0711715313923;2323.035940084863;2287.942801429961;2305.7348404933396;2319.3042087373806;2326.0230703104653;2331.813454923602;2250.696156018941;2269.8751568663715;2282.7717228277206;2329.6621989811465;2332.556814205304;2187.3656639574506;2224.3882932193615;2226.6214743493565;2251.7297924249033;2253.830962677806;2187.3984654220058;2191.1564047841694;2201.6147174244443;2206.7131272934575;2212.4911270407897;8416.410851240416;8451.70419035337;8468.491890486528;8504.787380315542;8507.149285071444;5072.365954255718;5165.66423182492;5179.300794392747;5181.974090129563;5226.686398816045;3054.823892801265;3095.349976504937;3237.3687131009465;3268.950965735516;3278.934421311584;1060.4008735064663;1075.9731006724817;1082.9079528240109;1091.3779145886847;1123.2530367305733;12122.939385303105;12136.939315303456;12227.572034978823;12234.08244381675;12245.877541224652;4387.486317220618;4443.133588950123;4462.04066125778;4523.638108951276;4554.544545545486;10168;10220.233482488844;10252.794944101077;10258.846117308247;10284.588616455407;4818.927716084261;4829.420469543677;4871.439784424837;4872.098661747588;4969.875753106201;4129.132882094794;4511.639068874482;4639.721616703008;4806.158922188603;4824.49342819006;3969.7221194516683;4025.7383270087935;4070.430139780433;4097.487814023247;4120.320147175742;1263.317808383481;1281.237663590181;1289.8000809874484;1320.6038188543398;1330.0822432521722;942.3497786527412;983.5131609853169;1001.9198464122853;1005.3666190300064;1035.5184839049878;6062.757489700451;6090.36051214625;6233.812985610439;6377.904331435032;6408.455281301049;979.4417182206074;999.3703966501058;1028.984565231522;1030.8144533983955;1042.6142327338782;4059.817308221137;4157.10622216225;4186.518550366686;4245.257080010986;4264.211120942636;10513.316634418738;10880.075193608474;10907.727306817393;10917.617883374043;10918.563257469612;10703.625373111903;10818.404987725593;10910.454477276104;10934.726631834268;10965.83551246732;8004.759857204177;8126.715564955198;8271.33829293655;8278;8279.420440569102;6025.276966764016;6041.891106951843;6075.422834830684;6108.969455152695;6123.969380153071;9995.950020249853;10065.496725163566;10077.848832267375;10091.344062635904;10121.987801219819;9920.156786672926;9924.503774811086;10051.69844904654;10073.848892266475;10272.33229840058;6672.866542669217;7125.394341481032;7277.2722727726805;7342.155652100077;7387.630618468947;8524.616392262238;8547.358948078794;8548.273396761346;8618.741437756626;8672.046074931879;7351;7572.962135189509;7581.6209189541405;7605.619719013916;7619.161892191965;7416.332530072319;7486;7509.962450187714;7557.05536807899;7783.338416234684;6670.733170673118;6687.565308254948;6729.226138993882;6749.595024298558;6775.390214880487;5125.666831655931;5320.201969704575;5381.811636592701;5439;5480.068388373907;5341.332333458317;5371.865703357447;5393.9730301348245;5404.891902161856;5532.474414930575 08:45:38 INFO - PROCESS | 24663 | |4;prototype.html;299.12058547869276;310.825937475014;313.7317593457592;314.04686775635935;315.79157755881124;5436.320459942507;5574.358948720888;5585.79905320356;5661.971690141549;5680.971595142024;5595.49640532352;5636.351819540744;5641;5642.407547207546;5653.293338332698;4279.972806526443;4297.269464191095;4306.935395969063;4311.396404503372;4314.180305741899;4023.4970628671417;4244.87265382039;4282.957170428303;4297.183535128315;4320.135972805451;4160.812763425638;4208.389783481409;4212.389203565481;4226.852060177895;4234.449521562193;4236.724612900151;4245.08730622916;4252.2345977724;4255.680823938186;4275.187714334266;3535.1869070114017;3664.59689434162;3669.3028324618504;3675.191457879262;3704.499677630537;5405.7567409466665;5453.563714902798;5484.314460692413;5484.862878428071;5486.286782718221;4814.325994360793;4857.368542089505;4863.367762190928;4880.975595122037;4896.804127834918;5539.25220095286;5821.825345239649;5855.502282305966;5866.589338746289;5872.7357268923;4017.718759686823;4027.476428064362;4027.9194416111513;4054.695897807647;4058.4723985881647;6032.547558933054;6069.452289666151;6095.573309868311;6119;6144.907826382608;4041.0301527633155;4049.493813273341;4123.793810309473;4123.8556650517685;4124.237016152021;4123.257813593522;4138.337865941495;4148.128892932457;4167.729097608706;4171.270027745132;4717.466823282447;4799.592034677022;4817.205161148371;4825.831095911696;4869.537393947569;5285.207218917193;5856.677882716492;5861.9413805861395;5901.940980590225;6008.789692360834;1403.4596680277962;1419.950301739434;1420.9147451152965;1425.109306683323;1429.2139323372103;872.9825403491894;883.7172104926361;893.1693525021662;902.4495058014605;906.2704522859029;5053.5742843435355;5072.4673909239;5077.441481437039;5079.619028572872;5082.898342033139;5275.841724748264;5307.920381194285;5317.867053323698;5363.624546281723;5390.649607775482;4729.2906064089975;5036.320096786887;5052.418971818214;5073.923891141636;5080.187170052774;2829.920008793535;2856.8285902845896;2863.7708983281286;2879.5536691812804;2894.2619631993707;5475.165819450449;5485.01269771445;5531.1426728857095;5557.277553917965;5557.776489636001;5186.936677981005;5379.4130731434325;5439.5104440600535;5441.59188060897;5479;5414.539764120015;5450.836474905759;5471.151971444432;5483.8080667176455;5545.445455454503;5147.897042059063;5317.707526086102;5371.368029665357;5384.6769193848495;5392.406835248041;5242.872782351813;5248.343957005374;5253.290805741176;5287.180487024518;5317.457937198169;5400.62195646301;5477.657973796446;5481.698506582016;5537.529310008534;5538.750756215899;3513.7132698108267;3737.6449237322413;3759.4548790425783;3759.8496060157286;3779.544875223114;5317.521423071942;5341.157300731242;5350.250964864844;5843.561732870136;5885.94114058871;5844.649321040752;5911.497522710618;5912.46787789101;5929.517620594851;5933.970330148321;5850.94149058504;5877.882442351214;5879.559033072622;5893.6463812171405;5908.586398952032;5566.053770858883;5770.567207459373;5796.710299431785;5815.41845815415;5857.824265272048;5894.38108998549;5943.7028148591535;5954.583179177589;5954.940450595439;5996.790112346047;5666.546676265806;5692.0931487952;5776.942230577809;5795.1017592273265;5842.152887831156 08:45:38 INFO - PROCESS | 24663 | |5;yui.html;710.0520804725691;728.8688036153494;749.5502698380968;751.1324420294558;751.2975368030892;13931.233782141991;14306.141631502118;14322.570322890304;14370.856291437069;14391.352389142488;12782.744345113093;12947.80578291324;12952.93523532381;12970.481180752782;12974.675633109153;669.7588868007514;793.2464159048898;803.7508372404574;805.5327909812324;805.6173317674117;765.3188662090744;785.9056913170427;786.6971216081821;791.8891355210275;796.55791035975;835.5863847395517;838.5178522349643;840.1472505407016;842.8693552499342;842.928351090155;826.6569373709933;827.6482494939656;833.4665813879122;834.3617132893341;834.8956380452444;610.7129649064932;611.9969400153016;612.2958597612736;612.4457366083701;612.5038718637873;13292.800607990888;13321.533746318832;13381.397837097355;13385.063045586812;13423.3959471824;14363.784543231859;14699;14749.41002359915;14778.852211477963;14837.777433338508;12008.799120088008;12032.518699252107;12105;12187.085968552305;12711.745765084646;3784.1296501804463;3944.4872166618156;3949.6840252779707;4023.436718859362;4034;74460;76522.23477765206;78478;78979.6051019747;79024.6048769764;10602.628907988183;10627.309224900511;10814.35113893169;10999.450027498593;11268.380239086766;19576.119074641676;19600.60798784045;19693.212271509266;19700.70448943267;19731.802681972997;8090.635921383552;8465.40742148056;8500.659973600987;8541.27399171065;8731.563421828883;4661.766911654404;4845.733484658378;4900.26496025599;4956.157453232959;5041.395032596112;3291.7202037826573;3424.7945123292684;3454.4127498325347;3496.755227134076;3511.438169892805;586.6450797267591;596.9044952807529;601.4316470934924;610.5970059760537;611.5596770325359;629.7323637454064;650.7299470719693;670.8490589617395;684.1140722764032;695.4193248637343;8596.484210947237;8815.647374105092;8846.911530884609;8849.292056635582;8885.42244754089;589.9351071382144;599.9610025348338;600.3876046432614;632.5761739634456;632.8038308124404;4395.296752519582;4582.518835522289;4606.262997920317;4620.584147426681;4673.462551806586;91034.54482727544;103195;111999.44000279947;113575.4321228405;118335;61304.38695613076;78681;94589;94662.0533794667;95337;84275;84745.57627211948;85964.57017714871;86089.56955215184;86301.99999999875;8918.10818918103;9031.142041506046;9055.637774488947;9117.635294588143;9162.651231483043;49659;50209.24686129784;50302.748486258795;50667.74666126646;52291;46035.76982115068;73773.631131844;73962.63018684872;73988;76308.23691763234;9540.686767086254;9753.366031207948;10816.17192639699;10852.511636976196;10949.343039417661;12079.75840483203;12297.692557686129;12474.812877806658;12674.429650665927;12872;10729.195310351912;10820.710820710758;10857.945710271399;10992.560297588007;11102.722431939266;10993.395363255098;11002.22984391117;11164.720881978015;11695.181337306307;11784;11066.944665276622;11099.223054386115;11245;11275.267107637977;11289.20975531705;9549.952250238704;9727.367721098106;9785.119339259501;9897.35667181631;10026.197904167795;9904.455254961047;10095.192384609067;10101.949490252502;10242.334248273839;10347.793044138925 08:45:38 INFO - PROCESS | 24663 | __end_tp_report 08:45:38 INFO - PROCESS | 24663 | __start_cc_report 08:45:38 INFO - PROCESS | 24663 | _x_x_mozilla_cycle_collect,358 08:45:38 INFO - PROCESS | 24663 | __end_cc_report 08:45:38 INFO - PROCESS | 24663 | __startTimestamp1465314338288__endTimestamp 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | ------- Summary: start ------- 08:45:38 INFO - PROCESS | 24663 | Number of tests: 6 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | [#0] dojo.html Cycles:165 Average:5494.55 Median:5762.45 stddev:730.26 (12.7%) stddev-sans-first:708.50 08:45:38 INFO - PROCESS | 24663 | Values: 3127.6 3185.6 3215.0 3229.3 3230.0 5424.8 5425.1 5459.4 5496.9 5528.8 5348.4 5478.9 5501.4 5529.0 5585.0 4978.5 5006.4 5113.0 5146.1 5199.3 816.3 4963.0 5095.0 5138.8 5171.1 5073.5 5080.1 5104.1 5113.8 5150.2 5031.6 5112.8 5113.8 5133.1 5137.3 5022.3 5024.8 5024.8 5042.4 5128.9 5459.4 5461.6 5497.2 5515.8 5541.1 5727.1 5850.6 5894.5 6042.9 6048.4 6002.9 6007.7 6012.5 6018.2 6037.0 5561.8 5564.0 5578.7 5581.2 5585.5 5870.9 6002.4 6027.2 6067.3 6132.8 5848.4 5849.8 5865.1 5871.0 5910.8 5867.7 5916.2 5916.6 5918.9 5921.8 5786.2 5891.7 5893.7 5940.8 5972.2 5686.5 5879.8 5941.3 5977.1 6003.5 4537.2 4540.5 4550.2 4552.8 4567.1 3923.3 3972.1 3974.2 3992.6 4051.0 5776.2 5789.8 5790.2 5791.9 5815.9 6023.2 6041.6 6091.3 6093.1 6093.8 5474.2 5674.5 5685.9 5724.3 5724.6 5081.6 5115.7 5154.6 5156.2 5158.9 5913.5 6231.3 6240.6 6250.0 6255.4 5909.4 5934.0 5941.9 5989.1 5995.2 6092.6 6139.0 6147.8 6151.6 6154.8 5619.2 5766.2 5767.9 5778.8 5819.3 5954.1 5988.3 5991.3 6018.2 6055.1 5771.0 5788.7 5838.8 5839.9 5850.5 5631.0 5733.5 5762.5 5811.9 5833.3 5542.1 5684.3 5699.1 5736.5 5772.2 5858.0 5863.6 5892.7 5892.9 5917.9 5528.2 5597.7 5612.6 5717.5 5767.0 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | [#1] ext.html Cycles:180 Average:59893.83 Median:40852.50 stddev:122099.92 (298.9%) stddev-sans-first:122361.22 08:45:38 INFO - PROCESS | 24663 | Values: 578.2 606.9 610.9 616.1 636.0 42779.4 43300.6 43879.6 43891.1 47166.8 44702.8 45185.8 45425.5 45493.3 45512.8 8610.1 8759.2 8795.2 8828.9 8853.0 8756.7 8853.3 8853.7 8860.9 8871.7 8882.7 8945.1 8957.1 8958.3 8969.1 8488.1 8630.5 8653.6 8694.9 8858.6 8724.6 8801.8 8864.7 8883.0 8895.5 41685.6 41698.0 41978.0 42226.2 42293.2 3595.4 3671.1 3672.7 3693.8 3695.4 32547.3 32782.0 32838.5 34253.8 34322.1 4044.8 4160.1 4211.3 4251.0 4294.5 369714.0 371405.0 374477.0 375146.1 375833.0 33907.8 34822.8 57136.4 57609.0 57944.0 36525.0 36569.3 36719.3 36724.8 36725.8 14257.9 14316.4 14375.4 14431.3 14440.6 11928.6 12014.7 12024.1 12108.2 12161.9 8229.9 8315.3 8336.7 8411.7 8418.8 3201.2 3241.0 3266.7 3285.9 3291.6 1041.3 1064.0 1066.2 1074.9 1110.0 32618.7 32656.4 32848.2 32904.7 33026.0 1102.2 1154.4 1181.2 1184.6 1196.7 16717.2 17052.5 17157.3 17233.0 17236.8 547063.0 552599.0 553528.0 553751.0 554446.0 56252.4 57215.1 57348.0 57453.4 57507.1 1304.5 1338.2 1396.4 1402.3 1407.6 30669.7 31406.4 31741.0 31859.2 32020.0 49731.5 49829.8 50141.0 50197.7 50370.0 428661.0 432559.0 434683.0 436937.0 438083.0 27301.9 27507.7 27668.0 27743.6 27748.7 46311.5 47630.3 47947.0 48790.5 49116.8 40102.7 40987.0 41250.4 41381.0 41617.0 38968.4 39889.8 39964.6 40101.2 40144.0 40437.4 40837.0 40868.0 41554.2 44495.8 33906.8 37084.3 37380.6 37888.0 38428.0 28652.1 28681.7 28910.6 28926.9 29269.4 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | [#2] jquery.html Cycles:180 Average:28170.40 Median:2522.93 stddev:76850.39 (3046.1%) stddev-sans-first:77037.67 08:45:38 INFO - PROCESS | 24663 | Values: 388.6 390.1 390.3 391.6 413.6 17823.3 19274.8 19683.0 19743.9 20162.6 18345.0 18882.0 18987.2 19061.5 19116.2 5550.1 5578.8 5700.0 5740.5 5753.7 5622.5 5631.3 5644.8 5649.4 5651.0 5440.7 5609.6 5629.8 5695.2 5702.3 5648.4 5663.1 5668.1 5671.0 5689.9 4868.6 4966.1 4996.8 5014.8 5075.7 22012.3 22057.7 22699.4 23028.3 23101.0 2444.2 2502.0 2543.9 2634.6 2712.9 14077.0 14467.7 14496.9 14620.0 14663.2 1924.1 2012.3 2021.9 2041.7 2042.9 61030.7 67448.3 69101.0 78469.6 80392.0 10300.2 10473.2 10828.5 10883.6 11013.9 14853.9 14947.9 14948.3 14987.9 15002.4 7758.5 8120.0 8220.7 8255.5 8295.9 7895.5 7922.9 8023.1 8033.8 8141.2 6587.6 6610.0 6638.6 6793.5 6897.4 1891.8 1900.7 1913.7 1922.4 1930.8 800.4 976.9 1029.7 1034.4 1050.3 19381.3 20108.8 20132.5 20399.8 20417.3 933.5 975.8 1048.3 1071.5 1126.3 10310.9 10788.6 10822.5 10866.5 10868.0 458965.0 461400.0 468783.0 469267.0 473849.0 78513.0 88405.0 91764.0 92008.0 93388.5 1042.4 1070.3 1071.8 1081.7 1088.0 17698.8 17988.0 18110.5 18175.5 18371.2 41559.0 42615.1 42716.1 44048.8 44355.3 59514.7 60716.4 61161.0 61301.4 61988.7 5488.6 7873.8 7915.0 7965.6 8036.1 8548.0 11716.8 12509.4 12963.2 13164.5 11310.1 11377.7 11656.2 11704.4 12020.6 9290.9 11148.2 11233.9 11305.7 11335.3 11452.5 11596.8 11596.9 11736.6 12267.9 8111.3 8132.5 8137.3 8280.3 8350.7 11302.2 11797.6 11857.5 11892.1 11980.9 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | [#3] mootools.html Cycles:180 Average:5724.52 Median:4452.59 stddev:3241.74 (72.8%) stddev-sans-first:3235.07 08:45:38 INFO - PROCESS | 24663 | Values: 1469.9 1474.9 1629.2 1756.3 1765.4 7676.5 8156.8 8200.9 8720.2 8734.1 8194.4 8304.7 8410.3 8446.1 8487.7 2279.1 2314.5 2318.7 2322.1 2323.0 2287.9 2305.7 2319.3 2326.0 2331.8 2250.7 2269.9 2282.8 2329.7 2332.6 2187.4 2224.4 2226.6 2251.7 2253.8 2187.4 2191.2 2201.6 2206.7 2212.5 8416.4 8451.7 8468.5 8504.8 8507.1 5072.4 5165.7 5179.3 5182.0 5226.7 3054.8 3095.3 3237.4 3269.0 3278.9 1060.4 1076.0 1082.9 1091.4 1123.3 12122.9 12136.9 12227.6 12234.1 12245.9 4387.5 4443.1 4462.0 4523.6 4554.5 10168.0 10220.2 10252.8 10258.8 10284.6 4818.9 4829.4 4871.4 4872.1 4969.9 4129.1 4511.6 4639.7 4806.2 4824.5 3969.7 4025.7 4070.4 4097.5 4120.3 1263.3 1281.2 1289.8 1320.6 1330.1 942.3 983.5 1001.9 1005.4 1035.5 6062.8 6090.4 6233.8 6377.9 6408.5 979.4 999.4 1029.0 1030.8 1042.6 4059.8 4157.1 4186.5 4245.3 4264.2 10513.3 10880.1 10907.7 10917.6 10918.6 10703.6 10818.4 10910.5 10934.7 10965.8 8004.8 8126.7 8271.3 8278.0 8279.4 6025.3 6041.9 6075.4 6109.0 6124.0 9996.0 10065.5 10077.8 10091.3 10122.0 9920.2 9924.5 10051.7 10073.8 10272.3 6672.9 7125.4 7277.3 7342.2 7387.6 8524.6 8547.4 8548.3 8618.7 8672.0 7351.0 7573.0 7581.6 7605.6 7619.2 7416.3 7486.0 7510.0 7557.1 7783.3 6670.7 6687.6 6729.2 6749.6 6775.4 5125.7 5320.2 5381.8 5439.0 5480.1 5341.3 5371.9 5394.0 5404.9 5532.5 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | [#4] prototype.html Cycles:180 Average:4688.96 Median:5317.61 stddev:1396.39 (26.3%) stddev-sans-first:1360.88 08:45:38 INFO - PROCESS | 24663 | Values: 299.1 310.8 313.7 314.0 315.8 5436.3 5574.4 5585.8 5662.0 5681.0 5595.5 5636.4 5641.0 5642.4 5653.3 4280.0 4297.3 4306.9 4311.4 4314.2 4023.5 4244.9 4283.0 4297.2 4320.1 4160.8 4208.4 4212.4 4226.9 4234.4 4236.7 4245.1 4252.2 4255.7 4275.2 3535.2 3664.6 3669.3 3675.2 3704.5 5405.8 5453.6 5484.3 5484.9 5486.3 4814.3 4857.4 4863.4 4881.0 4896.8 5539.3 5821.8 5855.5 5866.6 5872.7 4017.7 4027.5 4027.9 4054.7 4058.5 6032.5 6069.5 6095.6 6119.0 6144.9 4041.0 4049.5 4123.8 4123.9 4124.2 4123.3 4138.3 4148.1 4167.7 4171.3 4717.5 4799.6 4817.2 4825.8 4869.5 5285.2 5856.7 5861.9 5901.9 6008.8 1403.5 1420.0 1420.9 1425.1 1429.2 873.0 883.7 893.2 902.4 906.3 5053.6 5072.5 5077.4 5079.6 5082.9 5275.8 5307.9 5317.9 5363.6 5390.6 4729.3 5036.3 5052.4 5073.9 5080.2 2829.9 2856.8 2863.8 2879.6 2894.3 5475.2 5485.0 5531.1 5557.3 5557.8 5186.9 5379.4 5439.5 5441.6 5479.0 5414.5 5450.8 5471.2 5483.8 5545.4 5147.9 5317.7 5371.4 5384.7 5392.4 5242.9 5248.3 5253.3 5287.2 5317.5 5400.6 5477.7 5481.7 5537.5 5538.8 3513.7 3737.6 3759.5 3759.8 3779.5 5317.5 5341.2 5350.3 5843.6 5885.9 5844.6 5911.5 5912.5 5929.5 5934.0 5850.9 5877.9 5879.6 5893.6 5908.6 5566.1 5770.6 5796.7 5815.4 5857.8 5894.4 5943.7 5954.6 5954.9 5996.8 5666.5 5692.1 5776.9 5795.1 5842.2 08:45:38 INFO - PROCESS | 24663 | 08:45:38 INFO - PROCESS | 24663 | [#5] yui.html Cycles:180 Average:19410.08 Median:27854.57 stddev:28367.81 (101.8%) stddev-sans-first:28412.64 08:45:38 INFO - PROCESS | 24663 | Values: 710.1 728.9 749.6 751.1 751.3 13931.2 14306.1 14322.6 14370.9 14391.4 12782.7 12947.8 12952.9 12970.5 12974.7 669.8 793.2 803.8 805.5 805.6 765.3 785.9 786.7 791.9 796.6 835.6 838.5 840.1 842.9 842.9 826.7 827.6 833.5 834.4 834.9 610.7 612.0 612.3 612.4 612.5 13292.8 13321.5 13381.4 13385.1 13423.4 14363.8 14699.0 14749.4 14778.9 14837.8 12008.8 12032.5 12105.0 12187.1 12711.7 3784.1 3944.5 3949.7 4023.4 4034.0 74460.0 76522.2 78478.0 78979.6 79024.6 10602.6 10627.3 10814.4 10999.5 11268.4 19576.1 19600.6 19693.2 19700.7 19731.8 8090.6 8465.4 8500.7 8541.3 8731.6 4661.8 4845.7 4900.3 4956.2 5041.4 3291.7 3424.8 3454.4 3496.8 3511.4 586.6 596.9 601.4 610.6 611.6 629.7 650.7 670.8 684.1 695.4 8596.5 8815.6 8846.9 8849.3 8885.4 589.9 600.0 600.4 632.6 632.8 4395.3 4582.5 4606.3 4620.6 4673.5 91034.5 103195.0 111999.4 113575.4 118335.0 61304.4 78681.0 94589.0 94662.1 95337.0 84275.0 84745.6 85964.6 86089.6 86302.0 8918.1 9031.1 9055.6 9117.6 9162.7 49659.0 50209.2 50302.7 50667.7 52291.0 46035.8 73773.6 73962.6 73988.0 76308.2 9540.7 9753.4 10816.2 10852.5 10949.3 12079.8 12297.7 12474.8 12674.4 12872.0 10729.2 10820.7 10857.9 10992.6 11102.7 10993.4 11002.2 11164.7 11695.2 11784.0 11066.9 11099.2 11245.0 11275.3 11289.2 9550.0 9727.4 9785.1 9897.4 10026.2 9904.5 10095.2 10101.9 10242.3 10347.8 08:45:38 INFO - PROCESS | 24663 | -------- Summary: end -------- 08:45:38 INFO - PROCESS | 24663 | 08:45:39 INFO - TEST-INFO | 24663: exit 0 08:45:39 INFO - TEST-OK | dromaeo_css | took 1110591ms 08:45:39 INFO - TEST-START | kraken 08:45:39 INFO - operating with platform_type : linux_ 08:45:39 INFO - Initialising browser for kraken test... 08:45:39 INFO - TEST-INFO | started process 24898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Ug_tE/profile http://localhost:41999/getInfo.html) 08:45:43 INFO - PROCESS | 24898 | __metrics Screen width/height:1600/1200 08:45:43 INFO - PROCESS | 24898 | colorDepth:24 08:45:43 INFO - PROCESS | 24898 | Browser inner width/height: 1024/697 08:45:43 INFO - PROCESS | 24898 | __metrics 08:45:44 ERROR - PROCESS | 24898 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 08:45:45 INFO - TEST-INFO | 24898: exit 0 08:45:45 INFO - Browser initialized. 08:45:45 INFO - Running cycle 1/1 for kraken test... 08:45:45 INFO - TEST-INFO | started process 25018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Ug_tE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:56 INFO - PROCESS | 25018 | RSS: Main: 167972864 08:45:56 INFO - PROCESS | 25018 | 08:45:59 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:00 INFO - PROCESS | 25018 | RSS: Main: 173338624 08:46:00 INFO - PROCESS | 25018 | 08:46:03 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-dft) 08:46:03 INFO - PROCESS | 25018 | RSS: Main: 172765184 08:46:03 INFO - PROCESS | 25018 | 08:46:06 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-fft) 08:46:07 INFO - PROCESS | 25018 | RSS: Main: 167366656 08:46:07 INFO - PROCESS | 25018 | 08:46:09 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-oscillator) 08:46:09 INFO - PROCESS | 25018 | RSS: Main: 167673856 08:46:09 INFO - PROCESS | 25018 | 08:46:12 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41999/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:12 INFO - PROCESS | 25018 | RSS: Main: 168329216 08:46:12 INFO - PROCESS | 25018 | 08:46:15 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41999/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:16 INFO - PROCESS | 25018 | RSS: Main: 167682048 08:46:16 INFO - PROCESS | 25018 | 08:46:19 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41999/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:20 INFO - PROCESS | 25018 | RSS: Main: 169021440 08:46:20 INFO - PROCESS | 25018 | 08:46:23 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41999/tests/kraken/driver.html?testName=json-parse-financial) 08:46:23 INFO - PROCESS | 25018 | RSS: Main: 168828928 08:46:23 INFO - PROCESS | 25018 | 08:46:25 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41999/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:46:26 INFO - PROCESS | 25018 | RSS: Main: 168865792 08:46:26 INFO - PROCESS | 25018 | 08:46:27 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:46:28 INFO - PROCESS | 25018 | RSS: Main: 168943616 08:46:28 INFO - PROCESS | 25018 | 08:46:30 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:46:31 INFO - PROCESS | 25018 | RSS: Main: 169336832 08:46:31 INFO - PROCESS | 25018 | 08:46:33 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:46:34 INFO - PROCESS | 25018 | RSS: Main: 169320448 08:46:34 INFO - PROCESS | 25018 | 08:46:37 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:46:37 INFO - PROCESS | 25018 | RSS: Main: 168828928 08:46:37 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41999/tests/kraken/driver.html?testName=ai-astar) 08:46:39 INFO - PROCESS | 25018 | RSS: Main: 169488384 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | __start_tp_report 08:46:39 INFO - PROCESS | 25018 | _x_x_mozilla_page_load 08:46:39 INFO - PROCESS | 25018 | _x_x_mozilla_page_load_details 08:46:39 INFO - PROCESS | 25018 | |i|pagename|runs| 08:46:39 INFO - PROCESS | 25018 | |0;ai-astar;112;106;112;112;113;112;109;111;111;112 08:46:39 INFO - PROCESS | 25018 | |1;audio-beat-detection;157;125;154;180;129;151;157;141;184;136 08:46:39 INFO - PROCESS | 25018 | |2;audio-dft;163;165;162;162;161;167;167;161;163;161 08:46:39 INFO - PROCESS | 25018 | |3;audio-fft;75;76;75;161;75;75;74;74;163;78 08:46:39 INFO - PROCESS | 25018 | |4;audio-oscillator;84;85;153;85;85;85;144;85;85;142 08:46:39 INFO - PROCESS | 25018 | |5;imaging-gaussian-blur;122;117;118;117;117;118;118;118;117;118 08:46:39 INFO - PROCESS | 25018 | |6;imaging-darkroom;146;147;146;148;148;146;147;149;147;147 08:46:39 INFO - PROCESS | 25018 | |7;imaging-desaturate;96;97;95;97;96;95;95;96;95;96 08:46:39 INFO - PROCESS | 25018 | |8;json-parse-financial;60;56;57;54;62;54;59;55;55;57 08:46:39 INFO - PROCESS | 25018 | |9;json-stringify-tinderbox;61;62;63;61;61;61;61;62;62;60 08:46:39 INFO - PROCESS | 25018 | |10;stanford-crypto-aes;80;80;82;81;82;80;82;80;111;81 08:46:39 INFO - PROCESS | 25018 | |11;stanford-crypto-ccm;128;126;127;140;133;128;132;133;142;131 08:46:39 INFO - PROCESS | 25018 | |12;stanford-crypto-pbkdf2;162;157;160;164;156;158;165;157;162;160 08:46:39 INFO - PROCESS | 25018 | |13;stanford-crypto-sha256-iterative;64;62;63;63;66;66;63;61;63;64 08:46:39 INFO - PROCESS | 25018 | __end_tp_report 08:46:39 INFO - PROCESS | 25018 | __start_cc_report 08:46:39 INFO - PROCESS | 25018 | _x_x_mozilla_cycle_collect,853 08:46:39 INFO - PROCESS | 25018 | __end_cc_report 08:46:39 INFO - PROCESS | 25018 | __startTimestamp1465314399727__endTimestamp 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | ------- Summary: start ------- 08:46:39 INFO - PROCESS | 25018 | Number of tests: 14 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.05 (1.8%) stddev-sans-first:2.15 08:46:39 INFO - PROCESS | 25018 | Values: 112.0 106.0 112.0 112.0 113.0 112.0 109.0 111.0 111.0 112.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.50 stddev:19.70 (12.7%) stddev-sans-first:20.80 08:46:39 INFO - PROCESS | 25018 | Values: 157.0 125.0 154.0 180.0 129.0 151.0 157.0 141.0 184.0 136.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.35 (1.4%) stddev-sans-first:2.49 08:46:39 INFO - PROCESS | 25018 | Values: 163.0 165.0 162.0 162.0 161.0 167.0 167.0 161.0 163.0 161.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:36.60 (48.8%) stddev-sans-first:38.26 08:46:39 INFO - PROCESS | 25018 | Values: 75.0 76.0 75.0 161.0 75.0 75.0 74.0 74.0 163.0 78.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:85.00 stddev:29.83 (35.1%) stddev-sans-first:30.81 08:46:39 INFO - PROCESS | 25018 | Values: 84.0 85.0 153.0 85.0 85.0 85.0 144.0 85.0 85.0 142.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 08:46:39 INFO - PROCESS | 25018 | Values: 122.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 08:46:39 INFO - PROCESS | 25018 | Values: 146.0 147.0 146.0 148.0 148.0 146.0 147.0 149.0 147.0 147.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 08:46:39 INFO - PROCESS | 25018 | Values: 96.0 97.0 95.0 97.0 96.0 95.0 95.0 96.0 95.0 96.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.69 (4.7%) stddev-sans-first:2.60 08:46:39 INFO - PROCESS | 25018 | Values: 60.0 56.0 57.0 54.0 62.0 54.0 59.0 55.0 55.0 57.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 08:46:39 INFO - PROCESS | 25018 | Values: 61.0 62.0 63.0 61.0 61.0 61.0 61.0 62.0 62.0 60.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:9.56 (11.8%) stddev-sans-first:10.04 08:46:39 INFO - PROCESS | 25018 | Values: 80.0 80.0 82.0 81.0 82.0 80.0 82.0 80.0 111.0 81.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:132.50 stddev:5.37 (4.1%) stddev-sans-first:5.50 08:46:39 INFO - PROCESS | 25018 | Values: 128.0 126.0 127.0 140.0 133.0 128.0 132.0 133.0 142.0 131.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:161.00 stddev:3.11 (1.9%) stddev-sans-first:3.22 08:46:39 INFO - PROCESS | 25018 | Values: 162.0 157.0 160.0 164.0 156.0 158.0 165.0 157.0 162.0 160.0 08:46:39 INFO - PROCESS | 25018 | 08:46:39 INFO - PROCESS | 25018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.58 (2.5%) stddev-sans-first:1.67 08:46:39 INFO - PROCESS | 25018 | Values: 64.0 62.0 63.0 63.0 66.0 66.0 63.0 61.0 63.0 64.0 08:46:39 INFO - PROCESS | 25018 | -------- Summary: end -------- 08:46:39 INFO - PROCESS | 25018 | 08:46:40 INFO - TEST-INFO | 25018: exit 0 08:46:40 INFO - TEST-OK | kraken | took 61665ms 08:46:40 INFO - SUITE-END | took 1172s 08:46:40 INFO - Completed test suite (00:19:32) 08:46:40 INFO - javascript benchmark 08:46:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7126.242217374724, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.624685037795, 3185.5699480570115, 3215.0354893531944, 3229.2895562976137, 3229.983850080749, 5424.783008679653, 5425.0506161421745, 5459.426760190182, 5496.890062198753, 5528.778848846041, 5348.358197016363, 5478.945210547893, 5501.449855014496, 5529.0, 5584.972075139619, 4978.502149785028, 5006.374203224597, 5112.97443512782, 5146.073706732786, 5199.298094757216, 816.2539738199683, 4963.032208719301, 5095.0, 5138.768755406016, 5171.095058364771, 5073.467285934979, 5080.1363768159135, 5104.132297509433, 5113.795448182068, 5150.1759718445055, 5031.647784655075, 5112.846614601568, 5113.82101626445, 5133.101707201225, 5137.3064636274, 5022.321986531808, 5024.773885175176, 5024.799008039674, 5042.42012168598, 5128.897422051576, 5459.426760190163, 5461.644993075477, 5497.230387745719, 5515.834524964257, 5541.141123125922, 5727.140928860705, 5850.590458667895, 5894.4989675877605, 6042.9395706042815, 6048.425399587032, 6002.909956350658, 6007.729652165663, 6012.488938440238, 6018.247719035121, 6036.9698151508965, 5561.833145005657, 5563.972180139114, 5578.693171875586, 5581.2186293918885, 5585.469380408855, 5870.882582348329, 6002.399760023963, 6027.186329845503, 6067.302260240129, 6132.816015519542, 5848.385919478478, 5849.795257165979, 5865.149553314745, 5870.970645146747, 5910.763569457174, 5867.735951882176, 5916.171735956969, 5916.645001299849, 5918.911216331759, 5921.792737254262, 5786.1610066540115, 5891.675957822361, 5893.705314734332, 5940.79207227745, 5972.193753843176, 5686.516646085129, 5879.764809407576, 5941.257342832146, 5977.073553599199, 6003.459688628044, 4537.2059889519205, 4540.455145382509, 4550.180967425829, 4552.7723613819835, 4567.063751930847, 3923.2938071146896, 3972.0864201233876, 3974.2250261199365, 3992.6007399260425, 4051.0277533391773, 5776.191333213354, 5789.797357092481, 5790.247267855152, 5791.88416231673, 5815.912761308584, 6023.156758053876, 6041.6375017499095, 6091.269047714302, 6093.146959425684, 6093.847653808691, 5474.206240095244, 5674.460926212003, 5685.886282274414, 5724.3130824300515, 5724.570657200727, 5081.644284900021, 5115.693058416507, 5154.639175257771, 5156.175011998137, 5158.92261616076, 5913.46778789911, 6231.283402408691, 6240.563160578716, 6250.0, 6255.40573645503, 5909.438603332676, 5933.970330148321, 5941.881162376641, 5989.131575921554, 5995.160677505066, 6092.634441933498, 6138.969305153446, 6147.815565533041, 6151.630902145886, 6154.753809847735, 5619.241402410622, 5766.221560089334, 5767.884642307215, 5778.768849245983, 5819.272590926134, 5954.10688396744, 5988.311344195473, 5991.281046274475, 6018.157457955977, 6055.061465472859, 5770.9711451444155, 5788.710564471844, 5838.824835254949, 5839.912401313899, 5850.531957443309, 5630.971845140748, 5733.541316694571, 5762.4525670061275, 5811.912821307599, 5833.300003999547, 5542.0855558832345, 5684.261046064151, 5699.059655156852, 5736.512396446182, 5772.249607550992, 5858.0, 5863.589548731547, 5892.705364731832, 5892.852678683067, 5917.852053698692, 5528.226048353315, 5597.6641401516035, 5612.635178713371, 5717.542596592346, 5767.0196066669605], "value": 5446.806971821302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1876463568685, 606.865162146785, 610.929743079546, 616.082037763732, 635.9777407790726, 42779.35830962534, 43300.566994330045, 43879.561204387945, 43891.122177556426, 47166.76416617921, 44702.776486117524, 45185.77407112968, 45425.54574454254, 45493.31760023602, 45512.77243613777, 8610.095939926296, 8759.211670949613, 8795.164459376349, 8828.911710882905, 8853.026167121612, 8756.737297881042, 8853.335999800009, 8853.690120845771, 8860.911390886105, 8871.733847984571, 8882.733517994471, 8945.105489451067, 8957.104289571056, 8958.283337332998, 8969.058248883872, 8488.108748581402, 8630.525321107369, 8653.610587523577, 8694.869576956318, 8858.601362938683, 8724.563771811447, 8801.779955501099, 8864.73405797827, 8883.022867484571, 8895.4662720237, 41685.58314416847, 41698.0, 41978.0, 42226.15547689029, 42293.15413691709, 3595.388783906742, 3671.1005803578028, 3672.7429079964413, 3693.778373297611, 3695.4087346024776, 32547.349053019043, 32782.0, 32838.507422388684, 34253.828730856185, 34322.14194645154, 4044.8027423742583, 4160.126373461577, 4211.263028969948, 4251.043515209084, 4294.484661840599, 369714.0, 371405.0, 374477.0, 375146.12426937965, 375833.0, 33907.83046084754, 34822.82588587041, 57136.42863571394, 57609.0, 57944.0, 36525.0, 36569.26861462756, 36719.26561468756, 36724.81637591795, 36725.81637091797, 14257.92871035659, 14316.355763990645, 14375.353109110116, 14431.278436078153, 14440.566782996317, 11928.582499612472, 12014.699632509082, 12024.098192635412, 12108.21296615717, 12161.939190303992, 8229.917700822914, 8315.251627353568, 8336.749897503085, 8411.663533458594, 8418.831623367498, 3201.199700074981, 3241.0, 3266.6733326667145, 3285.917852053718, 3291.5556399886186, 1041.2763129624839, 1063.9680809575725, 1066.1843689577324, 1074.9423960266924, 1109.9999999999839, 32618.673813262038, 32656.414723598555, 32848.17879552983, 32904.67095329016, 33026.0, 1102.2284400919227, 1154.440096553171, 1181.2499063094997, 1184.5557915781583, 1196.6948428150765, 16717.247723852455, 17052.48842534726, 17157.313707451813, 17233.0, 17236.82763172352, 547063.0, 552599.0, 553528.0, 553751.0, 554446.0, 56252.43747562472, 57215.14177287344, 57348.0, 57453.42546574564, 57507.13739293914, 1304.4847285322244, 1338.2305174524688, 1396.406527225925, 1402.2988505747126, 1407.6129064507343, 30669.693303066684, 31406.37187256288, 31741.0, 31859.20351991126, 32020.0, 49731.502684972686, 49829.75085124551, 50141.0, 50197.74901125471, 50370.0, 428661.0, 432559.0, 434683.0, 436937.0, 438083.0, 27301.86349068242, 27507.724922750516, 27668.0, 27743.583846242727, 27748.722512774613, 46311.53688463207, 47630.28554571615, 47947.0, 48790.5120948786, 49116.75441622769, 40102.65898713704, 40987.0, 41250.38124428076, 41381.0, 41617.0, 38968.41547376735, 39889.81099801549, 39964.60035399725, 40101.19797603973, 40144.0, 40437.39343909785, 40837.0, 40868.0, 41554.168916622104, 44495.777521112184, 33906.83046584751, 37084.258314833016, 37380.626193738804, 37888.0, 38428.0, 28652.137611055216, 28681.713182868738, 28910.566341504473, 28926.855365723037, 29269.41461170807], "value": 18881.089580807038, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.615270881827, 390.1436347217858, 390.32084173538044, 391.56536244768284, 413.6112054668611, 17823.28706851726, 19274.807251927476, 19683.0, 19743.901280493577, 20162.59674806503, 18345.0, 18882.0, 18987.240510379605, 19061.523461913424, 19116.23535058596, 5550.084236101038, 5578.776848926038, 5700.0, 5740.512056475204, 5753.712314384285, 5622.522085622706, 5631.2960879890015, 5644.8024319148835, 5649.435056494359, 5650.971745141289, 5440.700761458118, 5609.551235901138, 5629.774809007635, 5695.202671625976, 5702.344230413514, 5648.350439699446, 5663.093904975205, 5668.121441176624, 5670.971645141748, 5689.886202275952, 4868.634852386085, 4966.106100901836, 4996.775145118479, 5014.824481143142, 5075.670081444694, 22012.339629811133, 22057.669134962987, 22699.432514187112, 23028.272879534103, 23101.0, 2444.2300675287406, 2501.9874900625564, 2543.872806359693, 2634.6443230163873, 2712.9457410851674, 14077.0, 14467.71064578713, 14496.85503144976, 14620.0, 14663.193524356157, 1924.0956750327323, 2012.255465477768, 2021.9494512637302, 2041.7141600175987, 2042.8876411797346, 61030.69484652593, 67448.32551674519, 69101.0, 78469.60765196195, 80392.0, 10300.175985921109, 10473.214508911862, 10828.512716927757, 10883.564657413615, 11013.944930275296, 14853.925730371495, 14947.925260373628, 14948.32732527039, 14987.850121498863, 15002.399904003936, 7758.534487930742, 8119.959400202961, 8220.671173153127, 8255.463394879314, 8295.917040829514, 7895.512913432251, 7922.920770792333, 8023.117457079717, 8033.7991550210545, 8141.18588141193, 6587.637679927554, 6610.0, 6638.634875081917, 6793.5244532882225, 6897.379235868796, 1891.7635295588052, 1900.686386746199, 1913.7129430585524, 1922.3848368522217, 1930.7683078030727, 800.4316934976232, 976.9267304952015, 1029.6807989523272, 1034.374203606822, 1050.3067975136373, 19381.344368974176, 20108.798912010694, 20132.496687582927, 20399.796002040086, 20417.285395011102, 933.4725879877848, 975.8097171051719, 1048.2819268800895, 1071.45891324882, 1126.2679258482053, 10310.948445257725, 10788.56845726178, 10822.51298691545, 10866.511007004703, 10868.0, 458965.0, 461400.0, 468783.0, 469267.0, 473849.0, 78513.0, 88405.0, 91764.0, 92008.0, 93388.53305733428, 1042.4475028235047, 1070.3043022035738, 1071.8070747265567, 1081.6809041332826, 1087.9891201087887, 17698.8495747776, 17988.0, 18110.456686299432, 18175.45473635793, 18371.173297201924, 41559.0, 42615.14769704651, 42716.14567708566, 44048.779756101016, 44355.33466998062, 59514.70242648759, 60716.39283607107, 61161.0, 61301.38698613135, 61988.69005654943, 5488.588355873405, 7873.84252314939, 7914.960425197837, 7965.641546130322, 8036.1160272368825, 8547.95726021366, 11716.765664686829, 12509.43707533145, 12963.22220666763, 13164.539241126515, 11310.095192384424, 11377.691565469746, 11656.18406711522, 11704.356260405419, 12020.63938081859, 9290.860637090314, 11148.163887708291, 11233.943830280796, 11305.71735706614, 11335.263207891461, 11452.541898323974, 11596.76806463849, 11596.88403115958, 11736.589219377282, 12267.877321226673, 8111.269985701079, 8132.454833581601, 8137.349012078901, 8280.337572994267, 8350.665973360998, 11302.208845380745, 11797.587084452003, 11857.525698971944, 11892.10809189297, 11980.880191198325], "value": 9278.673743459896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.8750606198469, 1474.9115053096814, 1629.226117594143, 1756.3062590276834, 1765.373292481169, 7676.501027433227, 8156.796080098001, 8200.876986845202, 8720.171583699546, 8734.126587341263, 8194.426390152692, 8304.667813287477, 8410.327173826094, 8446.113158118402, 8487.745367638981, 2279.065583110929, 2314.467672435341, 2318.652202169671, 2322.0711715313923, 2323.035940084863, 2287.942801429961, 2305.7348404933396, 2319.3042087373806, 2326.0230703104653, 2331.813454923602, 2250.696156018941, 2269.8751568663715, 2282.7717228277206, 2329.6621989811465, 2332.556814205304, 2187.3656639574506, 2224.3882932193615, 2226.6214743493565, 2251.7297924249033, 2253.830962677806, 2187.3984654220058, 2191.1564047841694, 2201.6147174244443, 2206.7131272934575, 2212.4911270407897, 8416.410851240416, 8451.70419035337, 8468.491890486528, 8504.787380315542, 8507.149285071444, 5072.365954255718, 5165.66423182492, 5179.300794392747, 5181.974090129563, 5226.686398816045, 3054.823892801265, 3095.349976504937, 3237.3687131009465, 3268.950965735516, 3278.934421311584, 1060.4008735064663, 1075.9731006724817, 1082.9079528240109, 1091.3779145886847, 1123.2530367305733, 12122.939385303105, 12136.939315303456, 12227.572034978823, 12234.08244381675, 12245.877541224652, 4387.486317220618, 4443.133588950123, 4462.04066125778, 4523.638108951276, 4554.544545545486, 10168.0, 10220.233482488844, 10252.794944101077, 10258.846117308247, 10284.588616455407, 4818.927716084261, 4829.420469543677, 4871.439784424837, 4872.098661747588, 4969.875753106201, 4129.132882094794, 4511.639068874482, 4639.721616703008, 4806.158922188603, 4824.49342819006, 3969.7221194516683, 4025.7383270087935, 4070.430139780433, 4097.487814023247, 4120.320147175742, 1263.317808383481, 1281.237663590181, 1289.8000809874484, 1320.6038188543398, 1330.0822432521722, 942.3497786527412, 983.5131609853169, 1001.9198464122853, 1005.3666190300064, 1035.5184839049878, 6062.757489700451, 6090.36051214625, 6233.812985610439, 6377.904331435032, 6408.455281301049, 979.4417182206074, 999.3703966501058, 1028.984565231522, 1030.8144533983955, 1042.6142327338782, 4059.817308221137, 4157.10622216225, 4186.518550366686, 4245.257080010986, 4264.211120942636, 10513.316634418738, 10880.075193608474, 10907.727306817393, 10917.617883374043, 10918.563257469612, 10703.625373111903, 10818.404987725593, 10910.454477276104, 10934.726631834268, 10965.83551246732, 8004.759857204177, 8126.715564955198, 8271.33829293655, 8278.0, 8279.420440569102, 6025.276966764016, 6041.891106951843, 6075.422834830684, 6108.969455152695, 6123.969380153071, 9995.950020249853, 10065.496725163566, 10077.848832267375, 10091.344062635904, 10121.987801219819, 9920.156786672926, 9924.503774811086, 10051.69844904654, 10073.848892266475, 10272.33229840058, 6672.866542669217, 7125.394341481032, 7277.2722727726805, 7342.155652100077, 7387.630618468947, 8524.616392262238, 8547.358948078794, 8548.273396761346, 8618.741437756626, 8672.046074931879, 7351.0, 7572.962135189509, 7581.6209189541405, 7605.619719013916, 7619.161892191965, 7416.332530072319, 7486.0, 7509.962450187714, 7557.05536807899, 7783.338416234684, 6670.733170673118, 6687.565308254948, 6729.226138993882, 6749.595024298558, 6775.390214880487, 5125.666831655931, 5320.201969704575, 5381.811636592701, 5439.0, 5480.068388373907, 5341.332333458317, 5371.865703357447, 5393.9730301348245, 5404.891902161856, 5532.474414930575], "value": 4598.784565248634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.12058547869276, 310.825937475014, 313.7317593457592, 314.04686775635935, 315.79157755881124, 5436.320459942507, 5574.358948720888, 5585.79905320356, 5661.971690141549, 5680.971595142024, 5595.49640532352, 5636.351819540744, 5641.0, 5642.407547207546, 5653.293338332698, 4279.972806526443, 4297.269464191095, 4306.935395969063, 4311.396404503372, 4314.180305741899, 4023.4970628671417, 4244.87265382039, 4282.957170428303, 4297.183535128315, 4320.135972805451, 4160.812763425638, 4208.389783481409, 4212.389203565481, 4226.852060177895, 4234.449521562193, 4236.724612900151, 4245.08730622916, 4252.2345977724, 4255.680823938186, 4275.187714334266, 3535.1869070114017, 3664.59689434162, 3669.3028324618504, 3675.191457879262, 3704.499677630537, 5405.7567409466665, 5453.563714902798, 5484.314460692413, 5484.862878428071, 5486.286782718221, 4814.325994360793, 4857.368542089505, 4863.367762190928, 4880.975595122037, 4896.804127834918, 5539.25220095286, 5821.825345239649, 5855.502282305966, 5866.589338746289, 5872.7357268923, 4017.718759686823, 4027.476428064362, 4027.9194416111513, 4054.695897807647, 4058.4723985881647, 6032.547558933054, 6069.452289666151, 6095.573309868311, 6119.0, 6144.907826382608, 4041.0301527633155, 4049.493813273341, 4123.793810309473, 4123.8556650517685, 4124.237016152021, 4123.257813593522, 4138.337865941495, 4148.128892932457, 4167.729097608706, 4171.270027745132, 4717.466823282447, 4799.592034677022, 4817.205161148371, 4825.831095911696, 4869.537393947569, 5285.207218917193, 5856.677882716492, 5861.9413805861395, 5901.940980590225, 6008.789692360834, 1403.4596680277962, 1419.950301739434, 1420.9147451152965, 1425.109306683323, 1429.2139323372103, 872.9825403491894, 883.7172104926361, 893.1693525021662, 902.4495058014605, 906.2704522859029, 5053.5742843435355, 5072.4673909239, 5077.441481437039, 5079.619028572872, 5082.898342033139, 5275.841724748264, 5307.920381194285, 5317.867053323698, 5363.624546281723, 5390.649607775482, 4729.2906064089975, 5036.320096786887, 5052.418971818214, 5073.923891141636, 5080.187170052774, 2829.920008793535, 2856.8285902845896, 2863.7708983281286, 2879.5536691812804, 2894.2619631993707, 5475.165819450449, 5485.01269771445, 5531.1426728857095, 5557.277553917965, 5557.776489636001, 5186.936677981005, 5379.4130731434325, 5439.5104440600535, 5441.59188060897, 5479.0, 5414.539764120015, 5450.836474905759, 5471.151971444432, 5483.8080667176455, 5545.445455454503, 5147.897042059063, 5317.707526086102, 5371.368029665357, 5384.6769193848495, 5392.406835248041, 5242.872782351813, 5248.343957005374, 5253.290805741176, 5287.180487024518, 5317.457937198169, 5400.62195646301, 5477.657973796446, 5481.698506582016, 5537.529310008534, 5538.750756215899, 3513.7132698108267, 3737.6449237322413, 3759.4548790425783, 3759.8496060157286, 3779.544875223114, 5317.521423071942, 5341.157300731242, 5350.250964864844, 5843.561732870136, 5885.94114058871, 5844.649321040752, 5911.497522710618, 5912.46787789101, 5929.517620594851, 5933.970330148321, 5850.94149058504, 5877.882442351214, 5879.559033072622, 5893.6463812171405, 5908.586398952032, 5566.053770858883, 5770.567207459373, 5796.710299431785, 5815.41845815415, 5857.824265272048, 5894.38108998549, 5943.7028148591535, 5954.583179177589, 5954.940450595439, 5996.790112346047, 5666.546676265806, 5692.0931487952, 5776.942230577809, 5795.1017592273265, 5842.152887831156], "value": 4232.4713572399705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.0520804725691, 728.8688036153494, 749.5502698380968, 751.1324420294558, 751.2975368030892, 13931.233782141991, 14306.141631502118, 14322.570322890304, 14370.856291437069, 14391.352389142488, 12782.744345113093, 12947.80578291324, 12952.93523532381, 12970.481180752782, 12974.675633109153, 669.7588868007514, 793.2464159048898, 803.7508372404574, 805.5327909812324, 805.6173317674117, 765.3188662090744, 785.9056913170427, 786.6971216081821, 791.8891355210275, 796.55791035975, 835.5863847395517, 838.5178522349643, 840.1472505407016, 842.8693552499342, 842.928351090155, 826.6569373709933, 827.6482494939656, 833.4665813879122, 834.3617132893341, 834.8956380452444, 610.7129649064932, 611.9969400153016, 612.2958597612736, 612.4457366083701, 612.5038718637873, 13292.800607990888, 13321.533746318832, 13381.397837097355, 13385.063045586812, 13423.3959471824, 14363.784543231859, 14699.0, 14749.41002359915, 14778.852211477963, 14837.777433338508, 12008.799120088008, 12032.518699252107, 12105.0, 12187.085968552305, 12711.745765084646, 3784.1296501804463, 3944.4872166618156, 3949.6840252779707, 4023.436718859362, 4034.0, 74460.0, 76522.23477765206, 78478.0, 78979.6051019747, 79024.6048769764, 10602.628907988183, 10627.309224900511, 10814.35113893169, 10999.450027498593, 11268.380239086766, 19576.119074641676, 19600.60798784045, 19693.212271509266, 19700.70448943267, 19731.802681972997, 8090.635921383552, 8465.40742148056, 8500.659973600987, 8541.27399171065, 8731.563421828883, 4661.766911654404, 4845.733484658378, 4900.26496025599, 4956.157453232959, 5041.395032596112, 3291.7202037826573, 3424.7945123292684, 3454.4127498325347, 3496.755227134076, 3511.438169892805, 586.6450797267591, 596.9044952807529, 601.4316470934924, 610.5970059760537, 611.5596770325359, 629.7323637454064, 650.7299470719693, 670.8490589617395, 684.1140722764032, 695.4193248637343, 8596.484210947237, 8815.647374105092, 8846.911530884609, 8849.292056635582, 8885.42244754089, 589.9351071382144, 599.9610025348338, 600.3876046432614, 632.5761739634456, 632.8038308124404, 4395.296752519582, 4582.518835522289, 4606.262997920317, 4620.584147426681, 4673.462551806586, 91034.54482727544, 103195.0, 111999.44000279947, 113575.4321228405, 118335.0, 61304.38695613076, 78681.0, 94589.0, 94662.0533794667, 95337.0, 84275.0, 84745.57627211948, 85964.57017714871, 86089.56955215184, 86301.99999999875, 8918.10818918103, 9031.142041506046, 9055.637774488947, 9117.635294588143, 9162.651231483043, 49659.0, 50209.24686129784, 50302.748486258795, 50667.74666126646, 52291.0, 46035.76982115068, 73773.631131844, 73962.63018684872, 73988.0, 76308.23691763234, 9540.686767086254, 9753.366031207948, 10816.17192639699, 10852.511636976196, 10949.343039417661, 12079.75840483203, 12297.692557686129, 12474.812877806658, 12674.429650665927, 12872.0, 10729.195310351912, 10820.710820710758, 10857.945710271399, 10992.560297588007, 11102.722431939266, 10993.395363255098, 11002.22984391117, 11164.720881978015, 11695.181337306307, 11784.0, 11066.944665276622, 11099.223054386115, 11245.0, 11275.267107637977, 11289.20975531705, 9549.952250238704, 9727.367721098106, 9785.119339259501, 9897.35667181631, 10026.197904167795, 9904.455254961047, 10095.192384609067, 10101.949490252502, 10242.334248273839, 10347.793044138925], "value": 7050.646304100414, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 112.0, 113.0, 112.0, 109.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 154.0, 180.0, 129.0, 151.0, 157.0, 141.0, 184.0, 136.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 162.0, 161.0, 167.0, 167.0, 161.0, 163.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 161.0, 75.0, 75.0, 74.0, 74.0, 163.0, 78.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 153.0, 85.0, 85.0, 85.0, 144.0, 85.0, 85.0, 142.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 148.0, 148.0, 146.0, 147.0, 149.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 57.0, 54.0, 62.0, 54.0, 59.0, 55.0, 55.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 60.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 81.0, 82.0, 80.0, 82.0, 80.0, 111.0, 81.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 127.0, 140.0, 133.0, 128.0, 132.0, 133.0, 142.0, 131.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 160.0, 164.0, 156.0, 158.0, 165.0, 157.0, 162.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 66.0, 66.0, 63.0, 61.0, 63.0, 64.0], "value": 63.5, "unit": "score"}]}]} 08:46:40 INFO - Return code: 0 08:46:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:46:41 ERROR - # TBPL SUCCESS # 08:46:41 INFO - Running post-action listener: _resource_record_post_action 08:46:41 INFO - ##### 08:46:41 INFO - ##### Finished run-tests step (success) 08:46:41 INFO - ##### 08:46:41 INFO - Running post-run listener: _resource_record_post_run 08:46:41 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 541896704; Read time: 0; Write time: 426924 08:46:41 INFO - TinderboxPrint: CPU usage
13.6% 08:46:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:46:41 INFO - TinderboxPrint: I/O write bytes / time
541,896,704 / 426,924 08:46:41 INFO - TinderboxPrint: CPU idle
8,206.4 (86.4%) 08:46:41 INFO - TinderboxPrint: CPU user
1,230.6 (13.0%) 08:46:41 INFO - TinderboxPrint: Swap in / out
0 / 0 08:46:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248082432; Read time: 0; Write time: 235744 08:46:41 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 293093376; Read time: 0; Write time: 191144 08:46:41 INFO - Running post-run listener: _upload_blobber_files 08:46:41 INFO - Blob upload gear active. 08:46:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:46:41 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:46:41 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:46:41 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:46:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:46:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:46:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:46:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:42 INFO - (blobuploader) - INFO - Done attempting. 08:46:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:46:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:46 INFO - (blobuploader) - INFO - Done attempting. 08:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:46:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:47 INFO - (blobuploader) - INFO - Done attempting. 08:46:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:46:47 INFO - Return code: 0 08:46:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:46:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:46:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66af81997f75f04ae422f54aba6317b584fe8e04b03089ced01bf8990980608fe052b4c25e09dc30497b1412661b6f18e0fee495ede6563718dcd3b77a55d8b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef94fa9269d4a01935e3d4645dc894e3df43a3daaa590dd6f37bdb173b090e47b0c029e99955cf6fcf0209b35e0ea6c5d4d5d97fa9f940e8ffc01420f26fd135", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0958dccb06e11527e949ffe9fff777ea71b33315fa44ebc1cfaac39053c43cade3536816bcac3712f4b7f62762c78b46ac8ae93912d6737d98ac431f8eb11f77"} 08:46:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:46:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:46:47 INFO - Contents: 08:46:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66af81997f75f04ae422f54aba6317b584fe8e04b03089ced01bf8990980608fe052b4c25e09dc30497b1412661b6f18e0fee495ede6563718dcd3b77a55d8b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef94fa9269d4a01935e3d4645dc894e3df43a3daaa590dd6f37bdb173b090e47b0c029e99955cf6fcf0209b35e0ea6c5d4d5d97fa9f940e8ffc01420f26fd135", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0958dccb06e11527e949ffe9fff777ea71b33315fa44ebc1cfaac39053c43cade3536816bcac3712f4b7f62762c78b46ac8ae93912d6737d98ac431f8eb11f77"} 08:46:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:46:47 INFO - Copying logs to upload dir... 08:46:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:46:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.460101 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-07 08:46:47.158573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:46:47.162123) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66af81997f75f04ae422f54aba6317b584fe8e04b03089ced01bf8990980608fe052b4c25e09dc30497b1412661b6f18e0fee495ede6563718dcd3b77a55d8b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef94fa9269d4a01935e3d4645dc894e3df43a3daaa590dd6f37bdb173b090e47b0c029e99955cf6fcf0209b35e0ea6c5d4d5d97fa9f940e8ffc01420f26fd135", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0958dccb06e11527e949ffe9fff777ea71b33315fa44ebc1cfaac39053c43cade3536816bcac3712f4b7f62762c78b46ac8ae93912d6737d98ac431f8eb11f77"} build_url:https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/LlZVZ4dMS0eHnvpVVwYjmw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66af81997f75f04ae422f54aba6317b584fe8e04b03089ced01bf8990980608fe052b4c25e09dc30497b1412661b6f18e0fee495ede6563718dcd3b77a55d8b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef94fa9269d4a01935e3d4645dc894e3df43a3daaa590dd6f37bdb173b090e47b0c029e99955cf6fcf0209b35e0ea6c5d4d5d97fa9f940e8ffc01420f26fd135", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0958dccb06e11527e949ffe9fff777ea71b33315fa44ebc1cfaac39053c43cade3536816bcac3712f4b7f62762c78b46ac8ae93912d6737d98ac431f8eb11f77"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:46:47.188723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:46:47.189108) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465313173.276869-1865821013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:46:47.240957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:46:47.241348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:46:47.241754) ========= ========= Total master_lag: 0.43 =========