builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1465217858.97 results: success (0) buildid: 20160606052827 builduid: 65ba04e3735e4d84a4c9deacaeed5e5f revision: 6a6cb441259d532d321f56272b26a322dbdc2caa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:38.971110) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:38.971571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:38.971852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:38.996870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:38.997181) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:57:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-06 05:57:39 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.119426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.119794) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022494 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.169218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.169586) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a6cb441259d532d321f56272b26a322dbdc2caa --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 6a6cb441259d532d321f56272b26a322dbdc2caa --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=652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:57:39,726 truncating revision to first 12 chars 2016-06-06 05:57:39,726 Setting DEBUG logging. 2016-06-06 05:57:39,726 attempt 1/10 2016-06-06 05:57:39,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a6cb441259d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:57:40,012 unpacking tar archive at: fx-team-6a6cb441259d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.840281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.840581) ========= script_repo_revision: 6a6cb441259d532d321f56272b26a322dbdc2caa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.840950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.841206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:57:39.849730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-06 05:57:39.850059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:40 INFO - MultiFileLogger online at 20160606 05:57:40 in /builds/slave/test 05:57:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:57:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:40 INFO - {'append_to_log': False, 05:57:40 INFO - 'base_work_dir': '/builds/slave/test', 05:57:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:57:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:40 INFO - 'branch': 'Fx-Team-Non-PGO', 05:57:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:40 INFO - 'config_files': ('talos/linux_config.py',), 05:57:40 INFO - 'default_actions': ('clobber', 05:57:40 INFO - 'read-buildbot-config', 05:57:40 INFO - 'download-and-extract', 05:57:40 INFO - 'populate-webroot', 05:57:40 INFO - 'create-virtualenv', 05:57:40 INFO - 'install', 05:57:40 INFO - 'run-tests'), 05:57:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:40 INFO - 'download_minidump_stackwalk': True, 05:57:40 INFO - 'download_symbols': 'ondemand', 05:57:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:40 INFO - 'installer_path': 'installer.exe', 05:57:40 INFO - 'log_level': 'info', 05:57:40 INFO - 'log_name': 'talos', 05:57:40 INFO - 'log_to_console': True, 05:57:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:40 INFO - 'opt_config_files': (), 05:57:40 INFO - 'pip_index': False, 05:57:40 INFO - 'sps_profile': False, 05:57:40 INFO - 'sps_profile_interval': 0, 05:57:40 INFO - 'suite': 'dromaeojs', 05:57:40 INFO - 'system_bits': '32', 05:57:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:40 INFO - 'title': 'talos-linux64-ix-046', 05:57:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:40 INFO - 'use_talos_json': True, 05:57:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:40 INFO - 'work_dir': 'build'} 05:57:40 INFO - ##### 05:57:40 INFO - ##### Running clobber step. 05:57:40 INFO - ##### 05:57:40 INFO - Running pre-action listener: _resource_record_pre_action 05:57:40 INFO - Running main action method: clobber 05:57:40 INFO - rmtree: /builds/slave/test/build 05:57:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:41 INFO - Running post-action listener: _resource_record_post_action 05:57:41 INFO - ##### 05:57:41 INFO - ##### Finished clobber step (success) 05:57:41 INFO - ##### 05:57:41 INFO - ##### 05:57:41 INFO - ##### Running read-buildbot-config step. 05:57:41 INFO - ##### 05:57:41 INFO - Running pre-action listener: _resource_record_pre_action 05:57:41 INFO - Running main action method: read_buildbot_config 05:57:41 INFO - Using buildbot properties: 05:57:41 INFO - { 05:57:41 INFO - "project": "", 05:57:41 INFO - "product": "firefox", 05:57:41 INFO - "script_repo_revision": "production", 05:57:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:57:41 INFO - "repository": "", 05:57:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:57:41 INFO - "buildid": "20160606052827", 05:57:41 INFO - "pgo_build": "False", 05:57:41 INFO - "basedir": "/builds/slave/test", 05:57:41 INFO - "buildnumber": 3045, 05:57:41 INFO - "slavename": "talos-linux64-ix-046", 05:57:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:57:41 INFO - "platform": "ubuntu64_hw", 05:57:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:57:41 INFO - "branch": "fx-team", 05:57:41 INFO - "repo_path": "integration/fx-team", 05:57:41 INFO - "revision": "6a6cb441259d532d321f56272b26a322dbdc2caa", 05:57:41 INFO - "stage_platform": "linux64", 05:57:41 INFO - "builduid": "65ba04e3735e4d84a4c9deacaeed5e5f", 05:57:41 INFO - "slavebuilddir": "test" 05:57:41 INFO - } 05:57:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:57:41 INFO - Running post-action listener: _resource_record_post_action 05:57:41 INFO - ##### 05:57:41 INFO - ##### Finished read-buildbot-config step (success) 05:57:41 INFO - ##### 05:57:41 INFO - ##### 05:57:41 INFO - ##### Running download-and-extract step. 05:57:41 INFO - ##### 05:57:41 INFO - Running pre-action listener: _resource_record_pre_action 05:57:41 INFO - Running main action method: download_and_extract 05:57:41 INFO - mkdir: /builds/slave/test/build/tests 05:57:41 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')]} 05:57:41 INFO - https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:57:44 INFO - Downloaded 1361 bytes. 05:57:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:57:44 INFO - Using the following test package requirements: 05:57:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:57:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:57:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'jsshell-linux-x86_64.zip'], 05:57:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:57:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:57:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:57:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:57:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:57:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:44 INFO - https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:57:45 INFO - Downloaded 22870980 bytes. 05:57:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:57:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:57:46 INFO - Return code: 0 05:57:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:46 INFO - https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:57:49 INFO - Downloaded 22870980 bytes. 05:57:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:57:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:57:50 INFO - Return code: 0 05:57: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')]} 05:57:50 INFO - https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:57:52 INFO - Downloaded 10833369 bytes. 05:57:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:57:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:57:52 INFO - Return code: 0 05:57:52 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')]} 05:57:52 INFO - https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:57:53 INFO - Downloaded 55200460 bytes. 05:57:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:53 INFO - mkdir: /builds/slave/test/properties 05:57:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:57:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:57:53 INFO - Contents: 05:57:53 INFO - build_url:https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:54 INFO - Running post-action listener: _resource_record_post_action 05:57:54 INFO - Running post-action listener: set_extra_try_arguments 05:57:54 INFO - ##### 05:57:54 INFO - ##### Finished download-and-extract step (success) 05:57:54 INFO - ##### 05:57:54 INFO - ##### 05:57:54 INFO - ##### Running populate-webroot step. 05:57:54 INFO - ##### 05:57:54 INFO - Running pre-action listener: _resource_record_pre_action 05:57:54 INFO - Running main action method: populate_webroot 05:57:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:57:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:57:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:57:54 INFO - '--tppagecycles', 05:57:54 INFO - '7'], 05:57:54 INFO - 'tests': ['tsvgm']}}, 05:57:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:57:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:57:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:57:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:57:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['damp', 'tps']}, 05:57:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'tests': ['damp', 'tps']}, 05:57:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['dromaeo_dom']}, 05:57:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:57:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['a11yr', 05:57:54 INFO - 'ts_paint', 05:57:54 INFO - 'tpaint', 05:57:54 INFO - 'sessionrestore', 05:57:54 INFO - 'sessionrestore_no_auto_restore', 05:57:54 INFO - 'tabpaint']}, 05:57:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:57:54 INFO - 'ts_paint', 05:57:54 INFO - 'tpaint', 05:57:54 INFO - 'sessionrestore', 05:57:54 INFO - 'sessionrestore_no_auto_restore', 05:57:54 INFO - 'tabpaint']}, 05:57:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:57:54 INFO - 'ts_paint', 05:57:54 INFO - 'tpaint', 05:57:54 INFO - 'sessionrestore', 05:57:54 INFO - 'sessionrestore_no_auto_restore', 05:57:54 INFO - 'tabpaint']}, 05:57:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:57:54 INFO - 'ts_paint', 05:57:54 INFO - 'tpaint', 05:57:54 INFO - 'sessionrestore', 05:57:54 INFO - 'sessionrestore_no_auto_restore', 05:57:54 INFO - 'tabpaint']}, 05:57:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['a11yr', 05:57:54 INFO - 'ts_paint', 05:57:54 INFO - 'tpaint', 05:57:54 INFO - 'sessionrestore', 05:57:54 INFO - 'sessionrestore_no_auto_restore', 05:57:54 INFO - 'tabpaint']}, 05:57:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['a11yr', 05:57:54 INFO - 'ts_paint', 05:57:54 INFO - 'tpaint', 05:57:54 INFO - 'sessionrestore', 05:57:54 INFO - 'sessionrestore_no_auto_restore', 05:57:54 INFO - 'tabpaint']}, 05:57:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['tsvgx', 05:57:54 INFO - 'tsvgr_opacity', 05:57:54 INFO - 'tart', 05:57:54 INFO - 'tscrollx', 05:57:54 INFO - 'cart']}, 05:57:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:57:54 INFO - 'tsvgr_opacity', 05:57:54 INFO - 'tart', 05:57:54 INFO - 'tscrollx', 05:57:54 INFO - 'cart']}, 05:57:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'talos_options': ['--disable-e10s'], 05:57:54 INFO - 'tests': ['tp5o']}, 05:57:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'tests': ['tp5o']}, 05:57:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'talos_options': ['--disable-e10s', 05:57:54 INFO - '--xperf_path', 05:57:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:54 INFO - 'tests': ['tp5n']}, 05:57:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:54 INFO - 'talos_options': ['--xperf_path', 05:57:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:54 INFO - 'tests': ['tp5n']}}, 05:57:54 INFO - 'talos.zip': {'path': '', 05:57:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:57:54 INFO - Running post-action listener: _resource_record_post_action 05:57:54 INFO - ##### 05:57:54 INFO - ##### Finished populate-webroot step (success) 05:57:54 INFO - ##### 05:57:54 INFO - ##### 05:57:54 INFO - ##### Running create-virtualenv step. 05:57:54 INFO - ##### 05:57:54 INFO - Running pre-action listener: _resource_record_pre_action 05:57:54 INFO - Running main action method: create_virtualenv 05:57:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:57:54 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 05:57:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:57:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:57:54 INFO - Using real prefix '/usr' 05:57:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:57:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:57 INFO - Installing pip.................done. 05:57:57 INFO - Return code: 0 05:57:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:57 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:57:57 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 05:57:57 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 05:57:57 INFO - Using env: {'DISPLAY': ':0', 05:57:57 INFO - 'HOME': '/home/cltbld', 05:57:57 INFO - 'LANG': 'en_US.UTF-8', 05:57:57 INFO - 'LANGUAGE': 'en_US:en', 05:57:57 INFO - 'LOGNAME': 'cltbld', 05:57:57 INFO - 'MAIL': '/var/mail/cltbld', 05:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:57 INFO - 'MOZ_NO_REMOTE': '1', 05:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:57 INFO - 'NO_EM_RESTART': '1', 05:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:57 INFO - 'PWD': '/builds/slave/test', 05:57:57 INFO - 'SHELL': '/bin/bash', 05:57:57 INFO - 'SHLVL': '1', 05:57:57 INFO - 'TERM': 'linux', 05:57:57 INFO - 'TMOUT': '86400', 05:57:57 INFO - 'USER': 'cltbld', 05:57:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:57 INFO - '_': '/tools/buildbot/bin/python'} 05:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:57 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 05:57:57 INFO - Cleaning up... 05:57:57 INFO - Return code: 0 05:57:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:57 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:57:57 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 05:57:57 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 05:57:57 INFO - Using env: {'DISPLAY': ':0', 05:57:57 INFO - 'HOME': '/home/cltbld', 05:57:57 INFO - 'LANG': 'en_US.UTF-8', 05:57:57 INFO - 'LANGUAGE': 'en_US:en', 05:57:57 INFO - 'LOGNAME': 'cltbld', 05:57:57 INFO - 'MAIL': '/var/mail/cltbld', 05:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:57 INFO - 'MOZ_NO_REMOTE': '1', 05:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:57 INFO - 'NO_EM_RESTART': '1', 05:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:57 INFO - 'PWD': '/builds/slave/test', 05:57:57 INFO - 'SHELL': '/bin/bash', 05:57:57 INFO - 'SHLVL': '1', 05:57:57 INFO - 'TERM': 'linux', 05:57:57 INFO - 'TMOUT': '86400', 05:57:57 INFO - 'USER': 'cltbld', 05:57:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:57 INFO - '_': '/tools/buildbot/bin/python'} 05:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:57 INFO - Downloading/unpacking psutil>=3.1.1 05:57:57 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 05:57:57 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 05:57:57 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 05:57:57 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 05:57:57 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 05:57:57 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 05:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:59 INFO - Installing collected packages: psutil 05:57:59 INFO - Running setup.py install for psutil 05:57:59 INFO - building 'psutil._psutil_linux' extension 05:57:59 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 05:57:59 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 05:57:59 INFO - building 'psutil._psutil_posix' extension 05:57:59 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 05:57:59 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 05:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:00 INFO - Successfully installed psutil 05:58:00 INFO - Cleaning up... 05:58:00 INFO - Return code: 0 05:58:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:00 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')]} 05:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:00 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')]} 05:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:00 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:00 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 05:58:00 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 05:58:00 INFO - Using env: {'DISPLAY': ':0', 05:58:00 INFO - 'HOME': '/home/cltbld', 05:58:00 INFO - 'LANG': 'en_US.UTF-8', 05:58:00 INFO - 'LANGUAGE': 'en_US:en', 05:58:00 INFO - 'LOGNAME': 'cltbld', 05:58:00 INFO - 'MAIL': '/var/mail/cltbld', 05:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:00 INFO - 'MOZ_NO_REMOTE': '1', 05:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:00 INFO - 'NO_EM_RESTART': '1', 05:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:00 INFO - 'PWD': '/builds/slave/test', 05:58:00 INFO - 'SHELL': '/bin/bash', 05:58:00 INFO - 'SHLVL': '1', 05:58:00 INFO - 'TERM': 'linux', 05:58:00 INFO - 'TMOUT': '86400', 05:58:00 INFO - 'USER': 'cltbld', 05:58:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:00 INFO - '_': '/tools/buildbot/bin/python'} 05:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:00 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 05:58:00 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 05:58:00 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 05:58:00 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 05:58:00 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 05:58:00 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 05:58:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:02 INFO - Installing collected packages: mozsystemmonitor 05:58:02 INFO - Running setup.py install for mozsystemmonitor 05:58:02 INFO - Successfully installed mozsystemmonitor 05:58:02 INFO - Cleaning up... 05:58:02 INFO - Return code: 0 05:58:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:02 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:02 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 05:58:02 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 05:58:02 INFO - Using env: {'DISPLAY': ':0', 05:58:02 INFO - 'HOME': '/home/cltbld', 05:58:02 INFO - 'LANG': 'en_US.UTF-8', 05:58:02 INFO - 'LANGUAGE': 'en_US:en', 05:58:02 INFO - 'LOGNAME': 'cltbld', 05:58:02 INFO - 'MAIL': '/var/mail/cltbld', 05:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:02 INFO - 'MOZ_NO_REMOTE': '1', 05:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:02 INFO - 'NO_EM_RESTART': '1', 05:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:02 INFO - 'PWD': '/builds/slave/test', 05:58:02 INFO - 'SHELL': '/bin/bash', 05:58:02 INFO - 'SHLVL': '1', 05:58:02 INFO - 'TERM': 'linux', 05:58:02 INFO - 'TMOUT': '86400', 05:58:02 INFO - 'USER': 'cltbld', 05:58:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:02 INFO - '_': '/tools/buildbot/bin/python'} 05:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:02 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 05:58:02 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 05:58:02 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 05:58:02 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 05:58:02 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 05:58:02 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 05:58:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:04 INFO - warning: no files found matching '*.txt' 05:58:04 INFO - no previously-included directories found matching 'build' 05:58:04 INFO - no previously-included directories found matching 'dist' 05:58:04 INFO - no previously-included directories found matching '.git*' 05:58:04 INFO - Installing collected packages: jsonschema, functools32 05:58:04 INFO - Running setup.py install for functools32 05:58:04 INFO - warning: no files found matching '*.txt' 05:58:04 INFO - no previously-included directories found matching 'build' 05:58:04 INFO - no previously-included directories found matching 'dist' 05:58:04 INFO - no previously-included directories found matching '.git*' 05:58:04 INFO - Successfully installed jsonschema functools32 05:58:04 INFO - Cleaning up... 05:58:05 INFO - Return code: 0 05:58:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:05 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:05 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 05:58:05 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 05:58:05 INFO - Using env: {'DISPLAY': ':0', 05:58:05 INFO - 'HOME': '/home/cltbld', 05:58:05 INFO - 'LANG': 'en_US.UTF-8', 05:58:05 INFO - 'LANGUAGE': 'en_US:en', 05:58:05 INFO - 'LOGNAME': 'cltbld', 05:58:05 INFO - 'MAIL': '/var/mail/cltbld', 05:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:05 INFO - 'MOZ_NO_REMOTE': '1', 05:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:05 INFO - 'NO_EM_RESTART': '1', 05:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:05 INFO - 'PWD': '/builds/slave/test', 05:58:05 INFO - 'SHELL': '/bin/bash', 05:58:05 INFO - 'SHLVL': '1', 05:58:05 INFO - 'TERM': 'linux', 05:58:05 INFO - 'TMOUT': '86400', 05:58:05 INFO - 'USER': 'cltbld', 05:58:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:05 INFO - '_': '/tools/buildbot/bin/python'} 05:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:05 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 05:58:05 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 05:58:05 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 05:58:05 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 05:58:05 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 05:58:05 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 05:58:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 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 05:58:07 INFO - Downloading docopt-0.6.1.tar.gz 05:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:07 INFO - Running setup.py install for blobuploader 05:58:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:07 INFO - Running setup.py install for requests 05:58:08 INFO - Running setup.py install for docopt 05:58:08 INFO - Successfully installed blobuploader requests docopt 05:58:08 INFO - Cleaning up... 05:58:08 INFO - Return code: 0 05:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:08 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:08 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 05:58:08 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 05:58:08 INFO - Using env: {'DISPLAY': ':0', 05:58:08 INFO - 'HOME': '/home/cltbld', 05:58:08 INFO - 'LANG': 'en_US.UTF-8', 05:58:08 INFO - 'LANGUAGE': 'en_US:en', 05:58:08 INFO - 'LOGNAME': 'cltbld', 05:58:08 INFO - 'MAIL': '/var/mail/cltbld', 05:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:08 INFO - 'MOZ_NO_REMOTE': '1', 05:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:08 INFO - 'NO_EM_RESTART': '1', 05:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:08 INFO - 'PWD': '/builds/slave/test', 05:58:08 INFO - 'SHELL': '/bin/bash', 05:58:08 INFO - 'SHLVL': '1', 05:58:08 INFO - 'TERM': 'linux', 05:58:08 INFO - 'TMOUT': '86400', 05:58:08 INFO - 'USER': 'cltbld', 05:58:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:08 INFO - '_': '/tools/buildbot/bin/python'} 05:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:08 INFO - Running setup.py (path:/tmp/pip-dkGR_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:08 INFO - Running setup.py (path:/tmp/pip-v42ec3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:08 INFO - Running setup.py (path:/tmp/pip-uO56rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:08 INFO - Running setup.py (path:/tmp/pip-q0TfTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:08 INFO - Running setup.py (path:/tmp/pip-tSI1_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:09 INFO - Running setup.py (path:/tmp/pip-OgdMGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:09 INFO - Running setup.py (path:/tmp/pip-DoaRJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:09 INFO - Running setup.py (path:/tmp/pip-qFyZx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:09 INFO - Running setup.py (path:/tmp/pip-nbtCoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:09 INFO - Running setup.py (path:/tmp/pip-eHlCPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:09 INFO - Running setup.py (path:/tmp/pip-DjCPyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:09 INFO - Running setup.py (path:/tmp/pip-EB4SkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:09 INFO - Running setup.py (path:/tmp/pip-Zb3FSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:09 INFO - Running setup.py (path:/tmp/pip-U0ah5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:09 INFO - Running setup.py (path:/tmp/pip-DJzs_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:09 INFO - Running setup.py (path:/tmp/pip-zBvxxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:09 INFO - Running setup.py (path:/tmp/pip-JGjwbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:09 INFO - Running setup.py install for manifestparser 05:58:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Running setup.py install for mozcrash 05:58:10 INFO - Running setup.py install for mozdebug 05:58:10 INFO - Running setup.py install for mozdevice 05:58:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Running setup.py install for mozfile 05:58:10 INFO - Running setup.py install for mozhttpd 05:58:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Running setup.py install for mozinfo 05:58:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Running setup.py install for mozInstall 05:58:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Running setup.py install for mozleak 05:58:10 INFO - Running setup.py install for mozlog 05:58:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:10 INFO - Running setup.py install for moznetwork 05:58:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:11 INFO - Running setup.py install for mozprocess 05:58:11 INFO - Running setup.py install for mozprofile 05:58:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:11 INFO - Running setup.py install for mozrunner 05:58:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:11 INFO - Running setup.py install for mozscreenshot 05:58:11 INFO - Running setup.py install for moztest 05:58:11 INFO - Running setup.py install for mozversion 05:58:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:11 INFO - Cleaning up... 05:58:11 INFO - Return code: 0 05:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:11 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:11 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 05:58:11 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 05:58:11 INFO - Using env: {'DISPLAY': ':0', 05:58:11 INFO - 'HOME': '/home/cltbld', 05:58:11 INFO - 'LANG': 'en_US.UTF-8', 05:58:11 INFO - 'LANGUAGE': 'en_US:en', 05:58:11 INFO - 'LOGNAME': 'cltbld', 05:58:11 INFO - 'MAIL': '/var/mail/cltbld', 05:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:11 INFO - 'MOZ_NO_REMOTE': '1', 05:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:11 INFO - 'NO_EM_RESTART': '1', 05:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:11 INFO - 'PWD': '/builds/slave/test', 05:58:11 INFO - 'SHELL': '/bin/bash', 05:58:11 INFO - 'SHLVL': '1', 05:58:11 INFO - 'TERM': 'linux', 05:58:11 INFO - 'TMOUT': '86400', 05:58:11 INFO - 'USER': 'cltbld', 05:58:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:11 INFO - '_': '/tools/buildbot/bin/python'} 05:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:11 INFO - Running setup.py (path:/tmp/pip-culpEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:11 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)) 05:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:11 INFO - Running setup.py (path:/tmp/pip-dMpR5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:12 INFO - Running setup.py (path:/tmp/pip-mGlyRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:12 INFO - Running setup.py (path:/tmp/pip-idzvPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:12 INFO - Running setup.py (path:/tmp/pip-d_ck5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:12 INFO - Running setup.py (path:/tmp/pip-9ExmLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:12 INFO - Running setup.py (path:/tmp/pip-mLTkd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:12 INFO - Running setup.py (path:/tmp/pip-8ntBkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:12 INFO - Running setup.py (path:/tmp/pip-uOchZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:12 INFO - Running setup.py (path:/tmp/pip-WeKNeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:12 INFO - Running setup.py (path:/tmp/pip-rLh8Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:12 INFO - Running setup.py (path:/tmp/pip-pgMb4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:12 INFO - Running setup.py (path:/tmp/pip-A0XRN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:12 INFO - Running setup.py (path:/tmp/pip-Wczu6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:12 INFO - Running setup.py (path:/tmp/pip-GZphlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:12 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)) 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:12 INFO - Running setup.py (path:/tmp/pip-2tIibf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:13 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)) 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:13 INFO - Running setup.py (path:/tmp/pip-eXLs7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:13 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)) 05:58:13 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)) 05:58:13 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)) 05:58:13 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)) 05:58:13 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)) 05:58:13 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)) 05:58:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:15 INFO - Downloading blessings-1.6.tar.gz 05:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:15 INFO - Installing collected packages: blessings 05:58:15 INFO - Running setup.py install for blessings 05:58:15 INFO - Successfully installed blessings 05:58:15 INFO - Cleaning up... 05:58:15 INFO - Return code: 0 05:58:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:15 INFO - Reading from file tmpfile_stdout 05:58:15 INFO - Current package versions: 05:58:15 INFO - argparse == 1.2.1 05:58:15 INFO - blessings == 1.6 05:58:15 INFO - blobuploader == 1.2.4 05:58:15 INFO - docopt == 0.6.1 05:58:15 INFO - functools32 == 3.2.3-2 05:58:15 INFO - jsonschema == 2.5.1 05:58:15 INFO - manifestparser == 1.1 05:58:15 INFO - mozInstall == 1.12 05:58:15 INFO - mozcrash == 0.17 05:58:15 INFO - mozdebug == 0.1 05:58:15 INFO - mozdevice == 0.48 05:58:15 INFO - mozfile == 1.2 05:58:15 INFO - mozhttpd == 0.7 05:58:15 INFO - mozinfo == 0.9 05:58:15 INFO - mozleak == 0.1 05:58:15 INFO - mozlog == 3.2 05:58:15 INFO - moznetwork == 0.27 05:58:15 INFO - mozprocess == 0.22 05:58:15 INFO - mozprofile == 0.28 05:58:15 INFO - mozrunner == 6.11 05:58:15 INFO - mozscreenshot == 0.1 05:58:15 INFO - mozsystemmonitor == 0.3 05:58:15 INFO - moztest == 0.7 05:58:15 INFO - mozversion == 1.4 05:58:15 INFO - psutil == 3.1.1 05:58:15 INFO - requests == 1.2.3 05:58:15 INFO - wsgiref == 0.1.2 05:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:15 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')]} 05:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 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')]} 05:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:15 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 05:58:15 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 05:58:15 INFO - Using env: {'DISPLAY': ':0', 05:58:15 INFO - 'HOME': '/home/cltbld', 05:58:15 INFO - 'LANG': 'en_US.UTF-8', 05:58:15 INFO - 'LANGUAGE': 'en_US:en', 05:58:15 INFO - 'LOGNAME': 'cltbld', 05:58:15 INFO - 'MAIL': '/var/mail/cltbld', 05:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:15 INFO - 'MOZ_NO_REMOTE': '1', 05:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:15 INFO - 'NO_EM_RESTART': '1', 05:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:15 INFO - 'PWD': '/builds/slave/test', 05:58:15 INFO - 'SHELL': '/bin/bash', 05:58:15 INFO - 'SHLVL': '1', 05:58:15 INFO - 'TERM': 'linux', 05:58:15 INFO - 'TMOUT': '86400', 05:58:15 INFO - 'USER': 'cltbld', 05:58:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:15 INFO - '_': '/tools/buildbot/bin/python'} 05:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 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)) 05:58:15 INFO - Cleaning up... 05:58:15 INFO - Return code: 0 05:58:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:15 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')]} 05:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 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')]} 05:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:15 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 05:58:15 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 05:58:15 INFO - Using env: {'DISPLAY': ':0', 05:58:15 INFO - 'HOME': '/home/cltbld', 05:58:15 INFO - 'LANG': 'en_US.UTF-8', 05:58:15 INFO - 'LANGUAGE': 'en_US:en', 05:58:15 INFO - 'LOGNAME': 'cltbld', 05:58:15 INFO - 'MAIL': '/var/mail/cltbld', 05:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:15 INFO - 'MOZ_NO_REMOTE': '1', 05:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:15 INFO - 'NO_EM_RESTART': '1', 05:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:15 INFO - 'PWD': '/builds/slave/test', 05:58:15 INFO - 'SHELL': '/bin/bash', 05:58:15 INFO - 'SHLVL': '1', 05:58:15 INFO - 'TERM': 'linux', 05:58:15 INFO - 'TMOUT': '86400', 05:58:15 INFO - 'USER': 'cltbld', 05:58:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:15 INFO - '_': '/tools/buildbot/bin/python'} 05:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:15 INFO - Cleaning up... 05:58:15 INFO - Return code: 0 05:58:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:15 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')]} 05:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 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')]} 05:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:15 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 0x7f1f1df53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, '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': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', '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 05:58:15 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 05:58:15 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 05:58:15 INFO - Using env: {'DISPLAY': ':0', 05:58:15 INFO - 'HOME': '/home/cltbld', 05:58:15 INFO - 'LANG': 'en_US.UTF-8', 05:58:15 INFO - 'LANGUAGE': 'en_US:en', 05:58:15 INFO - 'LOGNAME': 'cltbld', 05:58:15 INFO - 'MAIL': '/var/mail/cltbld', 05:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:15 INFO - 'MOZ_NO_REMOTE': '1', 05:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:15 INFO - 'NO_EM_RESTART': '1', 05:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:15 INFO - 'PWD': '/builds/slave/test', 05:58:15 INFO - 'SHELL': '/bin/bash', 05:58:15 INFO - 'SHLVL': '1', 05:58:15 INFO - 'TERM': 'linux', 05:58:15 INFO - 'TMOUT': '86400', 05:58:15 INFO - 'USER': 'cltbld', 05:58:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:15 INFO - '_': '/tools/buildbot/bin/python'} 05:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:16 INFO - Downloading/unpacking flake8 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:18 INFO - no previously-included directories found matching 'docs/_build' 05:58:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:18 INFO - Running setup.py install for pep8 05:58:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:18 INFO - no previously-included directories found matching 'docs/_build' 05:58:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:18 INFO - Cleaning up... 05:58:18 INFO - Return code: 0 05:58:18 INFO - Running post-action listener: _resource_record_post_action 05:58:18 INFO - Running post-action listener: _start_resource_monitoring 05:58:19 INFO - Starting resource monitoring. 05:58:19 INFO - ##### 05:58:19 INFO - ##### Finished create-virtualenv step (success) 05:58:19 INFO - ##### 05:58:19 INFO - ##### 05:58:19 INFO - ##### Running install step. 05:58:19 INFO - ##### 05:58:19 INFO - Running pre-action listener: _resource_record_pre_action 05:58:19 INFO - Running main action method: install 05:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:19 INFO - Reading from file tmpfile_stdout 05:58:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:19 INFO - Reading from file tmpfile_stdout 05:58:19 INFO - Output received: 05:58:19 INFO - Usage: mozinstall [options] installer 05:58:19 INFO - Options: 05:58:19 INFO - -h, --help show this help message and exit 05:58:19 INFO - -d DEST, --destination=DEST 05:58:19 INFO - Directory to install application into. [default: 05:58:19 INFO - "/builds/slave/test"] 05:58:19 INFO - --app=APP Application being installed. [default: firefox] 05:58:19 INFO - mkdir: /builds/slave/test/build/application 05:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:58:35 INFO - Reading from file tmpfile_stdout 05:58:35 INFO - Output received: 05:58:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:35 INFO - Running post-action listener: _resource_record_post_action 05:58:35 INFO - ##### 05:58:35 INFO - ##### Finished install step (success) 05:58:35 INFO - ##### 05:58:35 INFO - ##### 05:58:35 INFO - ##### Running run-tests step. 05:58:35 INFO - ##### 05:58:35 INFO - Running pre-action listener: _resource_record_pre_action 05:58:35 INFO - Running main action method: run_tests 05:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:35 INFO - Python 2.7.3 05:58:35 INFO - Return code: 0 05:58:35 INFO - grabbing minidump binary from tooltool 05:58:35 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')]} 05:58:35 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 0x14ea1c0>, '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 0x14eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:35 INFO - Return code: 0 05:58:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:58:36 INFO - Return code: 0 05:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:58:36 INFO - Using env: {'DISPLAY': ':0', 05:58:36 INFO - 'HOME': '/home/cltbld', 05:58:36 INFO - 'LANG': 'en_US.UTF-8', 05:58:36 INFO - 'LANGUAGE': 'en_US:en', 05:58:36 INFO - 'LOGNAME': 'cltbld', 05:58:36 INFO - 'MAIL': '/var/mail/cltbld', 05:58:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:36 INFO - 'MOZ_NO_REMOTE': '1', 05:58:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:36 INFO - 'NO_EM_RESTART': '1', 05:58:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:36 INFO - 'PWD': '/builds/slave/test', 05:58:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:36 INFO - 'SHELL': '/bin/bash', 05:58:36 INFO - 'SHLVL': '1', 05:58:36 INFO - 'TERM': 'linux', 05:58:36 INFO - 'TMOUT': '86400', 05:58:36 INFO - 'USER': 'cltbld', 05:58:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809', 05:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:36 INFO - '_': '/tools/buildbot/bin/python'} 05:58:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:58:36 INFO - mozversion application_buildid: 20160606052827 05:58:36 INFO - mozversion application_changeset: 6a6cb441259d532d321f56272b26a322dbdc2caa 05:58:36 INFO - mozversion application_display_name: Nightly 05:58:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:36 INFO - mozversion application_name: Firefox 05:58:36 INFO - mozversion application_remotingname: firefox 05:58:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:58:36 INFO - mozversion application_vendor: Mozilla 05:58:36 INFO - mozversion application_version: 49.0a1 05:58:36 INFO - mozversion platform_buildid: 20160606052827 05:58:36 INFO - mozversion platform_changeset: 6a6cb441259d532d321f56272b26a322dbdc2caa 05:58:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:58:36 INFO - mozversion platform_version: 49.0a1 05:58:36 INFO - using testdate: 1465217916 05:58:36 INFO - actual date: 1465217916 05:58:36 INFO - starting webserver on 'localhost:59720' 05:58:36 INFO - SUITE-START | Running 2 tests 05:58:36 INFO - TEST-START | dromaeo_css 05:58:36 INFO - operating with platform_type : linux_ 05:58:36 INFO - Initialising browser for dromaeo_css test... 05:58:36 INFO - TEST-INFO | started process 20460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnf6rB/profile http://localhost:59720/getInfo.html) 05:58:40 INFO - PROCESS | 20460 | __metrics Screen width/height:1600/1200 05:58:40 INFO - PROCESS | 20460 | colorDepth:24 05:58:40 INFO - PROCESS | 20460 | Browser inner width/height: 1024/697 05:58:40 INFO - PROCESS | 20460 | __metrics 05:58:41 ERROR - PROCESS | 20460 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:58:41 INFO - PROCESS | 20460 | console.error: PushService: 05:58:41 INFO - PROCESS | 20460 | stateChangeProcessEnqueue: Error transitioning state 05:58:41 INFO - PROCESS | 20460 | UnknownError 05:58:42 INFO - TEST-INFO | 20460: exit 0 05:58:42 INFO - Browser initialized. 05:58:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:42 INFO - TEST-INFO | started process 20542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnf6rB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:54 INFO - PROCESS | 20542 | RSS: Main: 157564928 05:58:54 INFO - PROCESS | 20542 | 05:59:46 INFO - PROCESS | 20542 | 1465217986235 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:01:57 INFO - PROCESS | 20542 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59720/tests/dromaeo/cssquery-ext.html) 06:01:58 INFO - PROCESS | 20542 | RSS: Main: 249032704 06:01:58 INFO - PROCESS | 20542 | 06:05:01 INFO - PROCESS | 20542 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-ext.html (next: http://localhost:59720/tests/dromaeo/cssquery-jquery.html) 06:05:02 INFO - PROCESS | 20542 | RSS: Main: 243712000 06:05:02 INFO - PROCESS | 20542 | 06:08:04 INFO - PROCESS | 20542 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59720/tests/dromaeo/cssquery-mootools.html) 06:08:04 INFO - PROCESS | 20542 | RSS: Main: 240193536 06:08:04 INFO - PROCESS | 20542 | 06:11:07 INFO - PROCESS | 20542 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59720/tests/dromaeo/cssquery-prototype.html) 06:11:07 INFO - PROCESS | 20542 | RSS: Main: 243081216 06:11:07 INFO - PROCESS | 20542 | 06:14:10 INFO - PROCESS | 20542 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59720/tests/dromaeo/cssquery-yui.html) 06:14:11 INFO - PROCESS | 20542 | RSS: Main: 227987456 06:14:11 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-yui.html (next: http://localhost:59720/tests/dromaeo/cssquery-dojo.html) 06:17:14 INFO - PROCESS | 20542 | RSS: Main: 278249472 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | __start_tp_report 06:17:14 INFO - PROCESS | 20542 | _x_x_mozilla_page_load 06:17:14 INFO - PROCESS | 20542 | _x_x_mozilla_page_load_details 06:17:14 INFO - PROCESS | 20542 | |i|pagename|runs| 06:17:14 INFO - PROCESS | 20542 | |0;dojo.html;2678.54464740994;2702.8243164194328;2710.227585138236;2728.7816974642033;2734.4667789781;4581.954180458194;4686.039361930804;4713.222318317477;4807.6153907687385;4837.419509658842;4715.08055929094;4725.8582242532775;4729.31424943383;4770.594499467541;4785.0908327417765;4290.184864875671;4331.328644060176;4372.191144638252;4410.117976404716;4566.269396896497;4493.056458143794;4518.97740511297;4537.795799189028;4551.1580357633775;4578.748168850712;4259.212045771511;4290.742555446652;4292.098659281554;4314.094040251551;4382.868513944571;4321.7406955582455;4337.1976184405985;4343.891402714926;4344.370066340394;4393.824247030115;4367.890802729926;4391.912161756779;4403.9870829709025;4436.778161091933;4448.977755111204;4560.110778398213;4619.260918253097;4669.533046695337;4730.148573256813;4730.455997560291;5107.591392688576;5131.974340128313;5187.922181167285;5190.4031036430915;5196.480351964811;5180.404253510819;5212.582993360522;5218.843434696965;5231.110711179071;5240.371155461331;4641.373414589055;4685.531446855287;4733.502982186889;4859.343988561534;4866.853994380139;5207.140821764442;5216.26972223889;5236.92144617831;5252.317198764136;5259.079661059376;4998.450170481244;5040.621953353513;5047.2429135629945;5047.4952504749235;5051.6716413433005;4861.6596838220985;5073.543381095719;5122.026814905156;5123.487651234846;5127.2052831811125;5083.313752643346;5101.132807422747;5102.540771330598;5109.846704598868;5156.303898973591;5088.542031217208;5094.923576146361;5094.949050509522;5097.7706003229205;5099.133147364957;4219.198352313051;4267.039916018933;4270.996315865769;4309.224339618836;4318.740875547477;3795.221979494197;3796.088938654703;3811.104390468238;3839.5584507781405;3840.5967373425947;4403.801828917706;4477.70894891831;4479.888002799891;4488.640908727294;4490.438695163105;5167.6641018333685;5196.274481588237;5197.038547868657;5206.245094461282;5258.027264955996;4453.955460445419;4461.933071003938;4463.352813841975;4469.7318160910445;4507.616852567503;4434.11317736454;4547.954520454819;4577.22187228172;4583.931241031387;4598.149342371672;4875;4876.341693871282;4876.829310974099;4887.120318342732;4923.138450771101;4879.951200488092;5147;5172.586193104467;5192.818251361185;5200.531952124327;4841.2496063110275;4855.830045948375;4872.6832755870755;4899.828506002415;4920.6555541111775;5063.367079115111;5077.339945807022;5080.7205603692155;5081.136206844919;5136.383633963948;4891.73095479752;5074.517920797518;5141.408737995179;5146.588272938081;5150.948490515197;4972.881101752077;5002.349694539686;5029.74851257443;5035.496450354935;5084.466131056186;5004.5746111579465;5004.799808007784;5012.198048312398;5013.39839219296;5075.3148324975655;4833.927491087707;4856.223004319292;4916.188828843344;4916.975415122902;4995.675281106716;5035.496450354935;5047.268146118866;5056.191009438619;5085.338905942203;5101.20931255656;4929.408470983505;4932.580730637936;4938.604911606991;4941.184704523714;4991.101601711727 06:17:14 INFO - PROCESS | 20542 | |1;ext.html;561.1750726432143;593.9724277000788;598.9727617136609;601.3835818286256;618.3229363846586;28476;29533.2616684583;38749;39929;40053.799731001374;38359.61640383596;38938.610613893856;38942.80528597353;38949.221015579744;38995.61004389955;7633.923660763391;7788.14330423653;7790.610469476504;7818.374530037612;7818.569978651172;7615;7727.304542591166;7738.961305193466;7743.148253692089;7744;7746.4190185736015;7785.883211751829;7786.104597971221;7790.337821285169;7792.415568832332;7715.421343399267;7755.185705500898;7756.34071103954;7756.961215193945;7761.22387761225;7570.924290757077;7616.504927179771;7650.579218143055;7664.195259497784;7665.386769058462;35427.4685879712;35759.28481430383;35862.820685896666;35868.820655896816;35882.641173588454;2880.438314528668;3054.831984240866;3077.292222788749;3089.7837151399413;3130.467820470503;27969.72030279712;28156.436871262664;28634.713652863622;28751.424971500663;29095.272618184503;3522.5420695309704;3524.731096805148;3543.362194804934;3557.5553055868018;3596.9100772480638;254613;256581;257549;259096;259260.7036964822;31497.8425107873;32473.350532989207;54679;55095.38855337385;55214.17178742322;33784.32431351359;33823.32353352919;33976.49035264473;34082;34086.659133408844;12532.937335313265;12600.684982875318;12620.873791262153;12634.178778379375;12651.557195498297;10075.992400760011;10084.69745907624;10085.798284034277;10102.19182465401;10147.847782283272;7929.44493885434;7951.284384405431;7958.602069896482;8009.159038301011;8040.35677145827;3097.550855125994;3125.812451252932;3128.671489493616;3163.114327988167;3166.8099914005234;879.2745984562762;920.5627327019746;1004.6785028790863;1019.5361110694616;1021.2953062386929;25572.360690982874;26514;26525.33686657849;26960.59559106615;27040.59439108415;791.6872835230051;947.824652439301;1018.1919620618833;1030.90206430389;1033.503918119307;13686.726265474636;14170.645733856736;14235.145891246559;14266.3580138894;14430.567082987527;383854;386903;387165;387451;388486;47760.76119619449;48161.277580836315;48189.27716084261;48304.275435867785;48308.75845620749;1081.1080858291941;1202.6812894582943;1204.8253003314471;1242.4657397319058;1252.661781319057;26010.34974125662;26814.86592567025;26899.86550067237;27261.454770904867;27298.181054568395;35923.46114808332;35993.64006359903;36221.27557448889;36255.45616815697;36282.637173627925;288836;296052;296469;296691;297115;21909.561808764054;22484.213052543084;22533;23691.28926132219;23696.644550332105;39367.80316098516;41901.371479427224;43144.137117258106;46250.30624540567;46603.766981164874;35662.465063023556;36458.45312320264;36833.81583092068;36872.26255474929;37122.25755484929;35659.643403565635;35794;35900.461493078146;36064;36531;35495.82252088723;35607;35889.46165807463;36184.276314473034;36435.08912277108;31689;31855.203619909687;32140.67859321377;32194.517082243317;32749.672503275615;23325.650115247947;23610.52778944446;24046.092834160296;24217.51564968726;24224.51550969006 06:17:14 INFO - PROCESS | 20542 | |2;jquery.html;357.68166331964545;362.48708078069524;363.6835952721131;379.19610425897105;387.4807757604809;16418.83581164188;16768.83231167688;16902.408415705453;17116.31534738609;17180.22688978994;16220.83779162208;17117.144142792873;17530.474085777416;17577.121143942783;17579.38472153475;5029.195328747392;5221.034108689885;5262.473752624726;5262.578993680497;5264.447233040533;3826.1391186982846;4010.9598904011023;5195.792168313263;5705.4294570542825;6065.363136870631;6130.325664176937;6147.938520614782;6148.631082135086;6165.506759459255;6167.32159462461;5867.11993201019;6133.877322453571;6143.539234557426;6154.076888466721;6155.84610384744;3408.6761757632985;4954.207326827726;5336.43967383423;5349.358077030743;5355.384130824966;19978.600427991358;20723.378298651063;20746.688799668016;20779.68830467544;20813.687794683094;1753.8859974101642;1943.8444924406015;1999.5501012272268;2059.969100463494;2128.712623795783;8610.698625548139;8894.510801905893;8934.374593778439;9106.134917182857;12838.229706217657;1750.2473936207425;1801.7567628370134;1820.2355010895324;1848.371553671758;1869.3457289948544;66032.3396766031;67558.66220668914;69005.65497172483;69159;70497.2950270496;9314.72055838326;9381.343305968516;9935;9985.400875947467;10023.69928902134;13750.106243094167;13773.311334433438;13806.378712957941;13808.861911380758;13917.930410347883;7078.398336141383;7207.099112610924;7298.708051677873;7448.292412220831;7463;7050.894236586455;7144.714211431588;7187.820304492325;7283.70865165398;7341.522801017917;4001.199760048002;4017.3686235515784;4033.4756481657196;4109.321961876317;4181.205570941512;1643.786307779981;1687.510621919654;1736.47905628311;1798.1099355818953;1824.1517694272227;770.433731207562;842.2125312832521;888.706726780161;909.8544232922701;922.9570585238772;16294.185290735415;16414.753778693328;16469.423570174986;16972.575685607957;17248;851.8551846186164;865.7878819689216;872.9519876406731;932.9673461428953;957.4973139102027;9556.378835375679;9617.951910240545;9716.125548700651;9725.513724313898;9830.803383932423;375941;377152;384689;385273;387220;75555.24444755592;75817.24182758213;75901;77117.61441192759;77827;922.1838672774643;928.3687092776842;937.9390339627903;943.1605870775015;944.8252073366449;15128.697426051638;15228.46700365482;15255.923720381326;15263.618409539851;15560.533184004498;24778.346948630744;25929.870350648125;33772.493412599324;35775;35798.46302305415;49681.50318496914;51356.22965655443;51525.7423712879;52019.73990130025;52071.47928520666;7097.148342198969;7345.118585769742;7365.1530074042175;7396.186419493959;7437.702491900263;6433.195850518685;9272.350935434724;9688.788901387326;11137.610183643534;12207.328596926898;9992.900070999487;10373.481325933522;10374.533146008296;10580.89419105799;10910.345379277269;9819.9018009819;10771.19216058783;10839.132869370274;10849.349039057683;10909.727256818644;10743.677689669323;10792.838107428552;10821.18841086906;10869.619563315246;11019.889801101886;7494.850102998019;7653.502522336031;7714.768556943301;7814.921850781647;7823.374130069695;10251.538680759235;10371.481425928523;10480.94759526228;10551.683449496528;10705.143588513056 06:17:14 INFO - PROCESS | 20542 | |3;mootools.html;1249.437753011145;1420.112429731418;1463.5389852196558;1575.731536113429;1781.5635169383504;6709.362610551996;7438.330550250476;7682.270184332493;7683.57740324282;7890.289873911347;7642;7793.493422927506;7796.766097017098;7798.259165379294;7804.843903121934;1907.5898681783483;2127.9468013299715;2183.8034576888035;2214.3467677035314;2232.520008198237;2246.0229800036955;2262.2195342606774;2263.151318255654;2266.9319920402413;2268.9659655105106;2197.5934452126326;2205.1730601024615;2240.0591751464426;2240.9103635854544;2240.9439764005865;1839.8988055656935;2097.8531502794813;2127.5213077057692;2157.234181865431;2160.5354848707602;2158.3632828315685;2173.7717539658424;2182.552576721784;2182.9345119646437;2183.6069507488646;7682.1549629540705;7728;7766.18455062216;7769.834524821322;7778;4451.221036318631;4559.6124329431705;4562.771861406916;4562.840300589497;4568.725876447424;2802.761765249956;2864.1550742531003;3018.969810301891;3025.4251692178414;3030.83330416827;895.7088946092546;915.6474757218518;924.7872989212451;937.8358787212279;944.475815922163;10608.045275925127;10703.411312377817;10758.623448179354;10762.623308184176;10798.67603971882;4124.237016152021;4237.258479766028;4290.334998075304;4304.182205380967;4317.978410107929;9226.677066302647;9247.95376023129;9272.397294175991;9283.953580232055;9286.628534858664;4636.675432719677;4703.74129422885;4705.388299521109;4709.929351059737;4710.387649605598;3678.797666128335;4070.715049946475;4213.389058586487;4222.59885310895;4260.190563792869;3699.7780133192095;3699.963000370016;3756.2675278320467;3823.2735780201674;3838.213166300902;1169.92980421175;1177.6761390617648;1185.3776767197119;1196.1806162778526;1198.053537705203;847.7499137754377;863.0980625246632;865.9437136586101;873.0832625742944;874.4054043250524;5158.241571997583;5198;5253.947460525423;5307.416184219733;5361.785528578813;410.8253992053365;413.2726401533323;418.80316251361813;421.47947285102873;423.40300176750634;3694.5935947045805;3766.5668448128818;3790.8294126764363;3796.088938654703;3824.694024478035;9451.905480945103;9716.3198576099;9891;9911.405315681082;9916.900830991743;9631.518424078768;9811.558479868423;9814.411135331902;9824.45965471906;9841.114299713061;7436.219196984347;7453.039990468966;7460.477766556289;7518.248175182438;7534.133574638987;5369.838904832861;5374.516293533601;5422.078246697992;5422.186671999231;5426.375966763715;8891.333150013645;8985.955070224607;9083.318751093826;9104.317176211678;9117.08829117083;8563.657453701782;8804.119588041145;8914.643414263617;8921.776955576162;9168.404053736485;5918.378570250062;6697.430718388991;6821.829454263683;6838.760643377458;6881.965590172017;7687.769366919001;7696.114946780968;7733.845323093619;7734.729284475016;7773.68905243784;6798.286179951034;6861.1080559526945;6985.895211571728;7061.540999834994;7114.964425177841;6849.24658287598;6893.965530172317;6895.379415852597;7037.648117594203;7056.823579410556;6365;6375.968120159369;6444.291127976013;6583.539152259296;6606.339366063356;4618.30725391194;4635.0729854030005;4655.837045703384;4689.155951928686;4736.218523943511;4672.836450724209;4705.694129881546;4708.270218116198;4797.472278049342;4812.1578723722505 06:17:14 INFO - PROCESS | 20542 | |4;prototype.html;284.5220030349014;287.80141702225467;292.56700083875864;297.1338548132195;298.32876028934896;4614.9307760383535;4761.785719642616;4766.428028636568;4820.734859582722;4828.420589529257;4539.659525535581;4670.76646167692;4673.668004618685;4687.789049492772;4688.718676879381;3709.3323201823728;3711.5546134463902;3717.6654101130894;3735.439684047401;3743.513343265385;3528.4883691864666;3582.910427239314;3711;3712.573054098773;3723.664870161685;3660.798656073915;3697.371446854028;3702.685271751891;3706;3721.1999420124666;3661.9084522887006;3663.212409331993;3669.5963444021136;3682.5396825396824;3688.5204923359793;3262.869485220588;3271.8854840080485;3276.8858588080166;3281.2945216778508;3285.2936618626873;4291.6137547620865;4528.660350473695;4536.931946020813;4557.680962332638;4637.281221410687;4105.97947010266;4115.629593336614;4118.979405102985;4128.401381799622;4145.2124096421885;4702.4827269000725;4877.414710234759;4887.291342755316;4918.262260660894;4926.408830940274;3454.671806178409;3460.7368310566712;3463.2900255447826;3475.6176820549717;3477.8434970426138;5171.870703232412;5175;5183.611229157828;5194.948050519484;5197.48025197481;3547.9645203547634;3563.7149028077692;3566.144125409935;3569.089882080053;3577.373959557067;3534.858605655745;3536.204354020325;3576.1059735066233;3589.6410358963894;3592.515010473605;4103.85636502721;4106.1992911382595;4110.362893751473;4115.32097203964;4124.360724087711;4893.21708526634;4896.922677011052;4904.057565460695;4909.337239472626;4917.729524876167;1131.603938621476;1145.7364806094645;1181.4033912874115;1190.2858285029085;1191.326900301327;773.4276635289957;778.2217782217782;778.4239662649599;789.7561340888125;805.8468890910825;3949.2101579683604;3992.161646054303;3998.8206427496502;4004.938691246822;4009.51885773709;4534;4563.315502674559;4564.493717073357;4571.428571428572;4595.471520775153;4042.171354872244;4044.4337792709043;4045.231406032903;4061.9845038740314;4149.585041495826;2717.9400033986763;2742.931426714308;2755.145904769528;2759.227416323433;2765.5989881467076;4912.263160525878;4918.754062296943;4919.401194611694;4932.506749325111;4939.950600494021;5014.52362025607;5268.2097685346735;5290.497402746733;5324.068288049653;5332.306800116037;4869.488703686062;4901.779419926112;4904.239842824368;4905.411350637946;4912.336834527293;5165.173572228426;5173.974130129476;5176.275321454924;5184.403793563638;5194.35070616173;4891.6575839692305;5064.670796398223;5072.365954255718;5109.3613298337705;5109.489051094861;4791.520847915181;4802.6638135330195;4829.73436460998;4858;4878.63410244226;3498.5801703795705;3525.806080665588;3525.942217334738;3531.1701750089223;3535.6641119093647;4927.152317880795;4935.851924442272;5088.898222035465;5103.362079740033;5193.714345711022;4958.900821983612;4970.403551573834;4974.427940786711;4978.8257410990445;4986.900261994812;4942.332785073969;4957.206846904478;4979.278004689228;5008;5017.147084995487;4765.833195838129;4824.638152138534;4867.780949857336;4868.805247790048;4878.78045487961;4947.876303092307;4960.900781984268;4965.851024469272;4977.4773648767805;5016.573591244785;4865.440474345495;4890.462049174517;4892.975535122301;4900.681455705368;4947.307376967299 06:17:14 INFO - PROCESS | 20542 | |5;yui.html;596.5376832954463;602.1599868183883;615.4829942848007;625.8935980883249;632.8607706304614;11962.700932476693;12258.632241032761;12296.323702196376;12382.876171238297;12418.19281746687;12992;13195.2742599157;13216.603501894959;13218.140820846662;13220.471181152743;619.3404024713687;768.5004746914494;775.8099265679916;787.0240901282426;792.4769652029662;799.5762246009624;802.7511471443842;806.1132753970644;806.4032615864277;806.8063664720484;846.7671390367667;847.8812966184739;848.4230723108284;848.5078654380476;848.5545088828353;650.8926027205529;805.138501803071;829.340674164041;831.3349320543541;843.1357858195369;607.465430421231;607.872346807171;607.9331273559905;608.6165715599188;610.4627927423838;12488.625341239687;12626.431810568547;12627.684307892285;12629.305388203646;12762.361881905868;12533.122681412306;12685;12862;13319.26744029078;13368.197908125543;11515.25150865191;11569;11651.650450486499;11780.88219117815;12115;4124.463819703449;4212.946763309173;4236.555161708007;4333.804978775931;4337.306031035019;55307.72346138284;55798.72100639511;56095.15857262144;56450.717746411414;56507.434925650625;9408.341416100808;9909.355891867006;10065.64770233053;10163.593456261815;10310.32982856112;16817.663646726996;16856.915715421343;17242;17248.310067597155;17487.737683934753;6385.265694445198;6468.708908099147;6489.643069631215;6634.104395906587;6656.866862662817;3790.65884070435;3791.3933770597123;3803.7717736935874;3829.1384438501673;3875.3411919973673;2899;2991.7756168287465;3000.3999200160056;3001.309698769295;3003.849807509616;514.452108504449;518.4452635679786;523.6125267302169;527.1881302793731;528.9523942845162;401.45001348152636;512.9051125541787;536.6592213944174;546.2325432766969;568.980155203486;7251.5286506376915;7647.579383133981;7730.845383092306;7750;7776.105747839071;467.95788379046047;528.6537318056679;546.3198318093998;552.8617845538615;571.4656795895768;3731.197792474631;3755.1926335837925;3760.379537376357;3772.550583075839;3777.773333599938;55287.44712552823;88193;88668;91185.54407227921;91273.54363228274;72499.63750181215;75350;77172;77596.2240377589;77905.22094779093;67699.66150169415;69572;69660.65169674119;70517;70952.64523677246;7463.104427468738;7558.941748155153;7791.298783109547;8647.26498247656;8731.912680873364;39889.2022159561;41189.382159267036;41212.793936030124;41334.89988250953;43954.56045439505;51576.74211629068;52551.474485256185;57144.71427642835;57797.422025779204;59825;10914.781704365709;11080.889191108308;11517.308961462339;11624.94187529057;11887.76224475523;12394.132410731523;12398.690032749253;12501.749965000467;13865.168089914638;13935.930320348334;11875.287482751062;12013.339266340436;12276.877231227574;12386.194897331645;12392.008639308653;11371.772564548828;12040.21738586989;12814.1670791402;12902.935485322889;13231.27228002469;11246.894883367675;12232.571859984857;12288.201266917979;12498.812517812423;12890.29103399322;9819.263555233529;10240;10262.486875656337;10295.12491438236;10348.689539313833;10086.445245511568;10533.631322903662;10575.365478071033;10620.09729173029;10682.57269709203 06:17:14 INFO - PROCESS | 20542 | __end_tp_report 06:17:14 INFO - PROCESS | 20542 | __start_cc_report 06:17:14 INFO - PROCESS | 20542 | _x_x_mozilla_cycle_collect,939 06:17:14 INFO - PROCESS | 20542 | __end_cc_report 06:17:14 INFO - PROCESS | 20542 | __startTimestamp1465219034764__endTimestamp 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | ------- Summary: start ------- 06:17:14 INFO - PROCESS | 20542 | Number of tests: 6 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | [#0] dojo.html Cycles:165 Average:4736.87 Median:4876.34 stddev:498.53 (10.2%) stddev-sans-first:473.18 06:17:14 INFO - PROCESS | 20542 | Values: 2678.5 2702.8 2710.2 2728.8 2734.5 4582.0 4686.0 4713.2 4807.6 4837.4 4715.1 4725.9 4729.3 4770.6 4785.1 4290.2 4331.3 4372.2 4410.1 4566.3 4493.1 4519.0 4537.8 4551.2 4578.7 4259.2 4290.7 4292.1 4314.1 4382.9 4321.7 4337.2 4343.9 4344.4 4393.8 4367.9 4391.9 4404.0 4436.8 4449.0 4560.1 4619.3 4669.5 4730.1 4730.5 5107.6 5132.0 5187.9 5190.4 5196.5 5180.4 5212.6 5218.8 5231.1 5240.4 4641.4 4685.5 4733.5 4859.3 4866.9 5207.1 5216.3 5236.9 5252.3 5259.1 4998.5 5040.6 5047.2 5047.5 5051.7 4861.7 5073.5 5122.0 5123.5 5127.2 5083.3 5101.1 5102.5 5109.8 5156.3 5088.5 5094.9 5094.9 5097.8 5099.1 4219.2 4267.0 4271.0 4309.2 4318.7 3795.2 3796.1 3811.1 3839.6 3840.6 4403.8 4477.7 4479.9 4488.6 4490.4 5167.7 5196.3 5197.0 5206.2 5258.0 4454.0 4461.9 4463.4 4469.7 4507.6 4434.1 4548.0 4577.2 4583.9 4598.1 4875.0 4876.3 4876.8 4887.1 4923.1 4880.0 5147.0 5172.6 5192.8 5200.5 4841.2 4855.8 4872.7 4899.8 4920.7 5063.4 5077.3 5080.7 5081.1 5136.4 4891.7 5074.5 5141.4 5146.6 5150.9 4972.9 5002.3 5029.7 5035.5 5084.5 5004.6 5004.8 5012.2 5013.4 5075.3 4833.9 4856.2 4916.2 4917.0 4995.7 5035.5 5047.3 5056.2 5085.3 5101.2 4929.4 4932.6 4938.6 4941.2 4991.1 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | [#1] ext.html Cycles:180 Average:45079.70 Median:19582.28 stddev:83877.31 (428.3%) stddev-sans-first:84046.00 06:17:14 INFO - PROCESS | 20542 | Values: 561.2 594.0 599.0 601.4 618.3 28476.0 29533.3 38749.0 39929.0 40053.8 38359.6 38938.6 38942.8 38949.2 38995.6 7633.9 7788.1 7790.6 7818.4 7818.6 7615.0 7727.3 7739.0 7743.1 7744.0 7746.4 7785.9 7786.1 7790.3 7792.4 7715.4 7755.2 7756.3 7757.0 7761.2 7570.9 7616.5 7650.6 7664.2 7665.4 35427.5 35759.3 35862.8 35868.8 35882.6 2880.4 3054.8 3077.3 3089.8 3130.5 27969.7 28156.4 28634.7 28751.4 29095.3 3522.5 3524.7 3543.4 3557.6 3596.9 254613.0 256581.0 257549.0 259096.0 259260.7 31497.8 32473.4 54679.0 55095.4 55214.2 33784.3 33823.3 33976.5 34082.0 34086.7 12532.9 12600.7 12620.9 12634.2 12651.6 10076.0 10084.7 10085.8 10102.2 10147.8 7929.4 7951.3 7958.6 8009.2 8040.4 3097.6 3125.8 3128.7 3163.1 3166.8 879.3 920.6 1004.7 1019.5 1021.3 25572.4 26514.0 26525.3 26960.6 27040.6 791.7 947.8 1018.2 1030.9 1033.5 13686.7 14170.6 14235.1 14266.4 14430.6 383854.0 386903.0 387165.0 387451.0 388486.0 47760.8 48161.3 48189.3 48304.3 48308.8 1081.1 1202.7 1204.8 1242.5 1252.7 26010.3 26814.9 26899.9 27261.5 27298.2 35923.5 35993.6 36221.3 36255.5 36282.6 288836.0 296052.0 296469.0 296691.0 297115.0 21909.6 22484.2 22533.0 23691.3 23696.6 39367.8 41901.4 43144.1 46250.3 46603.8 35662.5 36458.5 36833.8 36872.3 37122.3 35659.6 35794.0 35900.5 36064.0 36531.0 35495.8 35607.0 35889.5 36184.3 36435.1 31689.0 31855.2 32140.7 32194.5 32749.7 23325.7 23610.5 24046.1 24217.5 24224.5 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | [#2] jquery.html Cycles:180 Average:23908.33 Median:27317.86 stddev:63094.46 (231.0%) stddev-sans-first:63246.68 06:17:14 INFO - PROCESS | 20542 | Values: 357.7 362.5 363.7 379.2 387.5 16418.8 16768.8 16902.4 17116.3 17180.2 16220.8 17117.1 17530.5 17577.1 17579.4 5029.2 5221.0 5262.5 5262.6 5264.4 3826.1 4011.0 5195.8 5705.4 6065.4 6130.3 6147.9 6148.6 6165.5 6167.3 5867.1 6133.9 6143.5 6154.1 6155.8 3408.7 4954.2 5336.4 5349.4 5355.4 19978.6 20723.4 20746.7 20779.7 20813.7 1753.9 1943.8 1999.6 2060.0 2128.7 8610.7 8894.5 8934.4 9106.1 12838.2 1750.2 1801.8 1820.2 1848.4 1869.3 66032.3 67558.7 69005.7 69159.0 70497.3 9314.7 9381.3 9935.0 9985.4 10023.7 13750.1 13773.3 13806.4 13808.9 13917.9 7078.4 7207.1 7298.7 7448.3 7463.0 7050.9 7144.7 7187.8 7283.7 7341.5 4001.2 4017.4 4033.5 4109.3 4181.2 1643.8 1687.5 1736.5 1798.1 1824.2 770.4 842.2 888.7 909.9 923.0 16294.2 16414.8 16469.4 16972.6 17248.0 851.9 865.8 873.0 933.0 957.5 9556.4 9618.0 9716.1 9725.5 9830.8 375941.0 377152.0 384689.0 385273.0 387220.0 75555.2 75817.2 75901.0 77117.6 77827.0 922.2 928.4 937.9 943.2 944.8 15128.7 15228.5 15255.9 15263.6 15560.5 24778.3 25929.9 33772.5 35775.0 35798.5 49681.5 51356.2 51525.7 52019.7 52071.5 7097.1 7345.1 7365.2 7396.2 7437.7 6433.2 9272.4 9688.8 11137.6 12207.3 9992.9 10373.5 10374.5 10580.9 10910.3 9819.9 10771.2 10839.1 10849.3 10909.7 10743.7 10792.8 10821.2 10869.6 11019.9 7494.9 7653.5 7714.8 7814.9 7823.4 10251.5 10371.5 10480.9 10551.7 10705.1 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | [#3] mootools.html Cycles:180 Average:5182.52 Median:5178.12 stddev:2921.57 (56.4%) stddev-sans-first:2914.81 06:17:14 INFO - PROCESS | 20542 | Values: 1249.4 1420.1 1463.5 1575.7 1781.6 6709.4 7438.3 7682.3 7683.6 7890.3 7642.0 7793.5 7796.8 7798.3 7804.8 1907.6 2127.9 2183.8 2214.3 2232.5 2246.0 2262.2 2263.2 2266.9 2269.0 2197.6 2205.2 2240.1 2240.9 2240.9 1839.9 2097.9 2127.5 2157.2 2160.5 2158.4 2173.8 2182.6 2182.9 2183.6 7682.2 7728.0 7766.2 7769.8 7778.0 4451.2 4559.6 4562.8 4562.8 4568.7 2802.8 2864.2 3019.0 3025.4 3030.8 895.7 915.6 924.8 937.8 944.5 10608.0 10703.4 10758.6 10762.6 10798.7 4124.2 4237.3 4290.3 4304.2 4318.0 9226.7 9248.0 9272.4 9284.0 9286.6 4636.7 4703.7 4705.4 4709.9 4710.4 3678.8 4070.7 4213.4 4222.6 4260.2 3699.8 3700.0 3756.3 3823.3 3838.2 1169.9 1177.7 1185.4 1196.2 1198.1 847.7 863.1 865.9 873.1 874.4 5158.2 5198.0 5253.9 5307.4 5361.8 410.8 413.3 418.8 421.5 423.4 3694.6 3766.6 3790.8 3796.1 3824.7 9451.9 9716.3 9891.0 9911.4 9916.9 9631.5 9811.6 9814.4 9824.5 9841.1 7436.2 7453.0 7460.5 7518.2 7534.1 5369.8 5374.5 5422.1 5422.2 5426.4 8891.3 8986.0 9083.3 9104.3 9117.1 8563.7 8804.1 8914.6 8921.8 9168.4 5918.4 6697.4 6821.8 6838.8 6882.0 7687.8 7696.1 7733.8 7734.7 7773.7 6798.3 6861.1 6985.9 7061.5 7115.0 6849.2 6894.0 6895.4 7037.6 7056.8 6365.0 6376.0 6444.3 6583.5 6606.3 4618.3 4635.1 4655.8 4689.2 4736.2 4672.8 4705.7 4708.3 4797.5 4812.2 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | [#4] prototype.html Cycles:180 Average:4075.46 Median:4626.11 stddev:1202.97 (26.0%) stddev-sans-first:1172.22 06:17:14 INFO - PROCESS | 20542 | Values: 284.5 287.8 292.6 297.1 298.3 4614.9 4761.8 4766.4 4820.7 4828.4 4539.7 4670.8 4673.7 4687.8 4688.7 3709.3 3711.6 3717.7 3735.4 3743.5 3528.5 3582.9 3711.0 3712.6 3723.7 3660.8 3697.4 3702.7 3706.0 3721.2 3661.9 3663.2 3669.6 3682.5 3688.5 3262.9 3271.9 3276.9 3281.3 3285.3 4291.6 4528.7 4536.9 4557.7 4637.3 4106.0 4115.6 4119.0 4128.4 4145.2 4702.5 4877.4 4887.3 4918.3 4926.4 3454.7 3460.7 3463.3 3475.6 3477.8 5171.9 5175.0 5183.6 5194.9 5197.5 3548.0 3563.7 3566.1 3569.1 3577.4 3534.9 3536.2 3576.1 3589.6 3592.5 4103.9 4106.2 4110.4 4115.3 4124.4 4893.2 4896.9 4904.1 4909.3 4917.7 1131.6 1145.7 1181.4 1190.3 1191.3 773.4 778.2 778.4 789.8 805.8 3949.2 3992.2 3998.8 4004.9 4009.5 4534.0 4563.3 4564.5 4571.4 4595.5 4042.2 4044.4 4045.2 4062.0 4149.6 2717.9 2742.9 2755.1 2759.2 2765.6 4912.3 4918.8 4919.4 4932.5 4940.0 5014.5 5268.2 5290.5 5324.1 5332.3 4869.5 4901.8 4904.2 4905.4 4912.3 5165.2 5174.0 5176.3 5184.4 5194.4 4891.7 5064.7 5072.4 5109.4 5109.5 4791.5 4802.7 4829.7 4858.0 4878.6 3498.6 3525.8 3525.9 3531.2 3535.7 4927.2 4935.9 5088.9 5103.4 5193.7 4958.9 4970.4 4974.4 4978.8 4986.9 4942.3 4957.2 4979.3 5008.0 5017.1 4765.8 4824.6 4867.8 4868.8 4878.8 4947.9 4960.9 4965.9 4977.5 5016.6 4865.4 4890.5 4893.0 4900.7 4947.3 06:17:14 INFO - PROCESS | 20542 | 06:17:14 INFO - PROCESS | 20542 | [#5] yui.html Cycles:180 Average:16579.76 Median:4335.56 stddev:22539.79 (519.9%) stddev-sans-first:22571.06 06:17:14 INFO - PROCESS | 20542 | Values: 596.5 602.2 615.5 625.9 632.9 11962.7 12258.6 12296.3 12382.9 12418.2 12992.0 13195.3 13216.6 13218.1 13220.5 619.3 768.5 775.8 787.0 792.5 799.6 802.8 806.1 806.4 806.8 846.8 847.9 848.4 848.5 848.6 650.9 805.1 829.3 831.3 843.1 607.5 607.9 607.9 608.6 610.5 12488.6 12626.4 12627.7 12629.3 12762.4 12533.1 12685.0 12862.0 13319.3 13368.2 11515.3 11569.0 11651.7 11780.9 12115.0 4124.5 4212.9 4236.6 4333.8 4337.3 55307.7 55798.7 56095.2 56450.7 56507.4 9408.3 9909.4 10065.6 10163.6 10310.3 16817.7 16856.9 17242.0 17248.3 17487.7 6385.3 6468.7 6489.6 6634.1 6656.9 3790.7 3791.4 3803.8 3829.1 3875.3 2899.0 2991.8 3000.4 3001.3 3003.8 514.5 518.4 523.6 527.2 529.0 401.5 512.9 536.7 546.2 569.0 7251.5 7647.6 7730.8 7750.0 7776.1 468.0 528.7 546.3 552.9 571.5 3731.2 3755.2 3760.4 3772.6 3777.8 55287.4 88193.0 88668.0 91185.5 91273.5 72499.6 75350.0 77172.0 77596.2 77905.2 67699.7 69572.0 69660.7 70517.0 70952.6 7463.1 7558.9 7791.3 8647.3 8731.9 39889.2 41189.4 41212.8 41334.9 43954.6 51576.7 52551.5 57144.7 57797.4 59825.0 10914.8 11080.9 11517.3 11624.9 11887.8 12394.1 12398.7 12501.7 13865.2 13935.9 11875.3 12013.3 12276.9 12386.2 12392.0 11371.8 12040.2 12814.2 12902.9 13231.3 11246.9 12232.6 12288.2 12498.8 12890.3 9819.3 10240.0 10262.5 10295.1 10348.7 10086.4 10533.6 10575.4 10620.1 10682.6 06:17:14 INFO - PROCESS | 20542 | -------- Summary: end -------- 06:17:14 INFO - PROCESS | 20542 | 06:17:15 INFO - TEST-INFO | 20542: exit 0 06:17:15 INFO - TEST-OK | dromaeo_css | took 1119125ms 06:17:15 INFO - TEST-START | kraken 06:17:15 INFO - operating with platform_type : linux_ 06:17:15 INFO - Initialising browser for kraken test... 06:17:15 INFO - TEST-INFO | started process 20725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoAvKoI/profile http://localhost:59720/getInfo.html) 06:17:19 INFO - PROCESS | 20725 | __metrics Screen width/height:1600/1200 06:17:19 INFO - PROCESS | 20725 | colorDepth:24 06:17:19 INFO - PROCESS | 20725 | Browser inner width/height: 1024/697 06:17:19 INFO - PROCESS | 20725 | __metrics 06:17:20 ERROR - PROCESS | 20725 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:21 INFO - PROCESS | 20725 | console.error: PushService: 06:17:21 INFO - PROCESS | 20725 | stateChangeProcessEnqueue: Error transitioning state 06:17:21 INFO - PROCESS | 20725 | UnknownError 06:17:21 INFO - TEST-INFO | 20725: exit 0 06:17:21 INFO - Browser initialized. 06:17:21 INFO - Running cycle 1/1 for kraken test... 06:17:21 INFO - TEST-INFO | started process 20806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoAvKoI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:33 INFO - PROCESS | 20806 | RSS: Main: 157200384 06:17:33 INFO - PROCESS | 20806 | 06:17:36 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:37 INFO - PROCESS | 20806 | RSS: Main: 215736320 06:17:37 INFO - PROCESS | 20806 | 06:17:40 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-dft) 06:17:40 INFO - PROCESS | 20806 | RSS: Main: 202612736 06:17:40 INFO - PROCESS | 20806 | 06:17:44 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-fft) 06:17:44 INFO - PROCESS | 20806 | RSS: Main: 270393344 06:17:44 INFO - PROCESS | 20806 | 06:17:46 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-oscillator) 06:17:47 INFO - PROCESS | 20806 | RSS: Main: 180465664 06:17:47 INFO - PROCESS | 20806 | 06:17:49 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:50 INFO - PROCESS | 20806 | RSS: Main: 183885824 06:17:50 INFO - PROCESS | 20806 | 06:17:53 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:54 INFO - PROCESS | 20806 | RSS: Main: 220360704 06:17:54 INFO - PROCESS | 20806 | 06:17:57 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:58 INFO - PROCESS | 20806 | RSS: Main: 216371200 06:17:58 INFO - PROCESS | 20806 | 06:18:01 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59720/tests/kraken/driver.html?testName=json-parse-financial) 06:18:01 INFO - PROCESS | 20806 | RSS: Main: 219787264 06:18:01 INFO - PROCESS | 20806 | 06:18:03 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:04 INFO - PROCESS | 20806 | RSS: Main: 208658432 06:18:04 INFO - PROCESS | 20806 | 06:18:05 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:06 INFO - PROCESS | 20806 | RSS: Main: 211898368 06:18:06 INFO - PROCESS | 20806 | 06:18:08 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:09 INFO - PROCESS | 20806 | RSS: Main: 216129536 06:18:09 INFO - PROCESS | 20806 | 06:18:12 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:12 INFO - PROCESS | 20806 | RSS: Main: 222617600 06:18:12 INFO - PROCESS | 20806 | 06:18:15 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:16 INFO - PROCESS | 20806 | RSS: Main: 222523392 06:18:16 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59720/tests/kraken/driver.html?testName=ai-astar) 06:18:18 INFO - PROCESS | 20806 | RSS: Main: 265199616 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | __start_tp_report 06:18:18 INFO - PROCESS | 20806 | _x_x_mozilla_page_load 06:18:18 INFO - PROCESS | 20806 | _x_x_mozilla_page_load_details 06:18:18 INFO - PROCESS | 20806 | |i|pagename|runs| 06:18:18 INFO - PROCESS | 20806 | |0;ai-astar;113;109;113;113;112;113;112;113;113;111 06:18:18 INFO - PROCESS | 20806 | |1;audio-beat-detection;172;143;131;196;130;168;151;129;189;130 06:18:18 INFO - PROCESS | 20806 | |2;audio-dft;162;161;161;162;161;162;163;163;163;162 06:18:18 INFO - PROCESS | 20806 | |3;audio-fft;75;76;76;129;76;77;75;75;101;76 06:18:18 INFO - PROCESS | 20806 | |4;audio-oscillator;87;86;115;85;86;88;116;86;86;125 06:18:18 INFO - PROCESS | 20806 | |5;imaging-gaussian-blur;116;116;116;117;117;116;117;117;117;117 06:18:18 INFO - PROCESS | 20806 | |6;imaging-darkroom;146;146;146;145;145;146;147;146;146;145 06:18:18 INFO - PROCESS | 20806 | |7;imaging-desaturate;95;94;95;95;95;95;94;94;95;95 06:18:18 INFO - PROCESS | 20806 | |8;json-parse-financial;64;64;66;65;66;67;76;64;64;64 06:18:18 INFO - PROCESS | 20806 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;65;66;66 06:18:18 INFO - PROCESS | 20806 | |10;stanford-crypto-aes;83;84;84;89;84;91;84;86;126;94 06:18:18 INFO - PROCESS | 20806 | |11;stanford-crypto-ccm;133;132;131;128;129;128;128;131;135;141 06:18:18 INFO - PROCESS | 20806 | |12;stanford-crypto-pbkdf2;174;171;174;171;169;170;168;168;170;169 06:18:18 INFO - PROCESS | 20806 | |13;stanford-crypto-sha256-iterative;67;66;69;67;66;65;67;66;67;66 06:18:18 INFO - PROCESS | 20806 | __end_tp_report 06:18:18 INFO - PROCESS | 20806 | __start_cc_report 06:18:18 INFO - PROCESS | 20806 | _x_x_mozilla_cycle_collect,1878 06:18:18 INFO - PROCESS | 20806 | __end_cc_report 06:18:18 INFO - PROCESS | 20806 | __startTimestamp1465219098374__endTimestamp 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | ------- Summary: start ------- 06:18:18 INFO - PROCESS | 20806 | Number of tests: 14 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:1.32 (1.2%) stddev-sans-first:1.36 06:18:18 INFO - PROCESS | 20806 | Values: 113.0 109.0 113.0 113.0 112.0 113.0 112.0 113.0 113.0 111.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:159.50 stddev:25.70 (16.1%) stddev-sans-first:26.41 06:18:18 INFO - PROCESS | 20806 | Values: 172.0 143.0 131.0 196.0 130.0 168.0 151.0 129.0 189.0 130.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:18:18 INFO - PROCESS | 20806 | Values: 162.0 161.0 161.0 162.0 161.0 162.0 163.0 163.0 163.0 162.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:17.83 (23.5%) stddev-sans-first:18.64 06:18:18 INFO - PROCESS | 20806 | Values: 75.0 76.0 76.0 129.0 76.0 77.0 75.0 75.0 101.0 76.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:86.00 stddev:15.87 (18.5%) stddev-sans-first:16.50 06:18:18 INFO - PROCESS | 20806 | Values: 87.0 86.0 115.0 85.0 86.0 88.0 116.0 86.0 86.0 125.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:18:18 INFO - PROCESS | 20806 | Values: 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:18:18 INFO - PROCESS | 20806 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 147.0 146.0 146.0 145.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:18:18 INFO - PROCESS | 20806 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:65.50 stddev:3.68 (5.6%) stddev-sans-first:3.83 06:18:18 INFO - PROCESS | 20806 | Values: 64.0 64.0 66.0 65.0 66.0 67.0 76.0 64.0 64.0 64.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:18:18 INFO - PROCESS | 20806 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:85.00 stddev:13.00 (15.3%) stddev-sans-first:13.50 06:18:18 INFO - PROCESS | 20806 | Values: 83.0 84.0 84.0 89.0 84.0 91.0 84.0 86.0 126.0 94.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:131.50 stddev:4.06 (3.1%) stddev-sans-first:4.28 06:18:18 INFO - PROCESS | 20806 | Values: 133.0 132.0 131.0 128.0 129.0 128.0 128.0 131.0 135.0 141.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:170.50 stddev:2.17 (1.3%) stddev-sans-first:1.87 06:18:18 INFO - PROCESS | 20806 | Values: 174.0 171.0 174.0 171.0 169.0 170.0 168.0 168.0 170.0 169.0 06:18:18 INFO - PROCESS | 20806 | 06:18:18 INFO - PROCESS | 20806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 06:18:18 INFO - PROCESS | 20806 | Values: 67.0 66.0 69.0 67.0 66.0 65.0 67.0 66.0 67.0 66.0 06:18:18 INFO - PROCESS | 20806 | -------- Summary: end -------- 06:18:18 INFO - PROCESS | 20806 | 06:18:19 INFO - TEST-INFO | 20806: exit 0 06:18:19 INFO - TEST-OK | kraken | took 63932ms 06:18:19 INFO - SUITE-END | took 1183s 06:18:19 INFO - Completed test suite (00:19:43) 06:18:19 INFO - javascript benchmark 06:18:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.54464740994, 2702.8243164194328, 2710.227585138236, 2728.7816974642033, 2734.4667789781, 4581.954180458194, 4686.039361930804, 4713.222318317477, 4807.6153907687385, 4837.419509658842, 4715.08055929094, 4725.8582242532775, 4729.31424943383, 4770.594499467541, 4785.0908327417765, 4290.184864875671, 4331.328644060176, 4372.191144638252, 4410.117976404716, 4566.269396896497, 4493.056458143794, 4518.97740511297, 4537.795799189028, 4551.1580357633775, 4578.748168850712, 4259.212045771511, 4290.742555446652, 4292.098659281554, 4314.094040251551, 4382.868513944571, 4321.7406955582455, 4337.1976184405985, 4343.891402714926, 4344.370066340394, 4393.824247030115, 4367.890802729926, 4391.912161756779, 4403.9870829709025, 4436.778161091933, 4448.977755111204, 4560.110778398213, 4619.260918253097, 4669.533046695337, 4730.148573256813, 4730.455997560291, 5107.591392688576, 5131.974340128313, 5187.922181167285, 5190.4031036430915, 5196.480351964811, 5180.404253510819, 5212.582993360522, 5218.843434696965, 5231.110711179071, 5240.371155461331, 4641.373414589055, 4685.531446855287, 4733.502982186889, 4859.343988561534, 4866.853994380139, 5207.140821764442, 5216.26972223889, 5236.92144617831, 5252.317198764136, 5259.079661059376, 4998.450170481244, 5040.621953353513, 5047.2429135629945, 5047.4952504749235, 5051.6716413433005, 4861.6596838220985, 5073.543381095719, 5122.026814905156, 5123.487651234846, 5127.2052831811125, 5083.313752643346, 5101.132807422747, 5102.540771330598, 5109.846704598868, 5156.303898973591, 5088.542031217208, 5094.923576146361, 5094.949050509522, 5097.7706003229205, 5099.133147364957, 4219.198352313051, 4267.039916018933, 4270.996315865769, 4309.224339618836, 4318.740875547477, 3795.221979494197, 3796.088938654703, 3811.104390468238, 3839.5584507781405, 3840.5967373425947, 4403.801828917706, 4477.70894891831, 4479.888002799891, 4488.640908727294, 4490.438695163105, 5167.6641018333685, 5196.274481588237, 5197.038547868657, 5206.245094461282, 5258.027264955996, 4453.955460445419, 4461.933071003938, 4463.352813841975, 4469.7318160910445, 4507.616852567503, 4434.11317736454, 4547.954520454819, 4577.22187228172, 4583.931241031387, 4598.149342371672, 4875.0, 4876.341693871282, 4876.829310974099, 4887.120318342732, 4923.138450771101, 4879.951200488092, 5147.0, 5172.586193104467, 5192.818251361185, 5200.531952124327, 4841.2496063110275, 4855.830045948375, 4872.6832755870755, 4899.828506002415, 4920.6555541111775, 5063.367079115111, 5077.339945807022, 5080.7205603692155, 5081.136206844919, 5136.383633963948, 4891.73095479752, 5074.517920797518, 5141.408737995179, 5146.588272938081, 5150.948490515197, 4972.881101752077, 5002.349694539686, 5029.74851257443, 5035.496450354935, 5084.466131056186, 5004.5746111579465, 5004.799808007784, 5012.198048312398, 5013.39839219296, 5075.3148324975655, 4833.927491087707, 4856.223004319292, 4916.188828843344, 4916.975415122902, 4995.675281106716, 5035.496450354935, 5047.268146118866, 5056.191009438619, 5085.338905942203, 5101.20931255656, 4929.408470983505, 4932.580730637936, 4938.604911606991, 4941.184704523714, 4991.101601711727], "value": 4705.364825677006, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1750726432143, 593.9724277000788, 598.9727617136609, 601.3835818286256, 618.3229363846586, 28476.0, 29533.2616684583, 38749.0, 39929.0, 40053.799731001374, 38359.61640383596, 38938.610613893856, 38942.80528597353, 38949.221015579744, 38995.61004389955, 7633.923660763391, 7788.14330423653, 7790.610469476504, 7818.374530037612, 7818.569978651172, 7615.0, 7727.304542591166, 7738.961305193466, 7743.148253692089, 7744.0, 7746.4190185736015, 7785.883211751829, 7786.104597971221, 7790.337821285169, 7792.415568832332, 7715.421343399267, 7755.185705500898, 7756.34071103954, 7756.961215193945, 7761.22387761225, 7570.924290757077, 7616.504927179771, 7650.579218143055, 7664.195259497784, 7665.386769058462, 35427.4685879712, 35759.28481430383, 35862.820685896666, 35868.820655896816, 35882.641173588454, 2880.438314528668, 3054.831984240866, 3077.292222788749, 3089.7837151399413, 3130.467820470503, 27969.72030279712, 28156.436871262664, 28634.713652863622, 28751.424971500663, 29095.272618184503, 3522.5420695309704, 3524.731096805148, 3543.362194804934, 3557.5553055868018, 3596.9100772480638, 254613.0, 256581.0, 257549.0, 259096.0, 259260.7036964822, 31497.8425107873, 32473.350532989207, 54679.0, 55095.38855337385, 55214.17178742322, 33784.32431351359, 33823.32353352919, 33976.49035264473, 34082.0, 34086.659133408844, 12532.937335313265, 12600.684982875318, 12620.873791262153, 12634.178778379375, 12651.557195498297, 10075.992400760011, 10084.69745907624, 10085.798284034277, 10102.19182465401, 10147.847782283272, 7929.44493885434, 7951.284384405431, 7958.602069896482, 8009.159038301011, 8040.35677145827, 3097.550855125994, 3125.812451252932, 3128.671489493616, 3163.114327988167, 3166.8099914005234, 879.2745984562762, 920.5627327019746, 1004.6785028790863, 1019.5361110694616, 1021.2953062386929, 25572.360690982874, 26514.0, 26525.33686657849, 26960.59559106615, 27040.59439108415, 791.6872835230051, 947.824652439301, 1018.1919620618833, 1030.90206430389, 1033.503918119307, 13686.726265474636, 14170.645733856736, 14235.145891246559, 14266.3580138894, 14430.567082987527, 383854.0, 386903.0, 387165.0, 387451.0, 388486.0, 47760.76119619449, 48161.277580836315, 48189.27716084261, 48304.275435867785, 48308.75845620749, 1081.1080858291941, 1202.6812894582943, 1204.8253003314471, 1242.4657397319058, 1252.661781319057, 26010.34974125662, 26814.86592567025, 26899.86550067237, 27261.454770904867, 27298.181054568395, 35923.46114808332, 35993.64006359903, 36221.27557448889, 36255.45616815697, 36282.637173627925, 288836.0, 296052.0, 296469.0, 296691.0, 297115.0, 21909.561808764054, 22484.213052543084, 22533.0, 23691.28926132219, 23696.644550332105, 39367.80316098516, 41901.371479427224, 43144.137117258106, 46250.30624540567, 46603.766981164874, 35662.465063023556, 36458.45312320264, 36833.81583092068, 36872.26255474929, 37122.25755484929, 35659.643403565635, 35794.0, 35900.461493078146, 36064.0, 36531.0, 35495.82252088723, 35607.0, 35889.46165807463, 36184.276314473034, 36435.08912277108, 31689.0, 31855.203619909687, 32140.67859321377, 32194.517082243317, 32749.672503275615, 23325.650115247947, 23610.52778944446, 24046.092834160296, 24217.51564968726, 24224.51550969006], "value": 16063.099173697032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.68166331964545, 362.48708078069524, 363.6835952721131, 379.19610425897105, 387.4807757604809, 16418.83581164188, 16768.83231167688, 16902.408415705453, 17116.31534738609, 17180.22688978994, 16220.83779162208, 17117.144142792873, 17530.474085777416, 17577.121143942783, 17579.38472153475, 5029.195328747392, 5221.034108689885, 5262.473752624726, 5262.578993680497, 5264.447233040533, 3826.1391186982846, 4010.9598904011023, 5195.792168313263, 5705.4294570542825, 6065.363136870631, 6130.325664176937, 6147.938520614782, 6148.631082135086, 6165.506759459255, 6167.32159462461, 5867.11993201019, 6133.877322453571, 6143.539234557426, 6154.076888466721, 6155.84610384744, 3408.6761757632985, 4954.207326827726, 5336.43967383423, 5349.358077030743, 5355.384130824966, 19978.600427991358, 20723.378298651063, 20746.688799668016, 20779.68830467544, 20813.687794683094, 1753.8859974101642, 1943.8444924406015, 1999.5501012272268, 2059.969100463494, 2128.712623795783, 8610.698625548139, 8894.510801905893, 8934.374593778439, 9106.134917182857, 12838.229706217657, 1750.2473936207425, 1801.7567628370134, 1820.2355010895324, 1848.371553671758, 1869.3457289948544, 66032.3396766031, 67558.66220668914, 69005.65497172483, 69159.0, 70497.2950270496, 9314.72055838326, 9381.343305968516, 9935.0, 9985.400875947467, 10023.69928902134, 13750.106243094167, 13773.311334433438, 13806.378712957941, 13808.861911380758, 13917.930410347883, 7078.398336141383, 7207.099112610924, 7298.708051677873, 7448.292412220831, 7463.0, 7050.894236586455, 7144.714211431588, 7187.820304492325, 7283.70865165398, 7341.522801017917, 4001.199760048002, 4017.3686235515784, 4033.4756481657196, 4109.321961876317, 4181.205570941512, 1643.786307779981, 1687.510621919654, 1736.47905628311, 1798.1099355818953, 1824.1517694272227, 770.433731207562, 842.2125312832521, 888.706726780161, 909.8544232922701, 922.9570585238772, 16294.185290735415, 16414.753778693328, 16469.423570174986, 16972.575685607957, 17248.0, 851.8551846186164, 865.7878819689216, 872.9519876406731, 932.9673461428953, 957.4973139102027, 9556.378835375679, 9617.951910240545, 9716.125548700651, 9725.513724313898, 9830.803383932423, 375941.0, 377152.0, 384689.0, 385273.0, 387220.0, 75555.24444755592, 75817.24182758213, 75901.0, 77117.61441192759, 77827.0, 922.1838672774643, 928.3687092776842, 937.9390339627903, 943.1605870775015, 944.8252073366449, 15128.697426051638, 15228.46700365482, 15255.923720381326, 15263.618409539851, 15560.533184004498, 24778.346948630744, 25929.870350648125, 33772.493412599324, 35775.0, 35798.46302305415, 49681.50318496914, 51356.22965655443, 51525.7423712879, 52019.73990130025, 52071.47928520666, 7097.148342198969, 7345.118585769742, 7365.1530074042175, 7396.186419493959, 7437.702491900263, 6433.195850518685, 9272.350935434724, 9688.788901387326, 11137.610183643534, 12207.328596926898, 9992.900070999487, 10373.481325933522, 10374.533146008296, 10580.89419105799, 10910.345379277269, 9819.9018009819, 10771.19216058783, 10839.132869370274, 10849.349039057683, 10909.727256818644, 10743.677689669323, 10792.838107428552, 10821.18841086906, 10869.619563315246, 11019.889801101886, 7494.850102998019, 7653.502522336031, 7714.768556943301, 7814.921850781647, 7823.374130069695, 10251.538680759235, 10371.481425928523, 10480.94759526228, 10551.683449496528, 10705.143588513056], "value": 8182.333411420393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.437753011145, 1420.112429731418, 1463.5389852196558, 1575.731536113429, 1781.5635169383504, 6709.362610551996, 7438.330550250476, 7682.270184332493, 7683.57740324282, 7890.289873911347, 7642.0, 7793.493422927506, 7796.766097017098, 7798.259165379294, 7804.843903121934, 1907.5898681783483, 2127.9468013299715, 2183.8034576888035, 2214.3467677035314, 2232.520008198237, 2246.0229800036955, 2262.2195342606774, 2263.151318255654, 2266.9319920402413, 2268.9659655105106, 2197.5934452126326, 2205.1730601024615, 2240.0591751464426, 2240.9103635854544, 2240.9439764005865, 1839.8988055656935, 2097.8531502794813, 2127.5213077057692, 2157.234181865431, 2160.5354848707602, 2158.3632828315685, 2173.7717539658424, 2182.552576721784, 2182.9345119646437, 2183.6069507488646, 7682.1549629540705, 7728.0, 7766.18455062216, 7769.834524821322, 7778.0, 4451.221036318631, 4559.6124329431705, 4562.771861406916, 4562.840300589497, 4568.725876447424, 2802.761765249956, 2864.1550742531003, 3018.969810301891, 3025.4251692178414, 3030.83330416827, 895.7088946092546, 915.6474757218518, 924.7872989212451, 937.8358787212279, 944.475815922163, 10608.045275925127, 10703.411312377817, 10758.623448179354, 10762.623308184176, 10798.67603971882, 4124.237016152021, 4237.258479766028, 4290.334998075304, 4304.182205380967, 4317.978410107929, 9226.677066302647, 9247.95376023129, 9272.397294175991, 9283.953580232055, 9286.628534858664, 4636.675432719677, 4703.74129422885, 4705.388299521109, 4709.929351059737, 4710.387649605598, 3678.797666128335, 4070.715049946475, 4213.389058586487, 4222.59885310895, 4260.190563792869, 3699.7780133192095, 3699.963000370016, 3756.2675278320467, 3823.2735780201674, 3838.213166300902, 1169.92980421175, 1177.6761390617648, 1185.3776767197119, 1196.1806162778526, 1198.053537705203, 847.7499137754377, 863.0980625246632, 865.9437136586101, 873.0832625742944, 874.4054043250524, 5158.241571997583, 5198.0, 5253.947460525423, 5307.416184219733, 5361.785528578813, 410.8253992053365, 413.2726401533323, 418.80316251361813, 421.47947285102873, 423.40300176750634, 3694.5935947045805, 3766.5668448128818, 3790.8294126764363, 3796.088938654703, 3824.694024478035, 9451.905480945103, 9716.3198576099, 9891.0, 9911.405315681082, 9916.900830991743, 9631.518424078768, 9811.558479868423, 9814.411135331902, 9824.45965471906, 9841.114299713061, 7436.219196984347, 7453.039990468966, 7460.477766556289, 7518.248175182438, 7534.133574638987, 5369.838904832861, 5374.516293533601, 5422.078246697992, 5422.186671999231, 5426.375966763715, 8891.333150013645, 8985.955070224607, 9083.318751093826, 9104.317176211678, 9117.08829117083, 8563.657453701782, 8804.119588041145, 8914.643414263617, 8921.776955576162, 9168.404053736485, 5918.378570250062, 6697.430718388991, 6821.829454263683, 6838.760643377458, 6881.965590172017, 7687.769366919001, 7696.114946780968, 7733.845323093619, 7734.729284475016, 7773.68905243784, 6798.286179951034, 6861.1080559526945, 6985.895211571728, 7061.540999834994, 7114.964425177841, 6849.24658287598, 6893.965530172317, 6895.379415852597, 7037.648117594203, 7056.823579410556, 6365.0, 6375.968120159369, 6444.291127976013, 6583.539152259296, 6606.339366063356, 4618.30725391194, 4635.0729854030005, 4655.837045703384, 4689.155951928686, 4736.218523943511, 4672.836450724209, 4705.694129881546, 4708.270218116198, 4797.472278049342, 4812.1578723722505], "value": 4101.022706798907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.5220030349014, 287.80141702225467, 292.56700083875864, 297.1338548132195, 298.32876028934896, 4614.9307760383535, 4761.785719642616, 4766.428028636568, 4820.734859582722, 4828.420589529257, 4539.659525535581, 4670.76646167692, 4673.668004618685, 4687.789049492772, 4688.718676879381, 3709.3323201823728, 3711.5546134463902, 3717.6654101130894, 3735.439684047401, 3743.513343265385, 3528.4883691864666, 3582.910427239314, 3711.0, 3712.573054098773, 3723.664870161685, 3660.798656073915, 3697.371446854028, 3702.685271751891, 3706.0, 3721.1999420124666, 3661.9084522887006, 3663.212409331993, 3669.5963444021136, 3682.5396825396824, 3688.5204923359793, 3262.869485220588, 3271.8854840080485, 3276.8858588080166, 3281.2945216778508, 3285.2936618626873, 4291.6137547620865, 4528.660350473695, 4536.931946020813, 4557.680962332638, 4637.281221410687, 4105.97947010266, 4115.629593336614, 4118.979405102985, 4128.401381799622, 4145.2124096421885, 4702.4827269000725, 4877.414710234759, 4887.291342755316, 4918.262260660894, 4926.408830940274, 3454.671806178409, 3460.7368310566712, 3463.2900255447826, 3475.6176820549717, 3477.8434970426138, 5171.870703232412, 5175.0, 5183.611229157828, 5194.948050519484, 5197.48025197481, 3547.9645203547634, 3563.7149028077692, 3566.144125409935, 3569.089882080053, 3577.373959557067, 3534.858605655745, 3536.204354020325, 3576.1059735066233, 3589.6410358963894, 3592.515010473605, 4103.85636502721, 4106.1992911382595, 4110.362893751473, 4115.32097203964, 4124.360724087711, 4893.21708526634, 4896.922677011052, 4904.057565460695, 4909.337239472626, 4917.729524876167, 1131.603938621476, 1145.7364806094645, 1181.4033912874115, 1190.2858285029085, 1191.326900301327, 773.4276635289957, 778.2217782217782, 778.4239662649599, 789.7561340888125, 805.8468890910825, 3949.2101579683604, 3992.161646054303, 3998.8206427496502, 4004.938691246822, 4009.51885773709, 4534.0, 4563.315502674559, 4564.493717073357, 4571.428571428572, 4595.471520775153, 4042.171354872244, 4044.4337792709043, 4045.231406032903, 4061.9845038740314, 4149.585041495826, 2717.9400033986763, 2742.931426714308, 2755.145904769528, 2759.227416323433, 2765.5989881467076, 4912.263160525878, 4918.754062296943, 4919.401194611694, 4932.506749325111, 4939.950600494021, 5014.52362025607, 5268.2097685346735, 5290.497402746733, 5324.068288049653, 5332.306800116037, 4869.488703686062, 4901.779419926112, 4904.239842824368, 4905.411350637946, 4912.336834527293, 5165.173572228426, 5173.974130129476, 5176.275321454924, 5184.403793563638, 5194.35070616173, 4891.6575839692305, 5064.670796398223, 5072.365954255718, 5109.3613298337705, 5109.489051094861, 4791.520847915181, 4802.6638135330195, 4829.73436460998, 4858.0, 4878.63410244226, 3498.5801703795705, 3525.806080665588, 3525.942217334738, 3531.1701750089223, 3535.6641119093647, 4927.152317880795, 4935.851924442272, 5088.898222035465, 5103.362079740033, 5193.714345711022, 4958.900821983612, 4970.403551573834, 4974.427940786711, 4978.8257410990445, 4986.900261994812, 4942.332785073969, 4957.206846904478, 4979.278004689228, 5008.0, 5017.147084995487, 4765.833195838129, 4824.638152138534, 4867.780949857336, 4868.805247790048, 4878.78045487961, 4947.876303092307, 4960.900781984268, 4965.851024469272, 4977.4773648767805, 5016.573591244785, 4865.440474345495, 4890.462049174517, 4892.975535122301, 4900.681455705368, 4947.307376967299], "value": 3688.1078871154177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.5376832954463, 602.1599868183883, 615.4829942848007, 625.8935980883249, 632.8607706304614, 11962.700932476693, 12258.632241032761, 12296.323702196376, 12382.876171238297, 12418.19281746687, 12992.0, 13195.2742599157, 13216.603501894959, 13218.140820846662, 13220.471181152743, 619.3404024713687, 768.5004746914494, 775.8099265679916, 787.0240901282426, 792.4769652029662, 799.5762246009624, 802.7511471443842, 806.1132753970644, 806.4032615864277, 806.8063664720484, 846.7671390367667, 847.8812966184739, 848.4230723108284, 848.5078654380476, 848.5545088828353, 650.8926027205529, 805.138501803071, 829.340674164041, 831.3349320543541, 843.1357858195369, 607.465430421231, 607.872346807171, 607.9331273559905, 608.6165715599188, 610.4627927423838, 12488.625341239687, 12626.431810568547, 12627.684307892285, 12629.305388203646, 12762.361881905868, 12533.122681412306, 12685.0, 12862.0, 13319.26744029078, 13368.197908125543, 11515.25150865191, 11569.0, 11651.650450486499, 11780.88219117815, 12115.0, 4124.463819703449, 4212.946763309173, 4236.555161708007, 4333.804978775931, 4337.306031035019, 55307.72346138284, 55798.72100639511, 56095.15857262144, 56450.717746411414, 56507.434925650625, 9408.341416100808, 9909.355891867006, 10065.64770233053, 10163.593456261815, 10310.32982856112, 16817.663646726996, 16856.915715421343, 17242.0, 17248.310067597155, 17487.737683934753, 6385.265694445198, 6468.708908099147, 6489.643069631215, 6634.104395906587, 6656.866862662817, 3790.65884070435, 3791.3933770597123, 3803.7717736935874, 3829.1384438501673, 3875.3411919973673, 2899.0, 2991.7756168287465, 3000.3999200160056, 3001.309698769295, 3003.849807509616, 514.452108504449, 518.4452635679786, 523.6125267302169, 527.1881302793731, 528.9523942845162, 401.45001348152636, 512.9051125541787, 536.6592213944174, 546.2325432766969, 568.980155203486, 7251.5286506376915, 7647.579383133981, 7730.845383092306, 7750.0, 7776.105747839071, 467.95788379046047, 528.6537318056679, 546.3198318093998, 552.8617845538615, 571.4656795895768, 3731.197792474631, 3755.1926335837925, 3760.379537376357, 3772.550583075839, 3777.773333599938, 55287.44712552823, 88193.0, 88668.0, 91185.54407227921, 91273.54363228274, 72499.63750181215, 75350.0, 77172.0, 77596.2240377589, 77905.22094779093, 67699.66150169415, 69572.0, 69660.65169674119, 70517.0, 70952.64523677246, 7463.104427468738, 7558.941748155153, 7791.298783109547, 8647.26498247656, 8731.912680873364, 39889.2022159561, 41189.382159267036, 41212.793936030124, 41334.89988250953, 43954.56045439505, 51576.74211629068, 52551.474485256185, 57144.71427642835, 57797.422025779204, 59825.0, 10914.781704365709, 11080.889191108308, 11517.308961462339, 11624.94187529057, 11887.76224475523, 12394.132410731523, 12398.690032749253, 12501.749965000467, 13865.168089914638, 13935.930320348334, 11875.287482751062, 12013.339266340436, 12276.877231227574, 12386.194897331645, 12392.008639308653, 11371.772564548828, 12040.21738586989, 12814.1670791402, 12902.935485322889, 13231.27228002469, 11246.894883367675, 12232.571859984857, 12288.201266917979, 12498.812517812423, 12890.29103399322, 9819.263555233529, 10240.0, 10262.486875656337, 10295.12491438236, 10348.689539313833, 10086.445245511568, 10533.631322903662, 10575.365478071033, 10620.09729173029, 10682.57269709203], "value": 6453.347381842485, "unit": "score"}], "name": "dromaeo_css", "value": 6263.320856976003, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 111.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 143.0, 131.0, 196.0, 130.0, 168.0, 151.0, 129.0, 189.0, 130.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 129.0, 76.0, 77.0, 75.0, 75.0, 101.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 115.0, 85.0, 86.0, 88.0, 116.0, 86.0, 86.0, 125.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 65.0, 66.0, 67.0, 76.0, 64.0, 64.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 89.0, 84.0, 91.0, 84.0, 86.0, 126.0, 94.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 131.0, 128.0, 129.0, 128.0, 128.0, 131.0, 135.0, 141.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 174.0, 171.0, 169.0, 170.0, 168.0, 168.0, 170.0, 169.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1555.3000000000002, "alertThreshold": 2.0}]} 06:18:19 INFO - Return code: 0 06:18:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:19 ERROR - # TBPL SUCCESS # 06:18:19 INFO - Running post-action listener: _resource_record_post_action 06:18:19 INFO - ##### 06:18:19 INFO - ##### Finished run-tests step (success) 06:18:19 INFO - ##### 06:18:19 INFO - Running post-run listener: _resource_record_post_run 06:18:19 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543109120; Read time: 12; Write time: 518844 06:18:19 INFO - TinderboxPrint: CPU usage
13.1% 06:18:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:18:19 INFO - TinderboxPrint: I/O write bytes / time
543,109,120 / 518,844 06:18:19 INFO - TinderboxPrint: CPU idle
8,321.7 (86.9%) 06:18:19 INFO - TinderboxPrint: CPU user
1,212.4 (12.7%) 06:18:19 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:19 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 194486272; Read time: 0; Write time: 238072 06:18:19 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289423360; Read time: 12; Write time: 250912 06:18:20 INFO - Running post-run listener: _upload_blobber_files 06:18:20 INFO - Blob upload gear active. 06:18:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:18:20 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:20 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:20 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:21 INFO - (blobuploader) - INFO - Done attempting. 06:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:22 INFO - (blobuploader) - INFO - Done attempting. 06:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:25 INFO - (blobuploader) - INFO - Done attempting. 06:18:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:25 INFO - Return code: 0 06:18:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6776afcd064c7f599bdbd0d0617dee4495a276313d8e2615106e16f807a0494a9854ebc7c6ef55e94528747b6fc173a0de3c7078f26ca967f1b4fc86eaf4280a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325dfac001e00776ea92272f0198966e0800c8711820bd64c36f456199eb4510544ee8192344a0876f3ac452656abaca9fef13c428981ee6d5cd37882a31b081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abc1f3bb7bd4450dccbcdd70d0c842715929c32f7566c85258d10b7d2b23a678f4ebca11e05d6e78ce25b6cffc1cc20f29e75d79f69d0410d4e21da8ac3088c0"} 06:18:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:25 INFO - Contents: 06:18:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6776afcd064c7f599bdbd0d0617dee4495a276313d8e2615106e16f807a0494a9854ebc7c6ef55e94528747b6fc173a0de3c7078f26ca967f1b4fc86eaf4280a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325dfac001e00776ea92272f0198966e0800c8711820bd64c36f456199eb4510544ee8192344a0876f3ac452656abaca9fef13c428981ee6d5cd37882a31b081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abc1f3bb7bd4450dccbcdd70d0c842715929c32f7566c85258d10b7d2b23a678f4ebca11e05d6e78ce25b6cffc1cc20f29e75d79f69d0410d4e21da8ac3088c0"} 06:18:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:25 INFO - Copying logs to upload dir... 06:18:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.157560 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-06 06:18:25.025828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:18:25.029116) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6776afcd064c7f599bdbd0d0617dee4495a276313d8e2615106e16f807a0494a9854ebc7c6ef55e94528747b6fc173a0de3c7078f26ca967f1b4fc86eaf4280a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325dfac001e00776ea92272f0198966e0800c8711820bd64c36f456199eb4510544ee8192344a0876f3ac452656abaca9fef13c428981ee6d5cd37882a31b081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abc1f3bb7bd4450dccbcdd70d0c842715929c32f7566c85258d10b7d2b23a678f4ebca11e05d6e78ce25b6cffc1cc20f29e75d79f69d0410d4e21da8ac3088c0"} build_url:https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/D3YmpEAKRO2w46qVqMzPZQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6776afcd064c7f599bdbd0d0617dee4495a276313d8e2615106e16f807a0494a9854ebc7c6ef55e94528747b6fc173a0de3c7078f26ca967f1b4fc86eaf4280a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325dfac001e00776ea92272f0198966e0800c8711820bd64c36f456199eb4510544ee8192344a0876f3ac452656abaca9fef13c428981ee6d5cd37882a31b081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abc1f3bb7bd4450dccbcdd70d0c842715929c32f7566c85258d10b7d2b23a678f4ebca11e05d6e78ce25b6cffc1cc20f29e75d79f69d0410d4e21da8ac3088c0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:18:25.054058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:18:25.054369) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465217457.165615-672990809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:18:25.140792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:18:25.141179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:18:25.141473) ========= ========= Total master_lag: 0.17 =========