builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1466003485.47 results: success (0) buildid: 20160615053002 builduid: 1af116f20aec4c3caefbf45348bbf4eb revision: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.469188) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.469786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.470281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.495176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.495662) ========= 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-1466003160.272370-1871856095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 08:11:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-06-15 08:11:25 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.254995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.765636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.765998) ========= 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-1466003160.272370-1871856095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015981 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.816837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:25.817271) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff --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 bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff --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-1466003160.272370-1871856095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 08:11:26,082 truncating revision to first 12 chars 2016-06-15 08:11:26,082 Setting DEBUG logging. 2016-06-15 08:11:26,082 attempt 1/10 2016-06-15 08:11:26,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bac29d6a5639?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 08:11:26,438 unpacking tar archive at: fx-team-bac29d6a5639/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:26.548858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:26.549283) ========= script_repo_revision: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:26.549773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:26.550146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:11:26.564645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-15 08:11:26.564966) ========= /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-1466003160.272370-1871856095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:26 INFO - MultiFileLogger online at 20160615 08:11:26 in /builds/slave/test 08:11:26 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:11:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:26 INFO - {'append_to_log': False, 08:11:26 INFO - 'base_work_dir': '/builds/slave/test', 08:11:26 INFO - 'blob_upload_branch': 'Fx-Team', 08:11:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:26 INFO - 'branch': 'Fx-Team', 08:11:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:26 INFO - 'config_files': ('talos/linux_config.py',), 08:11:26 INFO - 'default_actions': ('clobber', 08:11:26 INFO - 'read-buildbot-config', 08:11:26 INFO - 'download-and-extract', 08:11:26 INFO - 'populate-webroot', 08:11:26 INFO - 'create-virtualenv', 08:11:26 INFO - 'install', 08:11:26 INFO - 'run-tests'), 08:11:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:26 INFO - 'download_minidump_stackwalk': True, 08:11:26 INFO - 'download_symbols': 'ondemand', 08:11:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:26 INFO - 'installer_path': 'installer.exe', 08:11:26 INFO - 'log_level': 'info', 08:11:26 INFO - 'log_name': 'talos', 08:11:26 INFO - 'log_to_console': True, 08:11:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:26 INFO - 'opt_config_files': (), 08:11:26 INFO - 'pip_index': False, 08:11:26 INFO - 'sps_profile': False, 08:11:26 INFO - 'sps_profile_interval': 0, 08:11:26 INFO - 'suite': 'dromaeojs-e10s', 08:11:26 INFO - 'system_bits': '32', 08:11:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:26 INFO - 'title': 'talos-linux64-ix-060', 08:11:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:26 INFO - 'use_talos_json': True, 08:11:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:26 INFO - 'work_dir': 'build'} 08:11:26 INFO - ##### 08:11:26 INFO - ##### Running clobber step. 08:11:26 INFO - ##### 08:11:26 INFO - Running pre-action listener: _resource_record_pre_action 08:11:26 INFO - Running main action method: clobber 08:11:26 INFO - rmtree: /builds/slave/test/build 08:11:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:27 INFO - Running post-action listener: _resource_record_post_action 08:11:27 INFO - ##### 08:11:27 INFO - ##### Finished clobber step (success) 08:11:27 INFO - ##### 08:11:27 INFO - ##### 08:11:27 INFO - ##### Running read-buildbot-config step. 08:11:27 INFO - ##### 08:11:27 INFO - Running pre-action listener: _resource_record_pre_action 08:11:27 INFO - Running main action method: read_buildbot_config 08:11:27 INFO - Using buildbot properties: 08:11:27 INFO - { 08:11:27 INFO - "project": "", 08:11:27 INFO - "product": "firefox", 08:11:27 INFO - "script_repo_revision": "production", 08:11:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:11:27 INFO - "repository": "", 08:11:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:11:27 INFO - "buildid": "20160615053002", 08:11:27 INFO - "pgo_build": "True", 08:11:27 INFO - "basedir": "/builds/slave/test", 08:11:27 INFO - "buildnumber": 473, 08:11:27 INFO - "slavename": "talos-linux64-ix-060", 08:11:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:11:27 INFO - "platform": "ubuntu64_hw", 08:11:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:11:27 INFO - "branch": "fx-team", 08:11:27 INFO - "repo_path": "integration/fx-team", 08:11:27 INFO - "revision": "bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff", 08:11:27 INFO - "stage_platform": "linux64-pgo", 08:11:27 INFO - "builduid": "1af116f20aec4c3caefbf45348bbf4eb", 08:11:27 INFO - "slavebuilddir": "test" 08:11:27 INFO - } 08:11:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:11:27 INFO - Running post-action listener: _resource_record_post_action 08:11:27 INFO - ##### 08:11:27 INFO - ##### Finished read-buildbot-config step (success) 08:11:27 INFO - ##### 08:11:27 INFO - ##### 08:11:27 INFO - ##### Running download-and-extract step. 08:11:27 INFO - ##### 08:11:27 INFO - Running pre-action listener: _resource_record_pre_action 08:11:27 INFO - Running main action method: download_and_extract 08:11:27 INFO - mkdir: /builds/slave/test/build/tests 08:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:27 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:28 INFO - Downloaded 1361 bytes. 08:11:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:28 INFO - Using the following test package requirements: 08:11:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'jsshell-linux-x86_64.zip'], 08:11:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11: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:11:28 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:29 INFO - Downloaded 24221178 bytes. 08:11:29 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:11:29 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:11:31 INFO - Return code: 0 08:11:31 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:11: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:11:31 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:33 INFO - Downloaded 24221178 bytes. 08:11:33 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:11:33 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:11:34 INFO - Return code: 0 08:11:34 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:11:34 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:36 INFO - Downloaded 14405384 bytes. 08:11:36 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:11:36 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:11:37 INFO - Return code: 0 08:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:37 INFO - https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bSwK6hb_QL6rlCam3nPEdA/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:11:39 INFO - Downloaded 59402892 bytes. 08:11:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:39 INFO - mkdir: /builds/slave/test/properties 08:11:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:39 INFO - Contents: 08:11:39 INFO - build_url:https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:40 INFO - Running post-action listener: _resource_record_post_action 08:11:40 INFO - Running post-action listener: set_extra_try_arguments 08:11:40 INFO - ##### 08:11:40 INFO - ##### Finished download-and-extract step (success) 08:11:40 INFO - ##### 08:11:40 INFO - ##### 08:11:40 INFO - ##### Running populate-webroot step. 08:11:40 INFO - ##### 08:11:40 INFO - Running pre-action listener: _resource_record_pre_action 08:11:40 INFO - Running main action method: populate_webroot 08:11:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:40 INFO - '--tppagecycles', 08:11:40 INFO - '7'], 08:11:40 INFO - 'tests': ['tsvgm']}}, 08:11:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['damp', 'tps']}, 08:11:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'tests': ['damp', 'tps']}, 08:11:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['dromaeo_dom']}, 08:11:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['basic_compositor_video']}, 08:11:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['a11yr', 08:11:40 INFO - 'ts_paint', 08:11:40 INFO - 'tpaint', 08:11:40 INFO - 'sessionrestore', 08:11:40 INFO - 'sessionrestore_no_auto_restore', 08:11:40 INFO - 'tabpaint']}, 08:11:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:40 INFO - 'ts_paint', 08:11:40 INFO - 'tpaint', 08:11:40 INFO - 'sessionrestore', 08:11:40 INFO - 'sessionrestore_no_auto_restore', 08:11:40 INFO - 'tabpaint']}, 08:11:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:40 INFO - 'ts_paint', 08:11:40 INFO - 'tpaint', 08:11:40 INFO - 'sessionrestore', 08:11:40 INFO - 'sessionrestore_no_auto_restore', 08:11:40 INFO - 'tabpaint']}, 08:11:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:40 INFO - 'ts_paint', 08:11:40 INFO - 'tpaint', 08:11:40 INFO - 'sessionrestore', 08:11:40 INFO - 'sessionrestore_no_auto_restore', 08:11:40 INFO - 'tabpaint']}, 08:11:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['a11yr', 08:11:40 INFO - 'ts_paint', 08:11:40 INFO - 'tpaint', 08:11:40 INFO - 'sessionrestore', 08:11:40 INFO - 'sessionrestore_no_auto_restore', 08:11:40 INFO - 'tabpaint']}, 08:11:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['a11yr', 08:11:40 INFO - 'ts_paint', 08:11:40 INFO - 'tpaint', 08:11:40 INFO - 'sessionrestore', 08:11:40 INFO - 'sessionrestore_no_auto_restore', 08:11:40 INFO - 'tabpaint']}, 08:11:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['tsvgx', 08:11:40 INFO - 'tsvgr_opacity', 08:11:40 INFO - 'tart', 08:11:40 INFO - 'tscrollx', 08:11:40 INFO - 'cart']}, 08:11:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:40 INFO - 'tsvgr_opacity', 08:11:40 INFO - 'tart', 08:11:40 INFO - 'tscrollx', 08:11:40 INFO - 'cart']}, 08:11:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'talos_options': ['--disable-e10s'], 08:11:40 INFO - 'tests': ['tp5o']}, 08:11:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'tests': ['tp5o']}, 08:11:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'talos_options': ['--disable-e10s', 08:11:40 INFO - '--xperf_path', 08:11:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:40 INFO - 'tests': ['tp5n']}, 08:11:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:40 INFO - 'talos_options': ['--xperf_path', 08:11:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:40 INFO - 'tests': ['tp5n']}}, 08:11:40 INFO - 'talos.zip': {'path': '', 08:11:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:40 INFO - Running post-action listener: _resource_record_post_action 08:11:40 INFO - ##### 08:11:40 INFO - ##### Finished populate-webroot step (success) 08:11:40 INFO - ##### 08:11:40 INFO - ##### 08:11:40 INFO - ##### Running create-virtualenv step. 08:11:40 INFO - ##### 08:11:40 INFO - Running pre-action listener: _resource_record_pre_action 08:11:40 INFO - Running main action method: create_virtualenv 08:11:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:40 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:11:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:40 INFO - Using real prefix '/usr' 08:11:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:42 INFO - Installing pip.................done. 08:11:42 INFO - Return code: 0 08:11:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11: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:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:42 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:42 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:11:42 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:11:42 INFO - Using env: {'DISPLAY': ':0', 08:11:42 INFO - 'HOME': '/home/cltbld', 08:11:42 INFO - 'LANG': 'en_US.UTF-8', 08:11:42 INFO - 'LANGUAGE': 'en_US:en', 08:11:42 INFO - 'LOGNAME': 'cltbld', 08:11:42 INFO - 'MAIL': '/var/mail/cltbld', 08:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:42 INFO - 'MOZ_NO_REMOTE': '1', 08:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:42 INFO - 'NO_EM_RESTART': '1', 08:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:42 INFO - 'PWD': '/builds/slave/test', 08:11:42 INFO - 'SHELL': '/bin/bash', 08:11:42 INFO - 'SHLVL': '1', 08:11:42 INFO - 'TERM': 'linux', 08:11:42 INFO - 'TMOUT': '86400', 08:11:42 INFO - 'USER': 'cltbld', 08:11:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:42 INFO - '_': '/tools/buildbot/bin/python'} 08:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:43 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:11:43 INFO - Cleaning up... 08:11:43 INFO - Return code: 0 08:11:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:43 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:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:43 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:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:43 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:43 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:11:43 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:11:43 INFO - Using env: {'DISPLAY': ':0', 08:11:43 INFO - 'HOME': '/home/cltbld', 08:11:43 INFO - 'LANG': 'en_US.UTF-8', 08:11:43 INFO - 'LANGUAGE': 'en_US:en', 08:11:43 INFO - 'LOGNAME': 'cltbld', 08:11:43 INFO - 'MAIL': '/var/mail/cltbld', 08:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:43 INFO - 'MOZ_NO_REMOTE': '1', 08:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:43 INFO - 'NO_EM_RESTART': '1', 08:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:43 INFO - 'PWD': '/builds/slave/test', 08:11:43 INFO - 'SHELL': '/bin/bash', 08:11:43 INFO - 'SHLVL': '1', 08:11:43 INFO - 'TERM': 'linux', 08:11:43 INFO - 'TMOUT': '86400', 08:11:43 INFO - 'USER': 'cltbld', 08:11:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:43 INFO - '_': '/tools/buildbot/bin/python'} 08:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:43 INFO - Downloading/unpacking psutil>=3.1.1 08:11:43 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:11:43 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:11:43 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:11:43 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:11:43 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:11:43 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:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:45 INFO - Installing collected packages: psutil 08:11:45 INFO - Running setup.py install for psutil 08:11:45 INFO - building 'psutil._psutil_linux' extension 08:11:45 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:11:45 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:11:45 INFO - building 'psutil._psutil_posix' extension 08:11:45 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:11:45 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:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:45 INFO - Successfully installed psutil 08:11:45 INFO - Cleaning up... 08:11:45 INFO - Return code: 0 08:11:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:11:45 INFO - Using env: {'DISPLAY': ':0', 08:11:45 INFO - 'HOME': '/home/cltbld', 08:11:45 INFO - 'LANG': 'en_US.UTF-8', 08:11:45 INFO - 'LANGUAGE': 'en_US:en', 08:11:45 INFO - 'LOGNAME': 'cltbld', 08:11:45 INFO - 'MAIL': '/var/mail/cltbld', 08:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:45 INFO - 'MOZ_NO_REMOTE': '1', 08:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:45 INFO - 'NO_EM_RESTART': '1', 08:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:45 INFO - 'PWD': '/builds/slave/test', 08:11:45 INFO - 'SHELL': '/bin/bash', 08:11:45 INFO - 'SHLVL': '1', 08:11:45 INFO - 'TERM': 'linux', 08:11:45 INFO - 'TMOUT': '86400', 08:11:45 INFO - 'USER': 'cltbld', 08:11:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:45 INFO - '_': '/tools/buildbot/bin/python'} 08:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:46 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:11:46 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:11:46 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:11:46 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:11:46 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:11:46 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:11:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:47 INFO - Installing collected packages: mozsystemmonitor 08:11:47 INFO - Running setup.py install for mozsystemmonitor 08:11:48 INFO - Successfully installed mozsystemmonitor 08:11:48 INFO - Cleaning up... 08:11:48 INFO - Return code: 0 08:11:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:48 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:48 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:11:48 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:11:48 INFO - Using env: {'DISPLAY': ':0', 08:11:48 INFO - 'HOME': '/home/cltbld', 08:11:48 INFO - 'LANG': 'en_US.UTF-8', 08:11:48 INFO - 'LANGUAGE': 'en_US:en', 08:11:48 INFO - 'LOGNAME': 'cltbld', 08:11:48 INFO - 'MAIL': '/var/mail/cltbld', 08:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:48 INFO - 'MOZ_NO_REMOTE': '1', 08:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:48 INFO - 'NO_EM_RESTART': '1', 08:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:48 INFO - 'PWD': '/builds/slave/test', 08:11:48 INFO - 'SHELL': '/bin/bash', 08:11:48 INFO - 'SHLVL': '1', 08:11:48 INFO - 'TERM': 'linux', 08:11:48 INFO - 'TMOUT': '86400', 08:11:48 INFO - 'USER': 'cltbld', 08:11:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:48 INFO - '_': '/tools/buildbot/bin/python'} 08:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:48 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:11:48 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:11:48 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:11:48 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:11:48 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:11:48 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:11:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:50 INFO - warning: no files found matching '*.txt' 08:11:50 INFO - no previously-included directories found matching 'build' 08:11:50 INFO - no previously-included directories found matching 'dist' 08:11:50 INFO - no previously-included directories found matching '.git*' 08:11:50 INFO - Installing collected packages: jsonschema, functools32 08:11:50 INFO - Running setup.py install for functools32 08:11:50 INFO - warning: no files found matching '*.txt' 08:11:50 INFO - no previously-included directories found matching 'build' 08:11:50 INFO - no previously-included directories found matching 'dist' 08:11:50 INFO - no previously-included directories found matching '.git*' 08:11:50 INFO - Successfully installed jsonschema functools32 08:11:50 INFO - Cleaning up... 08:11:50 INFO - Return code: 0 08:11:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:50 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:50 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:11:50 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:11:50 INFO - Using env: {'DISPLAY': ':0', 08:11:50 INFO - 'HOME': '/home/cltbld', 08:11:50 INFO - 'LANG': 'en_US.UTF-8', 08:11:50 INFO - 'LANGUAGE': 'en_US:en', 08:11:50 INFO - 'LOGNAME': 'cltbld', 08:11:50 INFO - 'MAIL': '/var/mail/cltbld', 08:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:50 INFO - 'MOZ_NO_REMOTE': '1', 08:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:50 INFO - 'NO_EM_RESTART': '1', 08:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:50 INFO - 'PWD': '/builds/slave/test', 08:11:50 INFO - 'SHELL': '/bin/bash', 08:11:50 INFO - 'SHLVL': '1', 08:11:50 INFO - 'TERM': 'linux', 08:11:50 INFO - 'TMOUT': '86400', 08:11:50 INFO - 'USER': 'cltbld', 08:11:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:50 INFO - '_': '/tools/buildbot/bin/python'} 08:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:52 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:11:52 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:11:52 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:11:52 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:11:52 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:11:52 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:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 INFO - Downloading docopt-0.6.1.tar.gz 08:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:53 INFO - Running setup.py install for blobuploader 08:11:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:53 INFO - Running setup.py install for requests 08:11:53 INFO - Running setup.py install for docopt 08:11:54 INFO - Successfully installed blobuploader requests docopt 08:11:54 INFO - Cleaning up... 08:11:54 INFO - Return code: 0 08:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:54 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:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:54 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:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:54 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:54 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:11:54 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:11:54 INFO - Using env: {'DISPLAY': ':0', 08:11:54 INFO - 'HOME': '/home/cltbld', 08:11:54 INFO - 'LANG': 'en_US.UTF-8', 08:11:54 INFO - 'LANGUAGE': 'en_US:en', 08:11:54 INFO - 'LOGNAME': 'cltbld', 08:11:54 INFO - 'MAIL': '/var/mail/cltbld', 08:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:54 INFO - 'MOZ_NO_REMOTE': '1', 08:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:54 INFO - 'NO_EM_RESTART': '1', 08:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:54 INFO - 'PWD': '/builds/slave/test', 08:11:54 INFO - 'SHELL': '/bin/bash', 08:11:54 INFO - 'SHLVL': '1', 08:11:54 INFO - 'TERM': 'linux', 08:11:54 INFO - 'TMOUT': '86400', 08:11:54 INFO - 'USER': 'cltbld', 08:11:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:54 INFO - '_': '/tools/buildbot/bin/python'} 08:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:54 INFO - Running setup.py (path:/tmp/pip-ITBLYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:54 INFO - Running setup.py (path:/tmp/pip-lWTZtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:54 INFO - Running setup.py (path:/tmp/pip-v_eHA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:54 INFO - Running setup.py (path:/tmp/pip-o9kWdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:54 INFO - Running setup.py (path:/tmp/pip-O1zvqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:54 INFO - Running setup.py (path:/tmp/pip-wlmVfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:54 INFO - Running setup.py (path:/tmp/pip-WUa_fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:54 INFO - Running setup.py (path:/tmp/pip-IQY2e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:54 INFO - Running setup.py (path:/tmp/pip-TW33bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:55 INFO - Running setup.py (path:/tmp/pip-RWgqnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:55 INFO - Running setup.py (path:/tmp/pip-IOZYjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:55 INFO - Running setup.py (path:/tmp/pip-4hbi3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:55 INFO - Running setup.py (path:/tmp/pip-uOKuBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:55 INFO - Running setup.py (path:/tmp/pip-LW9d1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:55 INFO - Running setup.py (path:/tmp/pip-ulnVC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:55 INFO - Running setup.py (path:/tmp/pip-GTD3fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:55 INFO - Running setup.py (path:/tmp/pip-FKGTtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:55 INFO - Running setup.py install for manifestparser 08:11:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:55 INFO - Running setup.py install for mozcrash 08:11:55 INFO - Running setup.py install for mozdebug 08:11:55 INFO - Running setup.py install for mozdevice 08:11:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for mozfile 08:11:56 INFO - Running setup.py install for mozhttpd 08:11:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for mozinfo 08:11:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for mozInstall 08:11:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for mozleak 08:11:56 INFO - Running setup.py install for mozlog 08:11:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for moznetwork 08:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for mozprocess 08:11:56 INFO - Running setup.py install for mozprofile 08:11:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:56 INFO - Running setup.py install for mozrunner 08:11:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:57 INFO - Running setup.py install for mozscreenshot 08:11:57 INFO - Running setup.py install for moztest 08:11:57 INFO - Running setup.py install for mozversion 08:11:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:57 INFO - Cleaning up... 08:11:57 INFO - Return code: 0 08:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:57 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:11:57 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:11:57 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:11:57 INFO - Using env: {'DISPLAY': ':0', 08:11:57 INFO - 'HOME': '/home/cltbld', 08:11:57 INFO - 'LANG': 'en_US.UTF-8', 08:11:57 INFO - 'LANGUAGE': 'en_US:en', 08:11:57 INFO - 'LOGNAME': 'cltbld', 08:11:57 INFO - 'MAIL': '/var/mail/cltbld', 08:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:57 INFO - 'MOZ_NO_REMOTE': '1', 08:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:57 INFO - 'NO_EM_RESTART': '1', 08:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:57 INFO - 'PWD': '/builds/slave/test', 08:11:57 INFO - 'SHELL': '/bin/bash', 08:11:57 INFO - 'SHLVL': '1', 08:11:57 INFO - 'TERM': 'linux', 08:11:57 INFO - 'TMOUT': '86400', 08:11:57 INFO - 'USER': 'cltbld', 08:11:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:57 INFO - '_': '/tools/buildbot/bin/python'} 08:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:57 INFO - Running setup.py (path:/tmp/pip-AFQT_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:57 INFO - Running setup.py (path:/tmp/pip-NVdcIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:57 INFO - Running setup.py (path:/tmp/pip-L0Nm0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:57 INFO - Running setup.py (path:/tmp/pip-W1RjE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:57 INFO - Running setup.py (path:/tmp/pip-sdNNex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:57 INFO - Running setup.py (path:/tmp/pip-zAgApl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:58 INFO - Running setup.py (path:/tmp/pip-ow6_w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:58 INFO - Running setup.py (path:/tmp/pip-4CSLv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:58 INFO - Running setup.py (path:/tmp/pip-rF0k8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:58 INFO - Running setup.py (path:/tmp/pip-zVy0ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:58 INFO - Running setup.py (path:/tmp/pip-yhv931-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:58 INFO - Running setup.py (path:/tmp/pip-pZqn1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:58 INFO - Running setup.py (path:/tmp/pip-MMyP8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:58 INFO - Running setup.py (path:/tmp/pip-Wlhxf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:58 INFO - Running setup.py (path:/tmp/pip-XTOfQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:58 INFO - Running setup.py (path:/tmp/pip-uoKZbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:58 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:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:58 INFO - Running setup.py (path:/tmp/pip-EOrovv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:58 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:11:58 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:11:58 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:11:58 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:11:58 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:11:58 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:11:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:00 INFO - Downloading blessings-1.6.tar.gz 08:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:00 INFO - Installing collected packages: blessings 08:12:00 INFO - Running setup.py install for blessings 08:12:00 INFO - Successfully installed blessings 08:12:00 INFO - Cleaning up... 08:12:00 INFO - Return code: 0 08:12:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:01 INFO - Reading from file tmpfile_stdout 08:12:01 INFO - Current package versions: 08:12:01 INFO - argparse == 1.2.1 08:12:01 INFO - blessings == 1.6 08:12:01 INFO - blobuploader == 1.2.4 08:12:01 INFO - docopt == 0.6.1 08:12:01 INFO - functools32 == 3.2.3-2 08:12:01 INFO - jsonschema == 2.5.1 08:12:01 INFO - manifestparser == 1.1 08:12:01 INFO - mozInstall == 1.12 08:12:01 INFO - mozcrash == 0.17 08:12:01 INFO - mozdebug == 0.1 08:12:01 INFO - mozdevice == 0.48 08:12:01 INFO - mozfile == 1.2 08:12:01 INFO - mozhttpd == 0.7 08:12:01 INFO - mozinfo == 0.9 08:12:01 INFO - mozleak == 0.1 08:12:01 INFO - mozlog == 3.2 08:12:01 INFO - moznetwork == 0.27 08:12:01 INFO - mozprocess == 0.22 08:12:01 INFO - mozprofile == 0.28 08:12:01 INFO - mozrunner == 6.11 08:12:01 INFO - mozscreenshot == 0.1 08:12:01 INFO - mozsystemmonitor == 0.3 08:12:01 INFO - moztest == 0.7 08:12:01 INFO - mozversion == 1.4 08:12:01 INFO - psutil == 3.1.1 08:12:01 INFO - requests == 1.2.3 08:12:01 INFO - wsgiref == 0.1.2 08:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:01 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:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:01 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:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:01 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:12:01 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:12:01 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:12:01 INFO - Using env: {'DISPLAY': ':0', 08:12:01 INFO - 'HOME': '/home/cltbld', 08:12:01 INFO - 'LANG': 'en_US.UTF-8', 08:12:01 INFO - 'LANGUAGE': 'en_US:en', 08:12:01 INFO - 'LOGNAME': 'cltbld', 08:12:01 INFO - 'MAIL': '/var/mail/cltbld', 08:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:01 INFO - 'MOZ_NO_REMOTE': '1', 08:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:01 INFO - 'NO_EM_RESTART': '1', 08:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:01 INFO - 'PWD': '/builds/slave/test', 08:12:01 INFO - 'SHELL': '/bin/bash', 08:12:01 INFO - 'SHLVL': '1', 08:12:01 INFO - 'TERM': 'linux', 08:12:01 INFO - 'TMOUT': '86400', 08:12:01 INFO - 'USER': 'cltbld', 08:12:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:01 INFO - '_': '/tools/buildbot/bin/python'} 08:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 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:12:01 INFO - Cleaning up... 08:12:01 INFO - Return code: 0 08:12:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:01 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:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:01 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:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:01 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:12:01 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:12:01 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:12:01 INFO - Using env: {'DISPLAY': ':0', 08:12:01 INFO - 'HOME': '/home/cltbld', 08:12:01 INFO - 'LANG': 'en_US.UTF-8', 08:12:01 INFO - 'LANGUAGE': 'en_US:en', 08:12:01 INFO - 'LOGNAME': 'cltbld', 08:12:01 INFO - 'MAIL': '/var/mail/cltbld', 08:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:01 INFO - 'MOZ_NO_REMOTE': '1', 08:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:01 INFO - 'NO_EM_RESTART': '1', 08:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:01 INFO - 'PWD': '/builds/slave/test', 08:12:01 INFO - 'SHELL': '/bin/bash', 08:12:01 INFO - 'SHLVL': '1', 08:12:01 INFO - 'TERM': 'linux', 08:12:01 INFO - 'TMOUT': '86400', 08:12:01 INFO - 'USER': 'cltbld', 08:12:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:01 INFO - '_': '/tools/buildbot/bin/python'} 08:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:01 INFO - Cleaning up... 08:12:01 INFO - Return code: 0 08:12:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:12:01 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:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:01 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:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:01 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 0x7fd382c0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, '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-1466003160.272370-1871856095', '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:12:01 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:12:01 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:12:01 INFO - Using env: {'DISPLAY': ':0', 08:12:01 INFO - 'HOME': '/home/cltbld', 08:12:01 INFO - 'LANG': 'en_US.UTF-8', 08:12:01 INFO - 'LANGUAGE': 'en_US:en', 08:12:01 INFO - 'LOGNAME': 'cltbld', 08:12:01 INFO - 'MAIL': '/var/mail/cltbld', 08:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:01 INFO - 'MOZ_NO_REMOTE': '1', 08:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:01 INFO - 'NO_EM_RESTART': '1', 08:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:01 INFO - 'PWD': '/builds/slave/test', 08:12:01 INFO - 'SHELL': '/bin/bash', 08:12:01 INFO - 'SHLVL': '1', 08:12:01 INFO - 'TERM': 'linux', 08:12:01 INFO - 'TMOUT': '86400', 08:12:01 INFO - 'USER': 'cltbld', 08:12:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:01 INFO - '_': '/tools/buildbot/bin/python'} 08:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:01 INFO - Downloading/unpacking flake8 08:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:12:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:12:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:12:04 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:12:04 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:12:04 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:12:04 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:12:04 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:12:04 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:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:12:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:04 INFO - no previously-included directories found matching 'docs/_build' 08:12:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:12:04 INFO - Running setup.py install for pep8 08:12:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:04 INFO - no previously-included directories found matching 'docs/_build' 08:12:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:12:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:12:04 INFO - Cleaning up... 08:12:04 INFO - Return code: 0 08:12:04 INFO - Running post-action listener: _resource_record_post_action 08:12:04 INFO - Running post-action listener: _start_resource_monitoring 08:12:04 INFO - Starting resource monitoring. 08:12:04 INFO - ##### 08:12:04 INFO - ##### Finished create-virtualenv step (success) 08:12:04 INFO - ##### 08:12:04 INFO - ##### 08:12:04 INFO - ##### Running install step. 08:12:04 INFO - ##### 08:12:04 INFO - Running pre-action listener: _resource_record_pre_action 08:12:04 INFO - Running main action method: install 08:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:04 INFO - Reading from file tmpfile_stdout 08:12:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:05 INFO - Reading from file tmpfile_stdout 08:12:05 INFO - Output received: 08:12:05 INFO - Usage: mozinstall [options] installer 08:12:05 INFO - Options: 08:12:05 INFO - -h, --help show this help message and exit 08:12:05 INFO - -d DEST, --destination=DEST 08:12:05 INFO - Directory to install application into. [default: 08:12:05 INFO - "/builds/slave/test"] 08:12:05 INFO - --app=APP Application being installed. [default: firefox] 08:12:05 INFO - mkdir: /builds/slave/test/build/application 08:12:05 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:12:05 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:12:21 INFO - Reading from file tmpfile_stdout 08:12:21 INFO - Output received: 08:12:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:21 INFO - Running post-action listener: _resource_record_post_action 08:12:21 INFO - ##### 08:12:21 INFO - ##### Finished install step (success) 08:12:21 INFO - ##### 08:12:21 INFO - ##### 08:12:21 INFO - ##### Running run-tests step. 08:12:21 INFO - ##### 08:12:21 INFO - Running pre-action listener: _resource_record_pre_action 08:12:21 INFO - Running main action method: run_tests 08:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:21 INFO - Python 2.7.3 08:12:21 INFO - Return code: 0 08:12:21 INFO - grabbing minidump binary from tooltool 08:12:21 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:12:21 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 0xf001c0>, '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 0xf010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf01550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:21 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:12:21 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:12:21 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:12:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:21 INFO - Return code: 0 08:12:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:12:22 INFO - Return code: 0 08:12:22 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/bSwK6hb_QL6rlCam3nPEdA/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:12:22 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/bSwK6hb_QL6rlCam3nPEdA/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:12:22 INFO - Using env: {'DISPLAY': ':0', 08:12:22 INFO - 'HOME': '/home/cltbld', 08:12:22 INFO - 'LANG': 'en_US.UTF-8', 08:12:22 INFO - 'LANGUAGE': 'en_US:en', 08:12:22 INFO - 'LOGNAME': 'cltbld', 08:12:22 INFO - 'MAIL': '/var/mail/cltbld', 08:12:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:22 INFO - 'MOZ_NO_REMOTE': '1', 08:12:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:22 INFO - 'NO_EM_RESTART': '1', 08:12:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:22 INFO - 'PWD': '/builds/slave/test', 08:12:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:22 INFO - 'SHELL': '/bin/bash', 08:12:22 INFO - 'SHLVL': '1', 08:12:22 INFO - 'TERM': 'linux', 08:12:22 INFO - 'TMOUT': '86400', 08:12:22 INFO - 'USER': 'cltbld', 08:12:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466003160.272370-1871856095', 08:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:22 INFO - '_': '/tools/buildbot/bin/python'} 08:12:22 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/bSwK6hb_QL6rlCam3nPEdA/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:12:23 INFO - mozversion application_buildid: 20160615053002 08:12:23 INFO - mozversion application_changeset: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff 08:12:23 INFO - mozversion application_display_name: Nightly 08:12:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:23 INFO - mozversion application_name: Firefox 08:12:23 INFO - mozversion application_remotingname: firefox 08:12:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:23 INFO - mozversion application_vendor: Mozilla 08:12:23 INFO - mozversion application_version: 50.0a1 08:12:23 INFO - mozversion platform_buildid: 20160615053002 08:12:23 INFO - mozversion platform_changeset: bac29d6a5639cca45c7bfb6a51ade60d1a19f4ff 08:12:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:23 INFO - mozversion platform_version: 50.0a1 08:12:23 INFO - using testdate: 1466003543 08:12:23 INFO - actual date: 1466003543 08:12:23 INFO - starting webserver on 'localhost:37385' 08:12:23 INFO - SUITE-START | Running 2 tests 08:12:23 INFO - TEST-START | dromaeo_css 08:12:23 INFO - operating with platform_type : linux_ 08:12:23 INFO - Initialising browser for dromaeo_css test... 08:12:23 INFO - TEST-INFO | started process 14080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpchCJ3s/profile http://localhost:37385/getInfo.html) 08:12:27 INFO - PROCESS | 14080 | __metrics Screen width/height:1600/1200 08:12:27 INFO - PROCESS | 14080 | colorDepth:24 08:12:27 INFO - PROCESS | 14080 | Browser inner width/height: 1024/697 08:12:27 INFO - PROCESS | 14080 | __metrics 08:12:28 ERROR - PROCESS | 14080 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:12:29 INFO - TEST-INFO | 14080: exit 0 08:12:29 INFO - Browser initialized. 08:12:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:29 INFO - TEST-INFO | started process 14199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpchCJ3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:41 INFO - PROCESS | 14199 | RSS: Main: 184655872 08:12:41 INFO - PROCESS | 14199 | 08:13:31 INFO - PROCESS | 14199 | 1466003611016 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:15:39 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:37385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37385/tests/dromaeo/cssquery-ext.html) 08:15:40 INFO - PROCESS | 14199 | RSS: Main: 189386752 08:15:40 INFO - PROCESS | 14199 | 08:18:42 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:37385/tests/dromaeo/cssquery-ext.html (next: http://localhost:37385/tests/dromaeo/cssquery-jquery.html) 08:18:42 INFO - PROCESS | 14199 | RSS: Main: 188334080 08:18:42 INFO - PROCESS | 14199 | 08:21:44 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:37385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37385/tests/dromaeo/cssquery-mootools.html) 08:21:45 INFO - PROCESS | 14199 | RSS: Main: 189820928 08:21:45 INFO - PROCESS | 14199 | 08:24:47 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:37385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37385/tests/dromaeo/cssquery-prototype.html) 08:24:47 INFO - PROCESS | 14199 | RSS: Main: 186908672 08:24:47 INFO - PROCESS | 14199 | 08:27:50 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:37385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37385/tests/dromaeo/cssquery-yui.html) 08:27:50 INFO - PROCESS | 14199 | RSS: Main: 189128704 08:27:50 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:37385/tests/dromaeo/cssquery-yui.html (next: http://localhost:37385/tests/dromaeo/cssquery-dojo.html) 08:30:53 INFO - PROCESS | 14199 | RSS: Main: 189788160 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | __start_tp_report 08:30:53 INFO - PROCESS | 14199 | _x_x_mozilla_page_load 08:30:53 INFO - PROCESS | 14199 | _x_x_mozilla_page_load_details 08:30:53 INFO - PROCESS | 14199 | |i|pagename|runs| 08:30:53 INFO - PROCESS | 14199 | |0;dojo.html;3087;3096.7832251742357;3125.062481255623;3135.6394014688312;3140.5289206619004;5275.920861187081;5279.260903473512;5283.550898173655;5305.681659100456;5326.786928522854;5255.08036093683;5334.226537152111;5349.3045904032515;5360.973195134019;5377.7580008899595;4789.616830653539;4809.254565542346;4895.975520122394;4948.05986862495;4998.875028124307;4839.056384005103;4996.7001979881325;4997.6501644884875;5027.824026159085;5033.094043072246;4749.07393058352;4775.355327030841;4809.975950120262;4886.34034405356;4891.48639392864;4855.344528488679;4869.123557759602;4872.6832755870755;4888;4899.750563606293;4789.712617242976;4795.568398844121;4828.855134345975;4831.130396528623;4875.098106850244;5208.296879921238;5233.267342572043;5268.683878967274;5327.227552004976;5339.439358867341;5695.943040569624;5746.54027677789;5751.683657398841;5757.798477053325;5762.740676669518;5726.141078838166;5788.855278618026;5789.565782566282;5790.71046447676;5791.971040144815;5191.922121168185;5195.714235717034;5241.973790131063;5248.134057880445;5312.495312945264;5759.280089988752;5821.912671309934;5825.941740582624;5833.795817146464;5837.29952405714;5443.2107344434835;5555.2222688822785;5562.582806289544;5567.2762540870235;5584;5509.862253443696;5517.586181036439;5557.277553917965;5573.888522229614;5575.470330318613;5537.612367134262;5556.861078473071;5571.220029195916;5580.079286917613;5584.190292407578;5565.805196818092;5645.689487078168;5653.9151912721345;5654.717264136777;5695.003374409462;4374.715643483227;4416.779161041935;4447.977760111179;4454.933176002362;4459.264221403432;3933.2920074386884;3945.506811648544;3947.032976920673;3957.52509698838;3976.5228172619472;5467.1799230115;5492.340919089735;5495.148252020863;5509.47659972302;5525.088360420566;5674.319081710139;5686.886262274731;5705.087186050212;5712.057510510719;5751.1373294006235;5484.972575137099;5522.199281104217;5530.474604912527;5530.917036244459;5537.141743029837;4916.287138364917;4952.479989601112;4962.106820772224;4999.425066117443;5009.0482808266315;6002.369751176151;6010.729517171738;6025.457708806229;6033.336333003366;6038.064100064497;5706.486416222477;5757.568182386254;5759.337676167294;5765.625234359753;5767.307923049261;5897.115432685132;5942.049272116441;5963.463288304073;5970.164177015308;6035.336113027475;5551.916721249266;5572.832815015556;5578.609497335147;5582.27430434041;5608.2148499209325;5588.692621905834;5673.347565030074;5693.857653558694;5701.600887937971;5709.7430615623225;5495.890082198253;5539.113741801292;5552.500274975271;5576.079946808731;5601.243832082617;5441.129419292894;5446.046941785093;5487.478689524489;5526.972365138148;5534.252875861707;5378.97310513445;5390.460953904578;5432.972835135799;5442;5472.5348345391085;5442.401335852974;5479.671219726829;5505.476979686923;5587.832365029056;5590.608657393944;5434.076207044733;5453.7818487260065;5477.890442191214;5480.040992826319;5497.5601951842955 08:30:53 INFO - PROCESS | 14199 | |1;ext.html;590.669225233869;634.8984162533994;637.5250438423373;652.4877970792928;656.8784774816658;38362.42456363153;41855;42086.789566052204;42189.57810421895;42379;41431.17137657245;41780.16439671205;42116.789416052874;42139.57860421395;42249.57750422495;8694.869576956351;8818.823623527525;8841.823163536725;8865.95567022164;8872.20150186483;8662.783430414258;8693.913060869405;8763.211310982011;8764.25503832175;8799.252063574604;8801.911980880206;8885.4668719877;8957.552122393887;8971.282297416192;8981.820363592724;8790.252828509585;8803.823923521557;8816.955915220447;8877.511736854503;8914.732558023237;8553.230209281195;8626.698065567674;8684.565771711452;8702.695405660772;8737.126287371275;40741.59258407437;40934.38598421026;41135.7943210285;41369.1726165475;41518;2942.5733268676136;3370.9494357584654;3420.8289585520874;3427.7600567960253;3457.343104810078;30055;30175.245618859484;30226.244343891358;30270.84864575685;30453.23866903323;4163.687723420725;4212.010177608259;4259.318509038539;4341.782910854445;4399.032212913154;281791;282207;285059;285428;286738;33802.32395352079;33965.32069358599;34030.31939361248;34063.489047664305;34105;34622.82688586541;35310.47034294488;35416.29167416689;35463.936081917585;35533.46699799505;16963.406280780113;16984.915075424542;17046.403375881786;17153.485395438158;17189.57026074358;12454.065945054157;12686.682832929066;12731.10882238253;12842.293673848028;12865.4210560525;19205.61588768217;19283.421497355102;19285.517862053563;19427.902860485607;19443.8055619442;7151.642417879085;7158.391536719333;7289.380402665727;7410.888836667455;7524.623768811538;998.9600415983425;1078.7109404261832;1102.5699977008974;1116.8771435142128;1123.5112725964232;32846.507302390484;32889.67110328914;32991.340173196404;32999.3400131996;33674.663253367646;1096.369587487198;1101.8898110188918;1126.6394753678908;1169.3217933598492;1174.5947648061406;16683.416080437128;17350.826491734922;17743;18636.72044919327;19111.80888191128;461876;473256;474113;475622;475913;60145.097823532684;62096.37903620996;62275;62396.37603623996;62435;1338.3375229261578;1393.1432169216062;1418.1278513713992;1427.3719563392074;1430.3205977160765;32385;33676.49485257772;34390;34530.65469345274;35058;52639.47360526499;52726;53234.20148697695;53324.200136998756;53513.732431337594;461920;465320;467320;467571;467794;44640.55359446364;44887;46120.07759844717;46223.76888115538;46411.53588464072;47877.5212247887;49019.50980490149;49222.50777492179;50121;50253.748731256106;41735.7913210432;42201.78899105608;42681.78659106685;42754.358684620376;43017.569824302605;40393.798031009654;40727.59272407238;40823.59176408198;41863.58136418597;41931.580684193985;39770.2045959085;41638;41706;42153.36769948392;42262;31961.840190798895;34132.658673412945;34358.82820585981;34910.65089349176;35052.47421288734;27988.440231194854;28104.578431323138;28311.454953830795;28340.40270589748;28460.43079138447 08:30:53 INFO - PROCESS | 14199 | |2;jquery.html;371.5300145316174;377.9565349984749;385.4507327058941;393.21161072050535;396.18781497929257;17563.912180439096;18859.811401885978;19353.129109190086;19440.708389374155;19458.1243844027;17696.38062667807;18438.354657586988;18537.814621853777;18666.906665466653;19375.418737437863;5538.806141785039;5689.9146512802345;5788.594798364116;5788.652680839163;5809.82570522885;5595.076812325961;5740.512056475204;5751.367349591542;5780.50865676418;5792.507636850873;5567.944320556783;5633.690147041911;5664.40523745007;5670.036093864053;5734.197212390269;5597.944020559783;5625.578081643893;5628.127640215753;5638.689872057035;5672.914906276409;4963.379577552806;5092.898142037176;5096.082705113078;5104;5143.305653736773;23099.191528296597;23212.76787232123;23434.17980370679;23534.64698029531;23536.64695029576;2175.510510135223;2607.4002979314864;2912.0681381957784;2913.374086775024;2961.822290662567;14176.645583860383;14280.500182493563;14509.419623215059;14569.271536423243;14610.342534585969;1858.2102606392364;1914.2247389807012;1924.422673198035;1960.0787629814108;1973.289615738333;77276;77490.61254693747;78027.6098619509;78776.60611696962;79057.60471197608;9784.951075244579;9871.210303175729;10652.201084918506;11261.605843795427;11541;14449.34977925996;14562.199079050542;14617.707645847024;14634.414623414945;14658.853411465961;7772.727954521564;7980.122186559473;7992.160823113606;8064.112947575762;8202.466839655523;7795.922040779519;7829.099653539915;7874.330681892104;8019.799505012421;8030.996125484315;6449.6130232186215;6536.150300460909;6589.110470086477;6615.735370585123;6688.598684078971;1867.9906600466911;1945.5719741656812;1952.8730632508841;1975.4764987278384;1980.2574034736974;969.680005598151;1009.8131845608586;1014.5383850348221;1056.9324981768468;1073.8042288471017;19006.90496547536;19966.90016549908;20201.898990504953;20379.184832606825;20654.07056682423;1008.178334657252;1012.3419777144768;1031.3966329697062;1032.700516850105;1048.863647725806;10666.573337066431;11551.364674942959;11644.592439264585;11676.357800321064;11727.941360293144;353281;359528;361204;444705;463032;85441.57279213688;91489;93709.5314523423;96750;102775.48612256891;1013.5084484025242;1042.9634962776267;1051.5268129341828;1065.4140222877386;1067.4342598422847;17559.473215803548;17681.911590441967;17847.643047139245;17932;18102.185401656694;38769;39176.60823391729;40453;42531.36202956896;45398.54601453943;57480.42519574918;58776.4122358788;59020;59386.70306648439;59563.40436595579;7637.770866874002;8604.612792424481;8956.417832841105;8973.820523589622;9005.14451127142;13496.6625834351;13724.451021959409;14092.577222683336;14276.072055316372;14477.855221447651;8064.798380040546;12101.878981210075;12173.330466824409;12384.256944583354;12481.93759031199;12391.876081239072;12425.93787031059;12464.813027804408;12522.123451358317;12690.11169218146;12272.81590776157;12399.75200496003;12485.75028499443;12670.113092083466;12761;7798.532088074734;7989.600519974094;8112.59437028158;8139.389545783972;8158;9144.725658230263;12261.816072759095;12320.260784352968;12490.500379984698;12710.300933448749 08:30:53 INFO - PROCESS | 14199 | |3;mootools.html;1376.3599926034394;1442.8917831162662;1460.9780853287202;1710.5638062294113;1741.9390321338756;7821.413393995459;8248.133945935673;8414.158584141584;8623.611937462822;8682.826343473127;8534.743957681265;8677.956610216956;8707.695230666928;8764.693235736751;8784.78038049049;2221.4113259986075;2279.2592407467555;2298.138198175684;2302.942426439344;2307.307807657696;2228.3760547046854;2234.0728597631964;2288.896999635012;2296.919607813727;2297.8851057447146;2198.8236293582936;2209.2930262316067;2210.4142402263415;2235.8373645704223;2258.469259723972;2140.475583482041;2151.214806595597;2152.2144417287655;2158.978410215909;2163.4266919266406;2181.454636340915;2198.7801219878043;2199.637059885117;2201.7798220178015;2206.9227577034885;8803.823923521557;8846.823063538757;8859.202671759509;8871.645134194625;8923.73228803137;4970.254461830718;5062.544371006627;5063.0380227756605;5065.696058236481;5087.033463641933;3080.2761351082477;3192.952105718416;3259.3318369734147;3295.0444371132344;3320.1533608929567;1084.208527774721;1088.2491081153978;1101.6309536305348;1123.685368096926;1132.3206076354122;12024.699382515508;12103.394830258452;12104;12143.696407589881;12211.26732396059;4447.310666846644;4476.574725401082;4532.184206842734;4566.97716511422;4579.793909274024;10295.588176472857;10313.948430257951;10342.172626189888;10344.689659310232;10345.793084138275;5005.799768009311;5079.923801142986;5091.8981620367385;5156.484351564814;5187.325647665854;4234.745915245096;4454.331850222493;4650.279206722963;4656.045510670305;4688.765561721901;3837.4052021936645;3879.56456111235;3936.4685767421606;3983;4015.277250095011;1172.5309876049648;1215.5198696514826;1217.0324591949422;1217.7686239614445;1220.1458978714936;1004.9397885231006;1026.6201505442884;1036.2746077745608;1044.6239353832614;1050.9579616815242;6151.876962460726;6266.592671476339;6303.936960630335;6312.274088479791;6326.810195694136;448.39466719928487;449.3080655790047;456.4590959712751;462.8727100047514;466.6336925513456;4254.234237837219;4453.599176074169;4480.417545719036;4498.527654596286;4511;10730.517126729159;11071.889281107247;11170.441477926071;11177.049950754114;11225.270357426905;11042.834357484644;11054.668359949215;11070.335779853234;11085.27945683528;11089.889101109047;7784.844303113906;8067.959660201662;8087.110417854032;8103.635336409876;8381.329493640616;5806.361300257053;5938.495227905676;5988.820335389945;6002.759889604367;6016.87966240664;9389.953050234979;9393.765155871159;9489.47807870546;9893.159081478156;9910.950445248016;9765.65820196318;9870.111689947938;10069.748256293651;10128.949355253177;10161.390316581028;7448.329650331496;7661.655225514976;7666.233376662289;7716.5755883426955;7861.921380786119;8500.57497125129;8522.403431759718;8539.444936079135;8543.102974187621;8543.700970466003;7454.1800401956825;7662.578558179131;7721.227877212458;7763.611819408894;7806.648700808364;7451.552906825608;7525;7546.66040028189;7685.193054729173;7807.453478256694;7132.643367831484;7152.320529549685;7156.85686286261;7165.677544510405;7238.23998480152;5297.496737809902;5396.298481197419;5508.091164957737;5511.311086114236;5560.221568980265;5197.298364720715;5398.13629819227;5419.67218031569;5455.1271796512365;5544.0575102231915 08:30:53 INFO - PROCESS | 14199 | |4;prototype.html;319.8113113263174;325.8859399210276;330.32943125455336;330.58841742031177;333.5513734027732;5353.304070470834;5487.807926722566;5577.330720313563;5648.548116150709;5672.404397538256;5512.228288039678;5539.390667026624;5551.195076713874;5551.2228288039705;5567.47109024643;4277.807498662568;4321.6326612238;4321.65426765858;4341.63096136828;4356.215881141393;4086.0397806515443;4284.721493102954;4334.869953901388;4343.587359200887;4361.171377438292;4226;4261.169072030955;4275.2945763949065;4279.379489973952;4308.009157893686;4291.957080429187;4311.417958575599;4325.675574331922;4333.696641235115;4341.630961368256;3751.512303400568;3819.4843696100947;3851.499305090348;3863.5943225961432;3875.379939209741;5383.488568585978;5389.461053894579;5392.78428862845;5395.973020134914;5400.810971615974;4949.554540091373;4952.182889823175;4965.875853103666;4973.204287314049;4978.477259887696;5483.327585086547;5799.420057994209;5800.433882851648;5844.561657875676;5870.383609721003;4146.523149837747;4148;4160.791960401968;4173.4157217989505;4176.979115104436;5970.194023806774;6068.150458935753;6104.2980057293535;6121.357257487989;6124.387561243884;4193.496780386312;4230.767307798101;4252.510961239435;4333.761643109659;4345.239583072949;4313.741175529478;4334.631556317685;4345.674569256407;4358.476982762026;4366.6506679465565;4890.217565189552;4938.703677779345;4963.379577552806;4972;4983.651144419929;5731.598788084877;5870.53035757147;5874.236349274567;5876.7355469004;5889.4392985858785;1497.9700405991819;1505.5633866178905;1520.2626726037863;1520.8479152084703;1526.5267766992267;974.8196583631909;976.3556053005125;977.4379731654327;984.2224642532319;990.7862867986659;5038.916632923939;5047.697138171648;5069.239614057847;5071;5088.236764485357;5258.002938325118;5258.526732594085;5280.6039547034125;5311.681299122065;5315.617939335723;4944.579710724557;5123.487651234846;5125.33370661819;5138.766695993009;5143.434222235551;2847.957280640792;2865.2407112115307;2877.223149749556;2882.6252587163535;2888.8155856098897;5504.605496608988;5524.8066317679495;5550.223928342892;5556.499915007668;5559.777608895599;5115.283860259567;5312.787488500494;5387.973060134675;5391.919121213185;5446.727663616883;5497.8075767347955;5510.256115424447;5525.557955363562;5544.473275038865;5551.361593416808;5247.947520524746;5312;5319.494648008588;5363.103923881061;5475.233467314659;5884.235049443545;5916.319623243382;5933.881322373615;5954.642721436728;5971.731272092853;6031.215941927697;6125.938740612537;6199.94600917836;6254.530910181664;6308.52686048539;4097.549269580403;4242.257604919188;4249.277622804069;4271.337942618899;4283.7429754214845;5921.970390148022;5963.2844058713235;5996.190514280516;6042.851858146938;6050.273967123973;5708.714564271687;5801.535877129904;5807.854803629774;5820.8649313383485;5879.853003674943;5668.489835914787;5713.8285851424525;5752.9712351437975;5781.190633311256;5800.187973683772;5660.462256085665;5662.631928924771;5673.404292549223;5676.864627074519;5701.629394089371;5582.27430434041;5809.883802324014;5839.416058394127;5852.736626851887;5897.203877476486;5658.745356458887;5662.282104589737;5726.649909802645;5733.512651424676;5739 08:30:53 INFO - PROCESS | 14199 | |5;yui.html;612.3233826621583;640.2828831708487;693.0678237770197;767.9961600191998;771.7723271634867;15283.770743438843;15900.443484478046;16124.999999999985;16134;16210.513684589481;14186.361613727382;15226.390944362212;15298;15326.310316035777;15399;790.7390561114819;790.8932294140303;792.6512334572799;803.1526739290047;812.695239285268;791.2443616346404;795.8647030004884;799.5242830515863;799.8240387114826;800.5756948817136;829.9170082991712;833.3832963606917;835.3901651794193;837.7151768398743;838.8154605986704;814.5153633588005;828.9046759622661;831.7089018843386;833.2001278772386;834.0325222741621;608.695652173913;609.4941198804981;610.1518888744648;610.8900397928371;613.6011592464889;14808.111513309235;14996.850031499655;15030.17334046627;15209.239538023054;15237.238138093162;14031.929840350835;14209.218492982882;14289.785653215211;14466.49367272151;14577.344019519147;12218.511259549607;12293.56972505967;12456.688582785413;12488.875111248954;12581.37093145339;3794.146317078663;3926.8625598104213;3942.6254505821903;3979.801009949491;3982.2433737590054;55964.72017639926;56674;56994;57073.429265707644;57248.42751572514;10720.785584288271;10920.2901811382;11005.724856878482;11355.659330220107;11372.260803047775;21071.473213169487;21159.259425920325;21162.153513859583;21244.57510849805;21280.148794048066;8170.959145204355;8483.363747718822;8505.149485051445;8609.096044915319;8711.433756805787;4991.401031876126;4996.525330093708;5070.188769796889;5082.542571168613;5185.792568297301;3607.603163651996;3680.2271522980473;3704.6110158432975;3722.553293604785;3724.329620668306;652.2238536142071;662.2648859765657;666.9333066693389;673.8618583190434;698.0262533765369;576.9884602307931;615.3692465223093;634.9776859256593;663.5468324369712;702.950793444454;9532.380395274286;9638.9036109638;9655.951720241354;9914.603415863285;10011.599536018477;732.9926700733031;760.179370407881;765.6745882999703;766.8581312457213;769.1616138409161;4287.978560107242;4313.870583882489;4392.1874453226255;4406.854217903368;4408.228560001987;127876;127962;128398;129100;131452;108933;109218.44689318666;109324;109614.45192773985;109875;59095.70452147798;63257.68371158207;94676.52661736647;96733.51633241789;97126;8109.148539403278;8148.633311500878;8224.671013159406;8268.958655206685;8322.807157136805;38456.2308753829;43215.78392108019;53221.733891330296;53656.46343536515;56435.43564564466;75044.62477687576;82425.58787206025;83135.75296370438;83494.16505835106;86023;11408.372539510407;11598.246114002563;11696.35670038156;12052.457639406422;12431.316277604457;14871.256437178314;15029.323680434189;15278;15603.765943511084;15807.604809879846;13568.59294221175;13884.652883677585;14324.498642547462;14359.425622974964;14588.416463341347;12462;12849.164804287691;13415;13813.51652692151;14744.705105897607;13139.60581182566;13605.659858503617;14086.15483071019;14224.715505690036;14310.928445357707;11229.66311010671;11580.768384632092;11637.301761894314;11765.352905590275;11909.225900316798;10918.454077296263;11003.61487347939;11512.82730759056;11751;12153.635390938285 08:30:53 INFO - PROCESS | 14199 | __end_tp_report 08:30:53 INFO - PROCESS | 14199 | __start_cc_report 08:30:53 INFO - PROCESS | 14199 | _x_x_mozilla_cycle_collect,358 08:30:53 INFO - PROCESS | 14199 | __end_cc_report 08:30:53 INFO - PROCESS | 14199 | __startTimestamp1466004653939__endTimestamp 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | ------- Summary: start ------- 08:30:53 INFO - PROCESS | 14199 | Number of tests: 6 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | [#0] dojo.html Cycles:165 Average:5297.00 Median:5492.34 stddev:585.13 (10.7%) stddev-sans-first:560.65 08:30:53 INFO - PROCESS | 14199 | Values: 3087.0 3096.8 3125.1 3135.6 3140.5 5275.9 5279.3 5283.6 5305.7 5326.8 5255.1 5334.2 5349.3 5361.0 5377.8 4789.6 4809.3 4896.0 4948.1 4998.9 4839.1 4996.7 4997.7 5027.8 5033.1 4749.1 4775.4 4810.0 4886.3 4891.5 4855.3 4869.1 4872.7 4888.0 4899.8 4789.7 4795.6 4828.9 4831.1 4875.1 5208.3 5233.3 5268.7 5327.2 5339.4 5695.9 5746.5 5751.7 5757.8 5762.7 5726.1 5788.9 5789.6 5790.7 5792.0 5191.9 5195.7 5242.0 5248.1 5312.5 5759.3 5821.9 5825.9 5833.8 5837.3 5443.2 5555.2 5562.6 5567.3 5584.0 5509.9 5517.6 5557.3 5573.9 5575.5 5537.6 5556.9 5571.2 5580.1 5584.2 5565.8 5645.7 5653.9 5654.7 5695.0 4374.7 4416.8 4448.0 4454.9 4459.3 3933.3 3945.5 3947.0 3957.5 3976.5 5467.2 5492.3 5495.1 5509.5 5525.1 5674.3 5686.9 5705.1 5712.1 5751.1 5485.0 5522.2 5530.5 5530.9 5537.1 4916.3 4952.5 4962.1 4999.4 5009.0 6002.4 6010.7 6025.5 6033.3 6038.1 5706.5 5757.6 5759.3 5765.6 5767.3 5897.1 5942.0 5963.5 5970.2 6035.3 5551.9 5572.8 5578.6 5582.3 5608.2 5588.7 5673.3 5693.9 5701.6 5709.7 5495.9 5539.1 5552.5 5576.1 5601.2 5441.1 5446.0 5487.5 5527.0 5534.3 5379.0 5390.5 5433.0 5442.0 5472.5 5442.4 5479.7 5505.5 5587.8 5590.6 5434.1 5453.8 5477.9 5480.0 5497.6 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | [#1] ext.html Cycles:180 Average:56693.16 Median:22900.84 stddev:110344.27 (481.8%) stddev-sans-first:110573.41 08:30:53 INFO - PROCESS | 14199 | Values: 590.7 634.9 637.5 652.5 656.9 38362.4 41855.0 42086.8 42189.6 42379.0 41431.2 41780.2 42116.8 42139.6 42249.6 8694.9 8818.8 8841.8 8866.0 8872.2 8662.8 8693.9 8763.2 8764.3 8799.3 8801.9 8885.5 8957.6 8971.3 8981.8 8790.3 8803.8 8817.0 8877.5 8914.7 8553.2 8626.7 8684.6 8702.7 8737.1 40741.6 40934.4 41135.8 41369.2 41518.0 2942.6 3370.9 3420.8 3427.8 3457.3 30055.0 30175.2 30226.2 30270.8 30453.2 4163.7 4212.0 4259.3 4341.8 4399.0 281791.0 282207.0 285059.0 285428.0 286738.0 33802.3 33965.3 34030.3 34063.5 34105.0 34622.8 35310.5 35416.3 35463.9 35533.5 16963.4 16984.9 17046.4 17153.5 17189.6 12454.1 12686.7 12731.1 12842.3 12865.4 19205.6 19283.4 19285.5 19427.9 19443.8 7151.6 7158.4 7289.4 7410.9 7524.6 999.0 1078.7 1102.6 1116.9 1123.5 32846.5 32889.7 32991.3 32999.3 33674.7 1096.4 1101.9 1126.6 1169.3 1174.6 16683.4 17350.8 17743.0 18636.7 19111.8 461876.0 473256.0 474113.0 475622.0 475913.0 60145.1 62096.4 62275.0 62396.4 62435.0 1338.3 1393.1 1418.1 1427.4 1430.3 32385.0 33676.5 34390.0 34530.7 35058.0 52639.5 52726.0 53234.2 53324.2 53513.7 461920.0 465320.0 467320.0 467571.0 467794.0 44640.6 44887.0 46120.1 46223.8 46411.5 47877.5 49019.5 49222.5 50121.0 50253.7 41735.8 42201.8 42681.8 42754.4 43017.6 40393.8 40727.6 40823.6 41863.6 41931.6 39770.2 41638.0 41706.0 42153.4 42262.0 31961.8 34132.7 34358.8 34910.7 35052.5 27988.4 28104.6 28311.5 28340.4 28460.4 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | [#2] jquery.html Cycles:180 Average:26603.58 Median:23535.65 stddev:66415.18 (282.2%) stddev-sans-first:66572.29 08:30:53 INFO - PROCESS | 14199 | Values: 371.5 378.0 385.5 393.2 396.2 17563.9 18859.8 19353.1 19440.7 19458.1 17696.4 18438.4 18537.8 18666.9 19375.4 5538.8 5689.9 5788.6 5788.7 5809.8 5595.1 5740.5 5751.4 5780.5 5792.5 5567.9 5633.7 5664.4 5670.0 5734.2 5597.9 5625.6 5628.1 5638.7 5672.9 4963.4 5092.9 5096.1 5104.0 5143.3 23099.2 23212.8 23434.2 23534.6 23536.6 2175.5 2607.4 2912.1 2913.4 2961.8 14176.6 14280.5 14509.4 14569.3 14610.3 1858.2 1914.2 1924.4 1960.1 1973.3 77276.0 77490.6 78027.6 78776.6 79057.6 9785.0 9871.2 10652.2 11261.6 11541.0 14449.3 14562.2 14617.7 14634.4 14658.9 7772.7 7980.1 7992.2 8064.1 8202.5 7795.9 7829.1 7874.3 8019.8 8031.0 6449.6 6536.2 6589.1 6615.7 6688.6 1868.0 1945.6 1952.9 1975.5 1980.3 969.7 1009.8 1014.5 1056.9 1073.8 19006.9 19966.9 20201.9 20379.2 20654.1 1008.2 1012.3 1031.4 1032.7 1048.9 10666.6 11551.4 11644.6 11676.4 11727.9 353281.0 359528.0 361204.0 444705.0 463032.0 85441.6 91489.0 93709.5 96750.0 102775.5 1013.5 1043.0 1051.5 1065.4 1067.4 17559.5 17681.9 17847.6 17932.0 18102.2 38769.0 39176.6 40453.0 42531.4 45398.5 57480.4 58776.4 59020.0 59386.7 59563.4 7637.8 8604.6 8956.4 8973.8 9005.1 13496.7 13724.5 14092.6 14276.1 14477.9 8064.8 12101.9 12173.3 12384.3 12481.9 12391.9 12425.9 12464.8 12522.1 12690.1 12272.8 12399.8 12485.8 12670.1 12761.0 7798.5 7989.6 8112.6 8139.4 8158.0 9144.7 12261.8 12320.3 12490.5 12710.3 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | [#3] mootools.html Cycles:180 Average:5756.21 Median:2511.72 stddev:3304.11 (131.5%) stddev-sans-first:3296.98 08:30:53 INFO - PROCESS | 14199 | Values: 1376.4 1442.9 1461.0 1710.6 1741.9 7821.4 8248.1 8414.2 8623.6 8682.8 8534.7 8678.0 8707.7 8764.7 8784.8 2221.4 2279.3 2298.1 2302.9 2307.3 2228.4 2234.1 2288.9 2296.9 2297.9 2198.8 2209.3 2210.4 2235.8 2258.5 2140.5 2151.2 2152.2 2159.0 2163.4 2181.5 2198.8 2199.6 2201.8 2206.9 8803.8 8846.8 8859.2 8871.6 8923.7 4970.3 5062.5 5063.0 5065.7 5087.0 3080.3 3193.0 3259.3 3295.0 3320.2 1084.2 1088.2 1101.6 1123.7 1132.3 12024.7 12103.4 12104.0 12143.7 12211.3 4447.3 4476.6 4532.2 4567.0 4579.8 10295.6 10313.9 10342.2 10344.7 10345.8 5005.8 5079.9 5091.9 5156.5 5187.3 4234.7 4454.3 4650.3 4656.0 4688.8 3837.4 3879.6 3936.5 3983.0 4015.3 1172.5 1215.5 1217.0 1217.8 1220.1 1004.9 1026.6 1036.3 1044.6 1051.0 6151.9 6266.6 6303.9 6312.3 6326.8 448.4 449.3 456.5 462.9 466.6 4254.2 4453.6 4480.4 4498.5 4511.0 10730.5 11071.9 11170.4 11177.0 11225.3 11042.8 11054.7 11070.3 11085.3 11089.9 7784.8 8068.0 8087.1 8103.6 8381.3 5806.4 5938.5 5988.8 6002.8 6016.9 9390.0 9393.8 9489.5 9893.2 9911.0 9765.7 9870.1 10069.7 10128.9 10161.4 7448.3 7661.7 7666.2 7716.6 7861.9 8500.6 8522.4 8539.4 8543.1 8543.7 7454.2 7662.6 7721.2 7763.6 7806.6 7451.6 7525.0 7546.7 7685.2 7807.5 7132.6 7152.3 7156.9 7165.7 7238.2 5297.5 5396.3 5508.1 5511.3 5560.2 5197.3 5398.1 5419.7 5455.1 5544.1 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | [#4] prototype.html Cycles:180 Average:4773.04 Median:5358.20 stddev:1384.92 (25.8%) stddev-sans-first:1347.87 08:30:53 INFO - PROCESS | 14199 | Values: 319.8 325.9 330.3 330.6 333.6 5353.3 5487.8 5577.3 5648.5 5672.4 5512.2 5539.4 5551.2 5551.2 5567.5 4277.8 4321.6 4321.7 4341.6 4356.2 4086.0 4284.7 4334.9 4343.6 4361.2 4226.0 4261.2 4275.3 4279.4 4308.0 4292.0 4311.4 4325.7 4333.7 4341.6 3751.5 3819.5 3851.5 3863.6 3875.4 5383.5 5389.5 5392.8 5396.0 5400.8 4949.6 4952.2 4965.9 4973.2 4978.5 5483.3 5799.4 5800.4 5844.6 5870.4 4146.5 4148.0 4160.8 4173.4 4177.0 5970.2 6068.2 6104.3 6121.4 6124.4 4193.5 4230.8 4252.5 4333.8 4345.2 4313.7 4334.6 4345.7 4358.5 4366.7 4890.2 4938.7 4963.4 4972.0 4983.7 5731.6 5870.5 5874.2 5876.7 5889.4 1498.0 1505.6 1520.3 1520.8 1526.5 974.8 976.4 977.4 984.2 990.8 5038.9 5047.7 5069.2 5071.0 5088.2 5258.0 5258.5 5280.6 5311.7 5315.6 4944.6 5123.5 5125.3 5138.8 5143.4 2848.0 2865.2 2877.2 2882.6 2888.8 5504.6 5524.8 5550.2 5556.5 5559.8 5115.3 5312.8 5388.0 5391.9 5446.7 5497.8 5510.3 5525.6 5544.5 5551.4 5247.9 5312.0 5319.5 5363.1 5475.2 5884.2 5916.3 5933.9 5954.6 5971.7 6031.2 6125.9 6199.9 6254.5 6308.5 4097.5 4242.3 4249.3 4271.3 4283.7 5922.0 5963.3 5996.2 6042.9 6050.3 5708.7 5801.5 5807.9 5820.9 5879.9 5668.5 5713.8 5753.0 5781.2 5800.2 5660.5 5662.6 5673.4 5676.9 5701.6 5582.3 5809.9 5839.4 5852.7 5897.2 5658.7 5662.3 5726.6 5733.5 5739.0 08:30:53 INFO - PROCESS | 14199 | 08:30:53 INFO - PROCESS | 14199 | [#5] yui.html Cycles:180 Average:20979.34 Median:3981.02 stddev:31440.36 (789.8%) stddev-sans-first:31491.36 08:30:53 INFO - PROCESS | 14199 | Values: 612.3 640.3 693.1 768.0 771.8 15283.8 15900.4 16125.0 16134.0 16210.5 14186.4 15226.4 15298.0 15326.3 15399.0 790.7 790.9 792.7 803.2 812.7 791.2 795.9 799.5 799.8 800.6 829.9 833.4 835.4 837.7 838.8 814.5 828.9 831.7 833.2 834.0 608.7 609.5 610.2 610.9 613.6 14808.1 14996.9 15030.2 15209.2 15237.2 14031.9 14209.2 14289.8 14466.5 14577.3 12218.5 12293.6 12456.7 12488.9 12581.4 3794.1 3926.9 3942.6 3979.8 3982.2 55964.7 56674.0 56994.0 57073.4 57248.4 10720.8 10920.3 11005.7 11355.7 11372.3 21071.5 21159.3 21162.2 21244.6 21280.1 8171.0 8483.4 8505.1 8609.1 8711.4 4991.4 4996.5 5070.2 5082.5 5185.8 3607.6 3680.2 3704.6 3722.6 3724.3 652.2 662.3 666.9 673.9 698.0 577.0 615.4 635.0 663.5 703.0 9532.4 9638.9 9656.0 9914.6 10011.6 733.0 760.2 765.7 766.9 769.2 4288.0 4313.9 4392.2 4406.9 4408.2 127876.0 127962.0 128398.0 129100.0 131452.0 108933.0 109218.4 109324.0 109614.5 109875.0 59095.7 63257.7 94676.5 96733.5 97126.0 8109.1 8148.6 8224.7 8269.0 8322.8 38456.2 43215.8 53221.7 53656.5 56435.4 75044.6 82425.6 83135.8 83494.2 86023.0 11408.4 11598.2 11696.4 12052.5 12431.3 14871.3 15029.3 15278.0 15603.8 15807.6 13568.6 13884.7 14324.5 14359.4 14588.4 12462.0 12849.2 13415.0 13813.5 14744.7 13139.6 13605.7 14086.2 14224.7 14310.9 11229.7 11580.8 11637.3 11765.4 11909.2 10918.5 11003.6 11512.8 11751.0 12153.6 08:30:53 INFO - PROCESS | 14199 | -------- Summary: end -------- 08:30:53 INFO - PROCESS | 14199 | 08:30:54 INFO - TEST-INFO | 14199: exit 0 08:30:54 INFO - TEST-OK | dromaeo_css | took 1111603ms 08:30:54 INFO - TEST-START | kraken 08:30:54 INFO - operating with platform_type : linux_ 08:30:54 INFO - Initialising browser for kraken test... 08:30:54 INFO - TEST-INFO | started process 14438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65SrmI/profile http://localhost:37385/getInfo.html) 08:30:59 INFO - PROCESS | 14438 | __metrics Screen width/height:1600/1200 08:30:59 INFO - PROCESS | 14438 | colorDepth:24 08:30:59 INFO - PROCESS | 14438 | Browser inner width/height: 1024/697 08:30:59 INFO - PROCESS | 14438 | __metrics 08:31:00 ERROR - PROCESS | 14438 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:31:00 INFO - TEST-INFO | 14438: exit 0 08:31:00 INFO - Browser initialized. 08:31:00 INFO - Running cycle 1/1 for kraken test... 08:31:00 INFO - TEST-INFO | started process 14557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65SrmI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:12 INFO - PROCESS | 14557 | RSS: Main: 184774656 08:31:12 INFO - PROCESS | 14557 | 08:31:15 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37385/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:16 INFO - PROCESS | 14557 | RSS: Main: 190537728 08:31:16 INFO - PROCESS | 14557 | 08:31:19 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37385/tests/kraken/driver.html?testName=audio-dft) 08:31:19 INFO - PROCESS | 14557 | RSS: Main: 189267968 08:31:19 INFO - PROCESS | 14557 | 08:31:22 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37385/tests/kraken/driver.html?testName=audio-fft) 08:31:23 INFO - PROCESS | 14557 | RSS: Main: 184385536 08:31:23 INFO - PROCESS | 14557 | 08:31:25 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37385/tests/kraken/driver.html?testName=audio-oscillator) 08:31:26 INFO - PROCESS | 14557 | RSS: Main: 185421824 08:31:26 INFO - PROCESS | 14557 | 08:31:28 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:28 INFO - PROCESS | 14557 | RSS: Main: 185856000 08:31:28 INFO - PROCESS | 14557 | 08:31:31 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37385/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:32 INFO - PROCESS | 14557 | RSS: Main: 186212352 08:31:32 INFO - PROCESS | 14557 | 08:31:36 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37385/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:36 INFO - PROCESS | 14557 | RSS: Main: 183357440 08:31:36 INFO - PROCESS | 14557 | 08:31:39 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37385/tests/kraken/driver.html?testName=json-parse-financial) 08:31:40 INFO - PROCESS | 14557 | RSS: Main: 185077760 08:31:40 INFO - PROCESS | 14557 | 08:31:41 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:42 INFO - PROCESS | 14557 | RSS: Main: 185491456 08:31:42 INFO - PROCESS | 14557 | 08:31:44 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:44 INFO - PROCESS | 14557 | RSS: Main: 185462784 08:31:44 INFO - PROCESS | 14557 | 08:31:46 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:47 INFO - PROCESS | 14557 | RSS: Main: 185335808 08:31:47 INFO - PROCESS | 14557 | 08:31:50 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:50 INFO - PROCESS | 14557 | RSS: Main: 186380288 08:31:50 INFO - PROCESS | 14557 | 08:31:53 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:54 INFO - PROCESS | 14557 | RSS: Main: 185778176 08:31:54 INFO - PROCESS | 14557 | 08:31:55 INFO - PROCESS | 14557 | Cycle 1(1): loaded http://localhost:37385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37385/tests/kraken/driver.html?testName=ai-astar) 08:31:56 INFO - PROCESS | 14557 | RSS: Main: 186888192 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | __start_tp_report 08:31:56 INFO - PROCESS | 14557 | _x_x_mozilla_page_load 08:31:56 INFO - PROCESS | 14557 | _x_x_mozilla_page_load_details 08:31:56 INFO - PROCESS | 14557 | |i|pagename|runs| 08:31:56 INFO - PROCESS | 14557 | |0;ai-astar;112;106;114;111;113;112;111;113;112;112 08:31:56 INFO - PROCESS | 14557 | |1;audio-beat-detection;158;130;151;181;128;150;156;132;192;128 08:31:56 INFO - PROCESS | 14557 | |2;audio-dft;164;163;163;170;165;170;165;164;161;162 08:31:56 INFO - PROCESS | 14557 | |3;audio-fft;75;74;75;173;76;78;73;75;165;75 08:31:56 INFO - PROCESS | 14557 | |4;audio-oscillator;85;85;158;84;86;85;148;85;86;143 08:31:56 INFO - PROCESS | 14557 | |5;imaging-gaussian-blur;118;118;117;121;118;119;119;119;118;118 08:31:56 INFO - PROCESS | 14557 | |6;imaging-darkroom;147;146;148;146;147;147;147;149;149;147 08:31:56 INFO - PROCESS | 14557 | |7;imaging-desaturate;98;96;95;96;96;96;96;96;96;95 08:31:56 INFO - PROCESS | 14557 | |8;json-parse-financial;56;56;56;57;61;55;56;57;56;55 08:31:56 INFO - PROCESS | 14557 | |9;json-stringify-tinderbox;66;64;64;65;64;63;66;63;65;64 08:31:56 INFO - PROCESS | 14557 | |10;stanford-crypto-aes;84;81;81;83;81;82;80;84;103;80 08:31:56 INFO - PROCESS | 14557 | |11;stanford-crypto-ccm;134;142;124;121;123;132;133;124;143;124 08:31:56 INFO - PROCESS | 14557 | |12;stanford-crypto-pbkdf2;164;164;164;161;167;165;161;168;164;164 08:31:56 INFO - PROCESS | 14557 | |13;stanford-crypto-sha256-iterative;65;65;69;65;63;64;63;64;68;63 08:31:56 INFO - PROCESS | 14557 | __end_tp_report 08:31:56 INFO - PROCESS | 14557 | __start_cc_report 08:31:56 INFO - PROCESS | 14557 | _x_x_mozilla_cycle_collect,900 08:31:56 INFO - PROCESS | 14557 | __end_cc_report 08:31:56 INFO - PROCESS | 14557 | __startTimestamp1466004716196__endTimestamp 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | ------- Summary: start ------- 08:31:56 INFO - PROCESS | 14557 | Number of tests: 14 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.17 (1.9%) stddev-sans-first:2.30 08:31:56 INFO - PROCESS | 14557 | Values: 112.0 106.0 114.0 111.0 113.0 112.0 111.0 113.0 112.0 112.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:153.50 stddev:22.40 (14.6%) stddev-sans-first:23.59 08:31:56 INFO - PROCESS | 14557 | Values: 158.0 130.0 151.0 181.0 128.0 150.0 156.0 132.0 192.0 128.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.06 (1.9%) stddev-sans-first:3.23 08:31:56 INFO - PROCESS | 14557 | Values: 164.0 163.0 163.0 170.0 165.0 170.0 165.0 164.0 161.0 162.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.00 stddev:39.65 (52.9%) stddev-sans-first:41.46 08:31:56 INFO - PROCESS | 14557 | Values: 75.0 74.0 75.0 173.0 76.0 78.0 73.0 75.0 165.0 75.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:85.00 stddev:31.38 (36.9%) stddev-sans-first:32.48 08:31:56 INFO - PROCESS | 14557 | Values: 85.0 85.0 158.0 84.0 86.0 85.0 148.0 85.0 86.0 143.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 08:31:56 INFO - PROCESS | 14557 | Values: 118.0 118.0 117.0 121.0 118.0 119.0 119.0 119.0 118.0 118.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 08:31:56 INFO - PROCESS | 14557 | Values: 147.0 146.0 148.0 146.0 147.0 147.0 147.0 149.0 149.0 147.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.44 08:31:56 INFO - PROCESS | 14557 | Values: 98.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:1.72 (3.1%) stddev-sans-first:1.81 08:31:56 INFO - PROCESS | 14557 | Values: 56.0 56.0 56.0 57.0 61.0 55.0 56.0 57.0 56.0 55.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:0.97 08:31:56 INFO - PROCESS | 14557 | Values: 66.0 64.0 64.0 65.0 64.0 63.0 66.0 63.0 65.0 64.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.50 stddev:6.87 (8.4%) stddev-sans-first:7.29 08:31:56 INFO - PROCESS | 14557 | Values: 84.0 81.0 81.0 83.0 81.0 82.0 80.0 84.0 103.0 80.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:132.50 stddev:8.03 (6.1%) stddev-sans-first:8.38 08:31:56 INFO - PROCESS | 14557 | Values: 134.0 142.0 124.0 121.0 123.0 132.0 133.0 124.0 143.0 124.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:2.20 (1.3%) stddev-sans-first:2.33 08:31:56 INFO - PROCESS | 14557 | Values: 164.0 164.0 164.0 161.0 167.0 165.0 161.0 168.0 164.0 164.0 08:31:56 INFO - PROCESS | 14557 | 08:31:56 INFO - PROCESS | 14557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.08 (3.2%) stddev-sans-first:2.20 08:31:56 INFO - PROCESS | 14557 | Values: 65.0 65.0 69.0 65.0 63.0 64.0 63.0 64.0 68.0 63.0 08:31:56 INFO - PROCESS | 14557 | -------- Summary: end -------- 08:31:56 INFO - PROCESS | 14557 | 08:31:57 INFO - TEST-INFO | 14557: exit 0 08:31:57 INFO - TEST-OK | kraken | took 62511ms 08:31:57 INFO - SUITE-END | took 1174s 08:31:57 INFO - Completed test suite (00:19:34) 08:31:57 INFO - javascript benchmark 08:31:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7232.745920362975, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.0, 3096.7832251742357, 3125.062481255623, 3135.6394014688312, 3140.5289206619004, 5275.920861187081, 5279.260903473512, 5283.550898173655, 5305.681659100456, 5326.786928522854, 5255.08036093683, 5334.226537152111, 5349.3045904032515, 5360.973195134019, 5377.7580008899595, 4789.616830653539, 4809.254565542346, 4895.975520122394, 4948.05986862495, 4998.875028124307, 4839.056384005103, 4996.7001979881325, 4997.6501644884875, 5027.824026159085, 5033.094043072246, 4749.07393058352, 4775.355327030841, 4809.975950120262, 4886.34034405356, 4891.48639392864, 4855.344528488679, 4869.123557759602, 4872.6832755870755, 4888.0, 4899.750563606293, 4789.712617242976, 4795.568398844121, 4828.855134345975, 4831.130396528623, 4875.098106850244, 5208.296879921238, 5233.267342572043, 5268.683878967274, 5327.227552004976, 5339.439358867341, 5695.943040569624, 5746.54027677789, 5751.683657398841, 5757.798477053325, 5762.740676669518, 5726.141078838166, 5788.855278618026, 5789.565782566282, 5790.71046447676, 5791.971040144815, 5191.922121168185, 5195.714235717034, 5241.973790131063, 5248.134057880445, 5312.495312945264, 5759.280089988752, 5821.912671309934, 5825.941740582624, 5833.795817146464, 5837.29952405714, 5443.2107344434835, 5555.2222688822785, 5562.582806289544, 5567.2762540870235, 5584.0, 5509.862253443696, 5517.586181036439, 5557.277553917965, 5573.888522229614, 5575.470330318613, 5537.612367134262, 5556.861078473071, 5571.220029195916, 5580.079286917613, 5584.190292407578, 5565.805196818092, 5645.689487078168, 5653.9151912721345, 5654.717264136777, 5695.003374409462, 4374.715643483227, 4416.779161041935, 4447.977760111179, 4454.933176002362, 4459.264221403432, 3933.2920074386884, 3945.506811648544, 3947.032976920673, 3957.52509698838, 3976.5228172619472, 5467.1799230115, 5492.340919089735, 5495.148252020863, 5509.47659972302, 5525.088360420566, 5674.319081710139, 5686.886262274731, 5705.087186050212, 5712.057510510719, 5751.1373294006235, 5484.972575137099, 5522.199281104217, 5530.474604912527, 5530.917036244459, 5537.141743029837, 4916.287138364917, 4952.479989601112, 4962.106820772224, 4999.425066117443, 5009.0482808266315, 6002.369751176151, 6010.729517171738, 6025.457708806229, 6033.336333003366, 6038.064100064497, 5706.486416222477, 5757.568182386254, 5759.337676167294, 5765.625234359753, 5767.307923049261, 5897.115432685132, 5942.049272116441, 5963.463288304073, 5970.164177015308, 6035.336113027475, 5551.916721249266, 5572.832815015556, 5578.609497335147, 5582.27430434041, 5608.2148499209325, 5588.692621905834, 5673.347565030074, 5693.857653558694, 5701.600887937971, 5709.7430615623225, 5495.890082198253, 5539.113741801292, 5552.500274975271, 5576.079946808731, 5601.243832082617, 5441.129419292894, 5446.046941785093, 5487.478689524489, 5526.972365138148, 5534.252875861707, 5378.97310513445, 5390.460953904578, 5432.972835135799, 5442.0, 5472.5348345391085, 5442.401335852974, 5479.671219726829, 5505.476979686923, 5587.832365029056, 5590.608657393944, 5434.076207044733, 5453.7818487260065, 5477.890442191214, 5480.040992826319, 5497.5601951842955], "value": 5258.65893489639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.669225233869, 634.8984162533994, 637.5250438423373, 652.4877970792928, 656.8784774816658, 38362.42456363153, 41855.0, 42086.789566052204, 42189.57810421895, 42379.0, 41431.17137657245, 41780.16439671205, 42116.789416052874, 42139.57860421395, 42249.57750422495, 8694.869576956351, 8818.823623527525, 8841.823163536725, 8865.95567022164, 8872.20150186483, 8662.783430414258, 8693.913060869405, 8763.211310982011, 8764.25503832175, 8799.252063574604, 8801.911980880206, 8885.4668719877, 8957.552122393887, 8971.282297416192, 8981.820363592724, 8790.252828509585, 8803.823923521557, 8816.955915220447, 8877.511736854503, 8914.732558023237, 8553.230209281195, 8626.698065567674, 8684.565771711452, 8702.695405660772, 8737.126287371275, 40741.59258407437, 40934.38598421026, 41135.7943210285, 41369.1726165475, 41518.0, 2942.5733268676136, 3370.9494357584654, 3420.8289585520874, 3427.7600567960253, 3457.343104810078, 30055.0, 30175.245618859484, 30226.244343891358, 30270.84864575685, 30453.23866903323, 4163.687723420725, 4212.010177608259, 4259.318509038539, 4341.782910854445, 4399.032212913154, 281791.0, 282207.0, 285059.0, 285428.0, 286738.0, 33802.32395352079, 33965.32069358599, 34030.31939361248, 34063.489047664305, 34105.0, 34622.82688586541, 35310.47034294488, 35416.29167416689, 35463.936081917585, 35533.46699799505, 16963.406280780113, 16984.915075424542, 17046.403375881786, 17153.485395438158, 17189.57026074358, 12454.065945054157, 12686.682832929066, 12731.10882238253, 12842.293673848028, 12865.4210560525, 19205.61588768217, 19283.421497355102, 19285.517862053563, 19427.902860485607, 19443.8055619442, 7151.642417879085, 7158.391536719333, 7289.380402665727, 7410.888836667455, 7524.623768811538, 998.9600415983425, 1078.7109404261832, 1102.5699977008974, 1116.8771435142128, 1123.5112725964232, 32846.507302390484, 32889.67110328914, 32991.340173196404, 32999.3400131996, 33674.663253367646, 1096.369587487198, 1101.8898110188918, 1126.6394753678908, 1169.3217933598492, 1174.5947648061406, 16683.416080437128, 17350.826491734922, 17743.0, 18636.72044919327, 19111.80888191128, 461876.0, 473256.0, 474113.0, 475622.0, 475913.0, 60145.097823532684, 62096.37903620996, 62275.0, 62396.37603623996, 62435.0, 1338.3375229261578, 1393.1432169216062, 1418.1278513713992, 1427.3719563392074, 1430.3205977160765, 32385.0, 33676.49485257772, 34390.0, 34530.65469345274, 35058.0, 52639.47360526499, 52726.0, 53234.20148697695, 53324.200136998756, 53513.732431337594, 461920.0, 465320.0, 467320.0, 467571.0, 467794.0, 44640.55359446364, 44887.0, 46120.07759844717, 46223.76888115538, 46411.53588464072, 47877.5212247887, 49019.50980490149, 49222.50777492179, 50121.0, 50253.748731256106, 41735.7913210432, 42201.78899105608, 42681.78659106685, 42754.358684620376, 43017.569824302605, 40393.798031009654, 40727.59272407238, 40823.59176408198, 41863.58136418597, 41931.580684193985, 39770.2045959085, 41638.0, 41706.0, 42153.36769948392, 42262.0, 31961.840190798895, 34132.658673412945, 34358.82820585981, 34910.65089349176, 35052.47421288734, 27988.440231194854, 28104.578431323138, 28311.454953830795, 28340.40270589748, 28460.43079138447], "value": 19732.75917450232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5300145316174, 377.9565349984749, 385.4507327058941, 393.21161072050535, 396.18781497929257, 17563.912180439096, 18859.811401885978, 19353.129109190086, 19440.708389374155, 19458.1243844027, 17696.38062667807, 18438.354657586988, 18537.814621853777, 18666.906665466653, 19375.418737437863, 5538.806141785039, 5689.9146512802345, 5788.594798364116, 5788.652680839163, 5809.82570522885, 5595.076812325961, 5740.512056475204, 5751.367349591542, 5780.50865676418, 5792.507636850873, 5567.944320556783, 5633.690147041911, 5664.40523745007, 5670.036093864053, 5734.197212390269, 5597.944020559783, 5625.578081643893, 5628.127640215753, 5638.689872057035, 5672.914906276409, 4963.379577552806, 5092.898142037176, 5096.082705113078, 5104.0, 5143.305653736773, 23099.191528296597, 23212.76787232123, 23434.17980370679, 23534.64698029531, 23536.64695029576, 2175.510510135223, 2607.4002979314864, 2912.0681381957784, 2913.374086775024, 2961.822290662567, 14176.645583860383, 14280.500182493563, 14509.419623215059, 14569.271536423243, 14610.342534585969, 1858.2102606392364, 1914.2247389807012, 1924.422673198035, 1960.0787629814108, 1973.289615738333, 77276.0, 77490.61254693747, 78027.6098619509, 78776.60611696962, 79057.60471197608, 9784.951075244579, 9871.210303175729, 10652.201084918506, 11261.605843795427, 11541.0, 14449.34977925996, 14562.199079050542, 14617.707645847024, 14634.414623414945, 14658.853411465961, 7772.727954521564, 7980.122186559473, 7992.160823113606, 8064.112947575762, 8202.466839655523, 7795.922040779519, 7829.099653539915, 7874.330681892104, 8019.799505012421, 8030.996125484315, 6449.6130232186215, 6536.150300460909, 6589.110470086477, 6615.735370585123, 6688.598684078971, 1867.9906600466911, 1945.5719741656812, 1952.8730632508841, 1975.4764987278384, 1980.2574034736974, 969.680005598151, 1009.8131845608586, 1014.5383850348221, 1056.9324981768468, 1073.8042288471017, 19006.90496547536, 19966.90016549908, 20201.898990504953, 20379.184832606825, 20654.07056682423, 1008.178334657252, 1012.3419777144768, 1031.3966329697062, 1032.700516850105, 1048.863647725806, 10666.573337066431, 11551.364674942959, 11644.592439264585, 11676.357800321064, 11727.941360293144, 353281.0, 359528.0, 361204.0, 444705.0, 463032.0, 85441.57279213688, 91489.0, 93709.5314523423, 96750.0, 102775.48612256891, 1013.5084484025242, 1042.9634962776267, 1051.5268129341828, 1065.4140222877386, 1067.4342598422847, 17559.473215803548, 17681.911590441967, 17847.643047139245, 17932.0, 18102.185401656694, 38769.0, 39176.60823391729, 40453.0, 42531.36202956896, 45398.54601453943, 57480.42519574918, 58776.4122358788, 59020.0, 59386.70306648439, 59563.40436595579, 7637.770866874002, 8604.612792424481, 8956.417832841105, 8973.820523589622, 9005.14451127142, 13496.6625834351, 13724.451021959409, 14092.577222683336, 14276.072055316372, 14477.855221447651, 8064.798380040546, 12101.878981210075, 12173.330466824409, 12384.256944583354, 12481.93759031199, 12391.876081239072, 12425.93787031059, 12464.813027804408, 12522.123451358317, 12690.11169218146, 12272.81590776157, 12399.75200496003, 12485.75028499443, 12670.113092083466, 12761.0, 7798.532088074734, 7989.600519974094, 8112.59437028158, 8139.389545783972, 8158.0, 9144.725658230263, 12261.816072759095, 12320.260784352968, 12490.500379984698, 12710.300933448749], "value": 9391.596022389347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.3599926034394, 1442.8917831162662, 1460.9780853287202, 1710.5638062294113, 1741.9390321338756, 7821.413393995459, 8248.133945935673, 8414.158584141584, 8623.611937462822, 8682.826343473127, 8534.743957681265, 8677.956610216956, 8707.695230666928, 8764.693235736751, 8784.78038049049, 2221.4113259986075, 2279.2592407467555, 2298.138198175684, 2302.942426439344, 2307.307807657696, 2228.3760547046854, 2234.0728597631964, 2288.896999635012, 2296.919607813727, 2297.8851057447146, 2198.8236293582936, 2209.2930262316067, 2210.4142402263415, 2235.8373645704223, 2258.469259723972, 2140.475583482041, 2151.214806595597, 2152.2144417287655, 2158.978410215909, 2163.4266919266406, 2181.454636340915, 2198.7801219878043, 2199.637059885117, 2201.7798220178015, 2206.9227577034885, 8803.823923521557, 8846.823063538757, 8859.202671759509, 8871.645134194625, 8923.73228803137, 4970.254461830718, 5062.544371006627, 5063.0380227756605, 5065.696058236481, 5087.033463641933, 3080.2761351082477, 3192.952105718416, 3259.3318369734147, 3295.0444371132344, 3320.1533608929567, 1084.208527774721, 1088.2491081153978, 1101.6309536305348, 1123.685368096926, 1132.3206076354122, 12024.699382515508, 12103.394830258452, 12104.0, 12143.696407589881, 12211.26732396059, 4447.310666846644, 4476.574725401082, 4532.184206842734, 4566.97716511422, 4579.793909274024, 10295.588176472857, 10313.948430257951, 10342.172626189888, 10344.689659310232, 10345.793084138275, 5005.799768009311, 5079.923801142986, 5091.8981620367385, 5156.484351564814, 5187.325647665854, 4234.745915245096, 4454.331850222493, 4650.279206722963, 4656.045510670305, 4688.765561721901, 3837.4052021936645, 3879.56456111235, 3936.4685767421606, 3983.0, 4015.277250095011, 1172.5309876049648, 1215.5198696514826, 1217.0324591949422, 1217.7686239614445, 1220.1458978714936, 1004.9397885231006, 1026.6201505442884, 1036.2746077745608, 1044.6239353832614, 1050.9579616815242, 6151.876962460726, 6266.592671476339, 6303.936960630335, 6312.274088479791, 6326.810195694136, 448.39466719928487, 449.3080655790047, 456.4590959712751, 462.8727100047514, 466.6336925513456, 4254.234237837219, 4453.599176074169, 4480.417545719036, 4498.527654596286, 4511.0, 10730.517126729159, 11071.889281107247, 11170.441477926071, 11177.049950754114, 11225.270357426905, 11042.834357484644, 11054.668359949215, 11070.335779853234, 11085.27945683528, 11089.889101109047, 7784.844303113906, 8067.959660201662, 8087.110417854032, 8103.635336409876, 8381.329493640616, 5806.361300257053, 5938.495227905676, 5988.820335389945, 6002.759889604367, 6016.87966240664, 9389.953050234979, 9393.765155871159, 9489.47807870546, 9893.159081478156, 9910.950445248016, 9765.65820196318, 9870.111689947938, 10069.748256293651, 10128.949355253177, 10161.390316581028, 7448.329650331496, 7661.655225514976, 7666.233376662289, 7716.5755883426955, 7861.921380786119, 8500.57497125129, 8522.403431759718, 8539.444936079135, 8543.102974187621, 8543.700970466003, 7454.1800401956825, 7662.578558179131, 7721.227877212458, 7763.611819408894, 7806.648700808364, 7451.552906825608, 7525.0, 7546.66040028189, 7685.193054729173, 7807.453478256694, 7132.643367831484, 7152.320529549685, 7156.85686286261, 7165.677544510405, 7238.23998480152, 5297.496737809902, 5396.298481197419, 5508.091164957737, 5511.311086114236, 5560.221568980265, 5197.298364720715, 5398.13629819227, 5419.67218031569, 5455.1271796512365, 5544.0575102231915], "value": 4514.292411684068, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8113113263174, 325.8859399210276, 330.32943125455336, 330.58841742031177, 333.5513734027732, 5353.304070470834, 5487.807926722566, 5577.330720313563, 5648.548116150709, 5672.404397538256, 5512.228288039678, 5539.390667026624, 5551.195076713874, 5551.2228288039705, 5567.47109024643, 4277.807498662568, 4321.6326612238, 4321.65426765858, 4341.63096136828, 4356.215881141393, 4086.0397806515443, 4284.721493102954, 4334.869953901388, 4343.587359200887, 4361.171377438292, 4226.0, 4261.169072030955, 4275.2945763949065, 4279.379489973952, 4308.009157893686, 4291.957080429187, 4311.417958575599, 4325.675574331922, 4333.696641235115, 4341.630961368256, 3751.512303400568, 3819.4843696100947, 3851.499305090348, 3863.5943225961432, 3875.379939209741, 5383.488568585978, 5389.461053894579, 5392.78428862845, 5395.973020134914, 5400.810971615974, 4949.554540091373, 4952.182889823175, 4965.875853103666, 4973.204287314049, 4978.477259887696, 5483.327585086547, 5799.420057994209, 5800.433882851648, 5844.561657875676, 5870.383609721003, 4146.523149837747, 4148.0, 4160.791960401968, 4173.4157217989505, 4176.979115104436, 5970.194023806774, 6068.150458935753, 6104.2980057293535, 6121.357257487989, 6124.387561243884, 4193.496780386312, 4230.767307798101, 4252.510961239435, 4333.761643109659, 4345.239583072949, 4313.741175529478, 4334.631556317685, 4345.674569256407, 4358.476982762026, 4366.6506679465565, 4890.217565189552, 4938.703677779345, 4963.379577552806, 4972.0, 4983.651144419929, 5731.598788084877, 5870.53035757147, 5874.236349274567, 5876.7355469004, 5889.4392985858785, 1497.9700405991819, 1505.5633866178905, 1520.2626726037863, 1520.8479152084703, 1526.5267766992267, 974.8196583631909, 976.3556053005125, 977.4379731654327, 984.2224642532319, 990.7862867986659, 5038.916632923939, 5047.697138171648, 5069.239614057847, 5071.0, 5088.236764485357, 5258.002938325118, 5258.526732594085, 5280.6039547034125, 5311.681299122065, 5315.617939335723, 4944.579710724557, 5123.487651234846, 5125.33370661819, 5138.766695993009, 5143.434222235551, 2847.957280640792, 2865.2407112115307, 2877.223149749556, 2882.6252587163535, 2888.8155856098897, 5504.605496608988, 5524.8066317679495, 5550.223928342892, 5556.499915007668, 5559.777608895599, 5115.283860259567, 5312.787488500494, 5387.973060134675, 5391.919121213185, 5446.727663616883, 5497.8075767347955, 5510.256115424447, 5525.557955363562, 5544.473275038865, 5551.361593416808, 5247.947520524746, 5312.0, 5319.494648008588, 5363.103923881061, 5475.233467314659, 5884.235049443545, 5916.319623243382, 5933.881322373615, 5954.642721436728, 5971.731272092853, 6031.215941927697, 6125.938740612537, 6199.94600917836, 6254.530910181664, 6308.52686048539, 4097.549269580403, 4242.257604919188, 4249.277622804069, 4271.337942618899, 4283.7429754214845, 5921.970390148022, 5963.2844058713235, 5996.190514280516, 6042.851858146938, 6050.273967123973, 5708.714564271687, 5801.535877129904, 5807.854803629774, 5820.8649313383485, 5879.853003674943, 5668.489835914787, 5713.8285851424525, 5752.9712351437975, 5781.190633311256, 5800.187973683772, 5660.462256085665, 5662.631928924771, 5673.404292549223, 5676.864627074519, 5701.629394089371, 5582.27430434041, 5809.883802324014, 5839.416058394127, 5852.736626851887, 5897.203877476486, 5658.745356458887, 5662.282104589737, 5726.649909802645, 5733.512651424676, 5739.0], "value": 4329.814749696673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.3233826621583, 640.2828831708487, 693.0678237770197, 767.9961600191998, 771.7723271634867, 15283.770743438843, 15900.443484478046, 16124.999999999985, 16134.0, 16210.513684589481, 14186.361613727382, 15226.390944362212, 15298.0, 15326.310316035777, 15399.0, 790.7390561114819, 790.8932294140303, 792.6512334572799, 803.1526739290047, 812.695239285268, 791.2443616346404, 795.8647030004884, 799.5242830515863, 799.8240387114826, 800.5756948817136, 829.9170082991712, 833.3832963606917, 835.3901651794193, 837.7151768398743, 838.8154605986704, 814.5153633588005, 828.9046759622661, 831.7089018843386, 833.2001278772386, 834.0325222741621, 608.695652173913, 609.4941198804981, 610.1518888744648, 610.8900397928371, 613.6011592464889, 14808.111513309235, 14996.850031499655, 15030.17334046627, 15209.239538023054, 15237.238138093162, 14031.929840350835, 14209.218492982882, 14289.785653215211, 14466.49367272151, 14577.344019519147, 12218.511259549607, 12293.56972505967, 12456.688582785413, 12488.875111248954, 12581.37093145339, 3794.146317078663, 3926.8625598104213, 3942.6254505821903, 3979.801009949491, 3982.2433737590054, 55964.72017639926, 56674.0, 56994.0, 57073.429265707644, 57248.42751572514, 10720.785584288271, 10920.2901811382, 11005.724856878482, 11355.659330220107, 11372.260803047775, 21071.473213169487, 21159.259425920325, 21162.153513859583, 21244.57510849805, 21280.148794048066, 8170.959145204355, 8483.363747718822, 8505.149485051445, 8609.096044915319, 8711.433756805787, 4991.401031876126, 4996.525330093708, 5070.188769796889, 5082.542571168613, 5185.792568297301, 3607.603163651996, 3680.2271522980473, 3704.6110158432975, 3722.553293604785, 3724.329620668306, 652.2238536142071, 662.2648859765657, 666.9333066693389, 673.8618583190434, 698.0262533765369, 576.9884602307931, 615.3692465223093, 634.9776859256593, 663.5468324369712, 702.950793444454, 9532.380395274286, 9638.9036109638, 9655.951720241354, 9914.603415863285, 10011.599536018477, 732.9926700733031, 760.179370407881, 765.6745882999703, 766.8581312457213, 769.1616138409161, 4287.978560107242, 4313.870583882489, 4392.1874453226255, 4406.854217903368, 4408.228560001987, 127876.0, 127962.0, 128398.0, 129100.0, 131452.0, 108933.0, 109218.44689318666, 109324.0, 109614.45192773985, 109875.0, 59095.70452147798, 63257.68371158207, 94676.52661736647, 96733.51633241789, 97126.0, 8109.148539403278, 8148.633311500878, 8224.671013159406, 8268.958655206685, 8322.807157136805, 38456.2308753829, 43215.78392108019, 53221.733891330296, 53656.46343536515, 56435.43564564466, 75044.62477687576, 82425.58787206025, 83135.75296370438, 83494.16505835106, 86023.0, 11408.372539510407, 11598.246114002563, 11696.35670038156, 12052.457639406422, 12431.316277604457, 14871.256437178314, 15029.323680434189, 15278.0, 15603.765943511084, 15807.604809879846, 13568.59294221175, 13884.652883677585, 14324.498642547462, 14359.425622974964, 14588.416463341347, 12462.0, 12849.164804287691, 13415.0, 13813.51652692151, 14744.705105897607, 13139.60581182566, 13605.659858503617, 14086.15483071019, 14224.715505690036, 14310.928445357707, 11229.66311010671, 11580.768384632092, 11637.301761894314, 11765.352905590275, 11909.225900316798, 10918.454077296263, 11003.61487347939, 11512.82730759056, 11751.0, 12153.635390938285], "value": 7514.726442854912, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 114.0, 111.0, 113.0, 112.0, 111.0, 113.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 151.0, 181.0, 128.0, 150.0, 156.0, 132.0, 192.0, 128.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 170.0, 165.0, 170.0, 165.0, 164.0, 161.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 173.0, 76.0, 78.0, 73.0, 75.0, 165.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 158.0, 84.0, 86.0, 85.0, 148.0, 85.0, 86.0, 143.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 121.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 149.0, 149.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 61.0, 55.0, 56.0, 57.0, 56.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 64.0, 63.0, 66.0, 63.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 81.0, 83.0, 81.0, 82.0, 80.0, 84.0, 103.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 124.0, 121.0, 123.0, 132.0, 133.0, 124.0, 143.0, 124.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 161.0, 167.0, 165.0, 161.0, 168.0, 164.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 65.0, 63.0, 64.0, 63.0, 64.0, 68.0, 63.0], "value": 64.9, "unit": "score"}]}]} 08:31:57 INFO - Return code: 0 08:31:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:57 ERROR - # TBPL SUCCESS # 08:31:57 INFO - Running post-action listener: _resource_record_post_action 08:31:57 INFO - ##### 08:31:57 INFO - ##### Finished run-tests step (success) 08:31:57 INFO - ##### 08:31:57 INFO - Running post-run listener: _resource_record_post_run 08:31:57 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 4096; Write bytes: 555487232; Read time: 16; Write time: 525212 08:31:57 INFO - TinderboxPrint: CPU usage
13.5% 08:31:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:31:57 INFO - TinderboxPrint: I/O write bytes / time
555,487,232 / 525,212 08:31:57 INFO - TinderboxPrint: CPU idle
8,221.3 (86.5%) 08:31:57 INFO - TinderboxPrint: CPU user
1,229.1 (12.9%) 08:31:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254132224; Read time: 0; Write time: 269532 08:31:57 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 4096; Write bytes: 292352000; Read time: 16; Write time: 254428 08:31:58 INFO - Running post-run listener: _upload_blobber_files 08:31:58 INFO - Blob upload gear active. 08:31:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:58 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:31:58 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:31:58 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:31:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:59 INFO - (blobuploader) - INFO - Done attempting. 08:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:04 INFO - (blobuploader) - INFO - Done attempting. 08:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:04 INFO - (blobuploader) - INFO - Done attempting. 08:32:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:04 INFO - Return code: 0 08:32:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1efd10447a7ec82b22958a1b9b2b9f9a7eb7d1746d2e401fcdb8328b4e756bf1450d3d5c944c28ae7fcb693c4bb0682c818728443b786dd148cd4cea583cb06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc9f88c1f34b1b43aed09cfcd2fb82fa09fbbb8523e19788d42586a88536afd60641d8a23edcf4645cd78c7a8b615dc8a2f273f26f7c40c7b34f20369d0881b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5dbb2f4f6451e99eb96130ffa01ece9ad518a01384dfb23ec284c4a3e95e7c2227dcf3160e91e65403d2d7c7e679d9a77f9f49bb1f2cdb171a7becfd4fca9e"} 08:32:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:04 INFO - Contents: 08:32:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1efd10447a7ec82b22958a1b9b2b9f9a7eb7d1746d2e401fcdb8328b4e756bf1450d3d5c944c28ae7fcb693c4bb0682c818728443b786dd148cd4cea583cb06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc9f88c1f34b1b43aed09cfcd2fb82fa09fbbb8523e19788d42586a88536afd60641d8a23edcf4645cd78c7a8b615dc8a2f273f26f7c40c7b34f20369d0881b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5dbb2f4f6451e99eb96130ffa01ece9ad518a01384dfb23ec284c4a3e95e7c2227dcf3160e91e65403d2d7c7e679d9a77f9f49bb1f2cdb171a7becfd4fca9e"} 08:32:04 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:04 INFO - Copying logs to upload dir... 08:32:04 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.998237 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-15 08:32:04.580893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:04.585005) ========= 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-1466003160.272370-1871856095 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/1efd10447a7ec82b22958a1b9b2b9f9a7eb7d1746d2e401fcdb8328b4e756bf1450d3d5c944c28ae7fcb693c4bb0682c818728443b786dd148cd4cea583cb06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc9f88c1f34b1b43aed09cfcd2fb82fa09fbbb8523e19788d42586a88536afd60641d8a23edcf4645cd78c7a8b615dc8a2f273f26f7c40c7b34f20369d0881b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5dbb2f4f6451e99eb96130ffa01ece9ad518a01384dfb23ec284c4a3e95e7c2227dcf3160e91e65403d2d7c7e679d9a77f9f49bb1f2cdb171a7becfd4fca9e"} build_url:https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/bSwK6hb_QL6rlCam3nPEdA/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/1efd10447a7ec82b22958a1b9b2b9f9a7eb7d1746d2e401fcdb8328b4e756bf1450d3d5c944c28ae7fcb693c4bb0682c818728443b786dd148cd4cea583cb06c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc9f88c1f34b1b43aed09cfcd2fb82fa09fbbb8523e19788d42586a88536afd60641d8a23edcf4645cd78c7a8b615dc8a2f273f26f7c40c7b34f20369d0881b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5dbb2f4f6451e99eb96130ffa01ece9ad518a01384dfb23ec284c4a3e95e7c2227dcf3160e91e65403d2d7c7e679d9a77f9f49bb1f2cdb171a7becfd4fca9e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:04.611121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:04.611471) ========= 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-1466003160.272370-1871856095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:32:04.694757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 08:32:04.695122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 08:32:04.695456) ========= ========= Total master_lag: 0.18 =========