builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1450246053.22 results: success (0) buildid: 20151215213907 builduid: 2cc0746be8ff40d384251c5e7f53f7d2 revision: 154c2eaad666c31de75f34b6cb4b3552a9d04c80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.224185) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.224833) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.225154) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006424 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.285215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.286025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.329882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.330187) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.383214) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.383689) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.384051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.384345) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 22:07:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-15 22:07:33 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182246 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.602782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.603118) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017222 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:33.661788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 22:07:33.662089) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 154c2eaad666c31de75f34b6cb4b3552a9d04c80 --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 154c2eaad666c31de75f34b6cb4b3552a9d04c80 --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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 22:07:33,940 truncating revision to first 12 chars 2015-12-15 22:07:33,940 Setting DEBUG logging. 2015-12-15 22:07:33,940 attempt 1/10 2015-12-15 22:07:33,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/154c2eaad666?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 22:07:35,116 unpacking tar archive at: fx-team-154c2eaad666/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 22:07:35.137030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:35.137344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:35.146810) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:35.147071) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 22:07:35.147514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-15 22:07:35.147795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:35 INFO - MultiFileLogger online at 20151215 22:07:35 in /builds/slave/test 22:07:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:07:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:35 INFO - {'append_to_log': False, 22:07:35 INFO - 'base_work_dir': '/builds/slave/test', 22:07:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:07:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:35 INFO - 'branch': 'Fx-Team-Non-PGO', 22:07:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:35 INFO - 'config_files': ('talos/linux_config.py',), 22:07:35 INFO - 'default_actions': ('clobber', 22:07:35 INFO - 'read-buildbot-config', 22:07:35 INFO - 'download-and-extract', 22:07:35 INFO - 'populate-webroot', 22:07:35 INFO - 'create-virtualenv', 22:07:35 INFO - 'install', 22:07:35 INFO - 'run-tests'), 22:07:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:35 INFO - 'download_minidump_stackwalk': True, 22:07:35 INFO - 'download_symbols': 'ondemand', 22:07:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:35 INFO - 'installer_path': 'installer.exe', 22:07:35 INFO - 'log_level': 'info', 22:07:35 INFO - 'log_name': 'talos', 22:07:35 INFO - 'log_to_console': True, 22:07:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:35 INFO - 'opt_config_files': (), 22:07:35 INFO - 'pip_index': False, 22:07:35 INFO - 'sps_profile': False, 22:07:35 INFO - 'sps_profile_interval': 0, 22:07:35 INFO - 'suite': 'dromaeojs-e10s', 22:07:35 INFO - 'system_bits': '64', 22:07:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:35 INFO - 'title': 'talos-linux64-ix-062', 22:07:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:35 INFO - 'use_talos_json': True, 22:07:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:35 INFO - 'work_dir': 'build'} 22:07:35 INFO - ##### 22:07:35 INFO - ##### Running clobber step. 22:07:35 INFO - ##### 22:07:35 INFO - Running pre-action listener: _resource_record_pre_action 22:07:35 INFO - Running main action method: clobber 22:07:35 INFO - rmtree: /builds/slave/test/build 22:07:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:35 INFO - Running post-action listener: _resource_record_post_action 22:07:35 INFO - ##### 22:07:35 INFO - ##### Running read-buildbot-config step. 22:07:35 INFO - ##### 22:07:35 INFO - Running pre-action listener: _resource_record_pre_action 22:07:35 INFO - Running main action method: read_buildbot_config 22:07:35 INFO - Using buildbot properties: 22:07:35 INFO - { 22:07:35 INFO - "properties": { 22:07:35 INFO - "buildnumber": 579, 22:07:35 INFO - "product": "firefox", 22:07:35 INFO - "script_repo_revision": "production", 22:07:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:07:35 INFO - "repository": "", 22:07:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:07:35 INFO - "buildid": "20151215213907", 22:07:35 INFO - "slavename": "talos-linux64-ix-062", 22:07:35 INFO - "pgo_build": "False", 22:07:35 INFO - "basedir": "/builds/slave/test", 22:07:35 INFO - "project": "", 22:07:35 INFO - "platform": "ubuntu64_hw", 22:07:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:07:35 INFO - "slavebuilddir": "test", 22:07:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:07:35 INFO - "branch": "fx-team", 22:07:35 INFO - "repo_path": "integration/fx-team", 22:07:35 INFO - "stage_platform": "linux64", 22:07:35 INFO - "builduid": "2cc0746be8ff40d384251c5e7f53f7d2", 22:07:35 INFO - "revision": "154c2eaad666c31de75f34b6cb4b3552a9d04c80" 22:07:35 INFO - }, 22:07:35 INFO - "sourcestamp": { 22:07:35 INFO - "repository": "", 22:07:35 INFO - "hasPatch": false, 22:07:35 INFO - "project": "", 22:07:35 INFO - "branch": "fx-team-linux64-talos", 22:07:35 INFO - "changes": [ 22:07:35 INFO - { 22:07:35 INFO - "category": null, 22:07:35 INFO - "files": [ 22:07:35 INFO - { 22:07:35 INFO - "url": null, 22:07:35 INFO - "name": "https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 22:07:35 INFO - } 22:07:35 INFO - ], 22:07:35 INFO - "repository": "", 22:07:35 INFO - "rev": "154c2eaad666c31de75f34b6cb4b3552a9d04c80", 22:07:35 INFO - "who": "georg.fritzsche@googlemail.com", 22:07:35 INFO - "when": 1450246009, 22:07:35 INFO - "number": 7364935, 22:07:35 INFO - "comments": "Bug 1172459 - The about:telemetry environment section should render addons & plugins better. r=gfritzsche", 22:07:35 INFO - "project": "", 22:07:35 INFO - "at": "Tue 15 Dec 2015 22:06:49", 22:07:35 INFO - "branch": "fx-team-linux64-talos", 22:07:35 INFO - "revlink": "", 22:07:35 INFO - "properties": [ 22:07:35 INFO - [ 22:07:35 INFO - "buildid", 22:07:35 INFO - "20151215213907", 22:07:35 INFO - "Change" 22:07:35 INFO - ], 22:07:35 INFO - [ 22:07:35 INFO - "builduid", 22:07:35 INFO - "2cc0746be8ff40d384251c5e7f53f7d2", 22:07:35 INFO - "Change" 22:07:35 INFO - ], 22:07:35 INFO - [ 22:07:35 INFO - "pgo_build", 22:07:35 INFO - "False", 22:07:35 INFO - "Change" 22:07:35 INFO - ] 22:07:35 INFO - ], 22:07:35 INFO - "revision": "154c2eaad666c31de75f34b6cb4b3552a9d04c80" 22:07:35 INFO - } 22:07:35 INFO - ], 22:07:35 INFO - "revision": "154c2eaad666c31de75f34b6cb4b3552a9d04c80" 22:07:35 INFO - } 22:07:35 INFO - } 22:07:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:07:35 INFO - Running post-action listener: _resource_record_post_action 22:07:35 INFO - ##### 22:07:35 INFO - ##### Running download-and-extract step. 22:07:35 INFO - ##### 22:07:35 INFO - Running pre-action listener: _resource_record_pre_action 22:07:35 INFO - Running main action method: download_and_extract 22:07:35 INFO - mkdir: /builds/slave/test/build/tests 22:07: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')]} 22:07:35 INFO - https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/test_packages.json 22:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/test_packages.json 22:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:07:42 INFO - Downloaded 1302 bytes. 22:07:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:07:42 INFO - Using the following test package requirements: 22:07:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'jsshell-linux-x86_64.zip'], 22:07:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:07:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:07:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:42 INFO - https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:44 INFO - Downloaded 21868751 bytes. 22:07:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:07:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:07:45 INFO - Return code: 0 22:07:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:45 INFO - https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:47 INFO - Downloaded 21868751 bytes. 22:07:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:07:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:07:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:07:49 INFO - Return code: 0 22:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:49 INFO - https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:07:49 INFO - Downloaded 11132052 bytes. 22:07:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:07:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:07:50 INFO - Return code: 0 22:07: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')]} 22:07:50 INFO - https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:07:51 INFO - Downloaded 57739588 bytes. 22:07:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:07:51 INFO - mkdir: /builds/slave/test/properties 22:07:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:51 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:51 INFO - Contents: 22:07:51 INFO - build_url:https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:07:51 INFO - Running post-action listener: _resource_record_post_action 22:07:51 INFO - Running post-action listener: set_extra_try_arguments 22:07:51 INFO - ##### 22:07:51 INFO - ##### Running populate-webroot step. 22:07:51 INFO - ##### 22:07:51 INFO - Running pre-action listener: _resource_record_pre_action 22:07:51 INFO - Running main action method: populate_webroot 22:07:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:51 INFO - '--tppagecycles', 22:07:51 INFO - '7'], 22:07:51 INFO - 'tests': ['tsvgm']}}, 22:07:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:07:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'tests': ['damp', 'tps']}, 22:07:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['damp', 'tps']}, 22:07:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:07:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:51 INFO - 'other': {'tests': ['a11yr', 22:07:51 INFO - 'ts_paint', 22:07:51 INFO - 'tpaint', 22:07:51 INFO - 'sessionrestore', 22:07:51 INFO - 'sessionrestore_no_auto_restore']}, 22:07:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['a11yr', 22:07:51 INFO - 'ts_paint', 22:07:51 INFO - 'tpaint', 22:07:51 INFO - 'sessionrestore', 22:07:51 INFO - 'sessionrestore_no_auto_restore']}, 22:07:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['a11yr', 22:07:51 INFO - 'ts_paint', 22:07:51 INFO - 'tpaint', 22:07:51 INFO - 'sessionrestore', 22:07:51 INFO - 'sessionrestore_no_auto_restore']}, 22:07:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['a11yr', 22:07:51 INFO - 'ts_paint', 22:07:51 INFO - 'tpaint', 22:07:51 INFO - 'sessionrestore', 22:07:51 INFO - 'sessionrestore_no_auto_restore']}, 22:07:51 INFO - 'other_l64': {'tests': ['a11yr', 22:07:51 INFO - 'ts_paint', 22:07:51 INFO - 'tpaint', 22:07:51 INFO - 'sessionrestore', 22:07:51 INFO - 'sessionrestore_no_auto_restore']}, 22:07:51 INFO - 'other_nol64': {'tests': ['a11yr', 22:07:51 INFO - 'ts_paint', 22:07:51 INFO - 'tpaint', 22:07:51 INFO - 'sessionrestore', 22:07:51 INFO - 'sessionrestore_no_auto_restore']}, 22:07:51 INFO - 'svgr': {'tests': ['tsvgx', 22:07:51 INFO - 'tsvgr_opacity', 22:07:51 INFO - 'tart', 22:07:51 INFO - 'tscrollx', 22:07:51 INFO - 'cart']}, 22:07:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['tsvgx', 22:07:51 INFO - 'tsvgr_opacity', 22:07:51 INFO - 'tart', 22:07:51 INFO - 'tscrollx', 22:07:51 INFO - 'cart']}, 22:07:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'tests': ['tp5o']}, 22:07:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'talos_options': ['--e10s'], 22:07:51 INFO - 'tests': ['tp5o']}, 22:07:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'talos_options': ['--xperf_path', 22:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:51 INFO - 'tests': ['tp5n']}, 22:07:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:51 INFO - 'talos_options': ['--e10s', 22:07:51 INFO - '--xperf_path', 22:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:51 INFO - 'tests': ['tp5n']}}, 22:07:51 INFO - 'talos.zip': {'path': '', 22:07:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:51 INFO - Running post-action listener: _resource_record_post_action 22:07:51 INFO - ##### 22:07:51 INFO - ##### Running create-virtualenv step. 22:07:51 INFO - ##### 22:07:51 INFO - Running pre-action listener: _resource_record_pre_action 22:07:51 INFO - Running main action method: create_virtualenv 22:07:51 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:51 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 22:07:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:51 INFO - Using real prefix '/usr' 22:07:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:52 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:54 INFO - Installing pip.................done. 22:07:54 INFO - Return code: 0 22:07:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 22:07:54 INFO - Using env: {'DISPLAY': ':0', 22:07:54 INFO - 'HOME': '/home/cltbld', 22:07:54 INFO - 'LANG': 'en_US.UTF-8', 22:07:54 INFO - 'LANGUAGE': 'en_US:en', 22:07:54 INFO - 'LOGNAME': 'cltbld', 22:07:54 INFO - 'MAIL': '/var/mail/cltbld', 22:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:54 INFO - 'MOZ_NO_REMOTE': '1', 22:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:54 INFO - 'NO_EM_RESTART': '1', 22:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:54 INFO - 'PWD': '/builds/slave/test', 22:07:54 INFO - 'SHELL': '/bin/bash', 22:07:54 INFO - 'SHLVL': '1', 22:07:54 INFO - 'TERM': 'linux', 22:07:54 INFO - 'TMOUT': '86400', 22:07:54 INFO - 'USER': 'cltbld', 22:07:54 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:54 INFO - '_': '/tools/buildbot/bin/python'} 22:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:54 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 22:07:54 INFO - Cleaning up... 22:07:54 INFO - Return code: 0 22:07:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 22:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 22:07:54 INFO - Using env: {'DISPLAY': ':0', 22:07:54 INFO - 'HOME': '/home/cltbld', 22:07:54 INFO - 'LANG': 'en_US.UTF-8', 22:07:54 INFO - 'LANGUAGE': 'en_US:en', 22:07:54 INFO - 'LOGNAME': 'cltbld', 22:07:54 INFO - 'MAIL': '/var/mail/cltbld', 22:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:54 INFO - 'MOZ_NO_REMOTE': '1', 22:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:54 INFO - 'NO_EM_RESTART': '1', 22:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:54 INFO - 'PWD': '/builds/slave/test', 22:07:54 INFO - 'SHELL': '/bin/bash', 22:07:54 INFO - 'SHLVL': '1', 22:07:54 INFO - 'TERM': 'linux', 22:07:54 INFO - 'TMOUT': '86400', 22:07:54 INFO - 'USER': 'cltbld', 22:07:54 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:54 INFO - '_': '/tools/buildbot/bin/python'} 22:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:54 INFO - Downloading/unpacking psutil>=0.7.1 22:07:54 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 22:07:54 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 22:07:54 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 22:07:54 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 22:07:54 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 22:07:54 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 22:07:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:07:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:56 INFO - Installing collected packages: psutil 22:07:56 INFO - Running setup.py install for psutil 22:07:56 INFO - building 'psutil._psutil_linux' extension 22:07:56 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 22:07:56 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 22:07:56 INFO - building 'psutil._psutil_posix' extension 22:07:56 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 22:07:56 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 22:07:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:56 INFO - Successfully installed psutil 22:07:56 INFO - Cleaning up... 22:07:56 INFO - Return code: 0 22:07:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:07:56 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')]} 22:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:56 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')]} 22:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 22:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 22:07:56 INFO - Using env: {'DISPLAY': ':0', 22:07:56 INFO - 'HOME': '/home/cltbld', 22:07:56 INFO - 'LANG': 'en_US.UTF-8', 22:07:56 INFO - 'LANGUAGE': 'en_US:en', 22:07:56 INFO - 'LOGNAME': 'cltbld', 22:07:56 INFO - 'MAIL': '/var/mail/cltbld', 22:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:56 INFO - 'MOZ_NO_REMOTE': '1', 22:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:56 INFO - 'NO_EM_RESTART': '1', 22:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:56 INFO - 'PWD': '/builds/slave/test', 22:07:56 INFO - 'SHELL': '/bin/bash', 22:07:56 INFO - 'SHLVL': '1', 22:07:56 INFO - 'TERM': 'linux', 22:07:56 INFO - 'TMOUT': '86400', 22:07:56 INFO - 'USER': 'cltbld', 22:07:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:56 INFO - '_': '/tools/buildbot/bin/python'} 22:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:58 INFO - Installing collected packages: mozsystemmonitor 22:07:58 INFO - Running setup.py install for mozsystemmonitor 22:07:58 INFO - Successfully installed mozsystemmonitor 22:07:58 INFO - Cleaning up... 22:07:59 INFO - Return code: 0 22:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 22:07:59 INFO - Using env: {'DISPLAY': ':0', 22:07:59 INFO - 'HOME': '/home/cltbld', 22:07:59 INFO - 'LANG': 'en_US.UTF-8', 22:07:59 INFO - 'LANGUAGE': 'en_US:en', 22:07:59 INFO - 'LOGNAME': 'cltbld', 22:07:59 INFO - 'MAIL': '/var/mail/cltbld', 22:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:59 INFO - 'MOZ_NO_REMOTE': '1', 22:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:59 INFO - 'NO_EM_RESTART': '1', 22:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:59 INFO - 'PWD': '/builds/slave/test', 22:07:59 INFO - 'SHELL': '/bin/bash', 22:07:59 INFO - 'SHLVL': '1', 22:07:59 INFO - 'TERM': 'linux', 22:07:59 INFO - 'TMOUT': '86400', 22:07:59 INFO - 'USER': 'cltbld', 22:07:59 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:59 INFO - '_': '/tools/buildbot/bin/python'} 22:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:59 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:59 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 22:07:59 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 22:07:59 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 22:07:59 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 22:07:59 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 22:07:59 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 22:08:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:08:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:08:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:08:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:01 INFO - Downloading docopt-0.6.1.tar.gz 22:08:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:08:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:08:01 INFO - Running setup.py install for blobuploader 22:08:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:08:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:08:01 INFO - Running setup.py install for requests 22:08:02 INFO - Running setup.py install for docopt 22:08:02 INFO - Successfully installed blobuploader requests docopt 22:08:02 INFO - Cleaning up... 22:08:02 INFO - Return code: 0 22:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 22:08:02 INFO - Using env: {'DISPLAY': ':0', 22:08:02 INFO - 'HOME': '/home/cltbld', 22:08:02 INFO - 'LANG': 'en_US.UTF-8', 22:08:02 INFO - 'LANGUAGE': 'en_US:en', 22:08:02 INFO - 'LOGNAME': 'cltbld', 22:08:02 INFO - 'MAIL': '/var/mail/cltbld', 22:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:02 INFO - 'MOZ_NO_REMOTE': '1', 22:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:02 INFO - 'NO_EM_RESTART': '1', 22:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:02 INFO - 'PWD': '/builds/slave/test', 22:08:02 INFO - 'SHELL': '/bin/bash', 22:08:02 INFO - 'SHLVL': '1', 22:08:02 INFO - 'TERM': 'linux', 22:08:02 INFO - 'TMOUT': '86400', 22:08:02 INFO - 'USER': 'cltbld', 22:08:02 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:02 INFO - '_': '/tools/buildbot/bin/python'} 22:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:02 INFO - Running setup.py (path:/tmp/pip-P0dYzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:02 INFO - Running setup.py (path:/tmp/pip-aJDLYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:02 INFO - Running setup.py (path:/tmp/pip-n3JTcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:02 INFO - Running setup.py (path:/tmp/pip-mUwSG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:02 INFO - Running setup.py (path:/tmp/pip-OOlwoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:02 INFO - Running setup.py (path:/tmp/pip-2w1skp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:02 INFO - Running setup.py (path:/tmp/pip-gSJPmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:02 INFO - Running setup.py (path:/tmp/pip-Wku6Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:03 INFO - Running setup.py (path:/tmp/pip-StLn4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:03 INFO - Running setup.py (path:/tmp/pip-A06YNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:03 INFO - Running setup.py (path:/tmp/pip-FRZk2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:03 INFO - Running setup.py (path:/tmp/pip-xo_3Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:03 INFO - Running setup.py (path:/tmp/pip-Tj3_7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:03 INFO - Running setup.py (path:/tmp/pip-0lOPzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:03 INFO - Running setup.py (path:/tmp/pip-etzkcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:03 INFO - Running setup.py (path:/tmp/pip-_VxXaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:03 INFO - Running setup.py (path:/tmp/pip-EkkEyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:03 INFO - Running setup.py install for manifestparser 22:08:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:08:03 INFO - Running setup.py install for mozcrash 22:08:03 INFO - Running setup.py install for mozdebug 22:08:03 INFO - Running setup.py install for mozdevice 22:08:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Running setup.py install for mozfile 22:08:04 INFO - Running setup.py install for mozhttpd 22:08:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Running setup.py install for mozinfo 22:08:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Running setup.py install for mozInstall 22:08:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Running setup.py install for mozleak 22:08:04 INFO - Running setup.py install for mozlog 22:08:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Running setup.py install for moznetwork 22:08:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:08:04 INFO - Running setup.py install for mozprocess 22:08:04 INFO - Running setup.py install for mozprofile 22:08:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:08:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:08:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:08:05 INFO - Running setup.py install for mozrunner 22:08:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:08:05 INFO - Running setup.py install for mozscreenshot 22:08:05 INFO - Running setup.py install for moztest 22:08:05 INFO - Running setup.py install for mozversion 22:08:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:08:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:05 INFO - Cleaning up... 22:08:05 INFO - Return code: 0 22:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 22:08:05 INFO - Using env: {'DISPLAY': ':0', 22:08:05 INFO - 'HOME': '/home/cltbld', 22:08:05 INFO - 'LANG': 'en_US.UTF-8', 22:08:05 INFO - 'LANGUAGE': 'en_US:en', 22:08:05 INFO - 'LOGNAME': 'cltbld', 22:08:05 INFO - 'MAIL': '/var/mail/cltbld', 22:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:05 INFO - 'MOZ_NO_REMOTE': '1', 22:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:05 INFO - 'NO_EM_RESTART': '1', 22:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:05 INFO - 'PWD': '/builds/slave/test', 22:08:05 INFO - 'SHELL': '/bin/bash', 22:08:05 INFO - 'SHLVL': '1', 22:08:05 INFO - 'TERM': 'linux', 22:08:05 INFO - 'TMOUT': '86400', 22:08:05 INFO - 'USER': 'cltbld', 22:08:05 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:05 INFO - '_': '/tools/buildbot/bin/python'} 22:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:05 INFO - Running setup.py (path:/tmp/pip-lY6K29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:05 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)) 22:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:05 INFO - Running setup.py (path:/tmp/pip-PoNMOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 22:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:05 INFO - Running setup.py (path:/tmp/pip-XF00G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:05 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)) 22:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:05 INFO - Running setup.py (path:/tmp/pip-deUl9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 22:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:05 INFO - Running setup.py (path:/tmp/pip-fsrWVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:06 INFO - Running setup.py (path:/tmp/pip-cnQ1KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:06 INFO - Running setup.py (path:/tmp/pip-Zo8O2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:06 INFO - Running setup.py (path:/tmp/pip-3vIoE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:06 INFO - Running setup.py (path:/tmp/pip-JehT4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:06 INFO - Running setup.py (path:/tmp/pip-jzi5tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:06 INFO - Running setup.py (path:/tmp/pip-A9JyIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:06 INFO - Running setup.py (path:/tmp/pip-nm_FIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:06 INFO - Running setup.py (path:/tmp/pip-kKkA2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:06 INFO - Running setup.py (path:/tmp/pip-5wJalY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:06 INFO - Running setup.py (path:/tmp/pip-MnDwFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:06 INFO - Running setup.py (path:/tmp/pip-gtGVVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:06 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)) 22:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:06 INFO - Running setup.py (path:/tmp/pip-2tFZDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:06 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)) 22:08:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:08:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:08:06 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)) 22:08:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:08:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:08:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:08 INFO - Downloading blessings-1.5.1.tar.gz 22:08:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:08 INFO - Installing collected packages: blessings 22:08:08 INFO - Running setup.py install for blessings 22:08:08 INFO - Successfully installed blessings 22:08:08 INFO - Cleaning up... 22:08:08 INFO - Return code: 0 22:08:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:09 INFO - Reading from file tmpfile_stdout 22:08:09 INFO - Current package versions: 22:08:09 INFO - argparse == 1.2.1 22:08:09 INFO - blessings == 1.5.1 22:08:09 INFO - blobuploader == 1.2.4 22:08:09 INFO - docopt == 0.6.1 22:08:09 INFO - manifestparser == 1.1 22:08:09 INFO - mozInstall == 1.12 22:08:09 INFO - mozcrash == 0.16 22:08:09 INFO - mozdebug == 0.1 22:08:09 INFO - mozdevice == 0.47 22:08:09 INFO - mozfile == 1.2 22:08:09 INFO - mozhttpd == 0.7 22:08:09 INFO - mozinfo == 0.9 22:08:09 INFO - mozleak == 0.1 22:08:09 INFO - mozlog == 3.1 22:08:09 INFO - moznetwork == 0.27 22:08:09 INFO - mozprocess == 0.22 22:08:09 INFO - mozprofile == 0.27 22:08:09 INFO - mozrunner == 6.11 22:08:09 INFO - mozscreenshot == 0.1 22:08:09 INFO - mozsystemmonitor == 0.0 22:08:09 INFO - moztest == 0.7 22:08:09 INFO - mozversion == 1.4 22:08:09 INFO - psutil == 3.1.1 22:08:09 INFO - requests == 1.2.3 22:08:09 INFO - wsgiref == 0.1.2 22:08:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:09 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')]} 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 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')]} 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 22:08:09 INFO - Using env: {'DISPLAY': ':0', 22:08:09 INFO - 'HOME': '/home/cltbld', 22:08:09 INFO - 'LANG': 'en_US.UTF-8', 22:08:09 INFO - 'LANGUAGE': 'en_US:en', 22:08:09 INFO - 'LOGNAME': 'cltbld', 22:08:09 INFO - 'MAIL': '/var/mail/cltbld', 22:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:09 INFO - 'MOZ_NO_REMOTE': '1', 22:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:09 INFO - 'NO_EM_RESTART': '1', 22:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:09 INFO - 'PWD': '/builds/slave/test', 22:08:09 INFO - 'SHELL': '/bin/bash', 22:08:09 INFO - 'SHLVL': '1', 22:08:09 INFO - 'TERM': 'linux', 22:08:09 INFO - 'TMOUT': '86400', 22:08:09 INFO - 'USER': 'cltbld', 22:08:09 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:09 INFO - '_': '/tools/buildbot/bin/python'} 22:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:09 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 1)) 22:08:09 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 2)) 22:08:09 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 3)) 22:08:09 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 4)) 22:08:09 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 5)) 22:08:09 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 6)) 22:08:09 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 7)) 22:08:09 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 8)) 22:08:09 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:08:09 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 3)) 22:08:09 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:08:09 INFO - Cleaning up... 22:08:09 INFO - Return code: 0 22:08:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:08:09 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')]} 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 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')]} 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 22:08:09 INFO - Using env: {'DISPLAY': ':0', 22:08:09 INFO - 'HOME': '/home/cltbld', 22:08:09 INFO - 'LANG': 'en_US.UTF-8', 22:08:09 INFO - 'LANGUAGE': 'en_US:en', 22:08:09 INFO - 'LOGNAME': 'cltbld', 22:08:09 INFO - 'MAIL': '/var/mail/cltbld', 22:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:09 INFO - 'MOZ_NO_REMOTE': '1', 22:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:09 INFO - 'NO_EM_RESTART': '1', 22:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:09 INFO - 'PWD': '/builds/slave/test', 22:08:09 INFO - 'SHELL': '/bin/bash', 22:08:09 INFO - 'SHLVL': '1', 22:08:09 INFO - 'TERM': 'linux', 22:08:09 INFO - 'TMOUT': '86400', 22:08:09 INFO - 'USER': 'cltbld', 22:08:09 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:09 INFO - '_': '/tools/buildbot/bin/python'} 22:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:09 INFO - Downloading/unpacking jsonschema 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:08:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:11 INFO - warning: no files found matching '*.txt' 22:08:11 INFO - no previously-included directories found matching 'build' 22:08:11 INFO - no previously-included directories found matching 'dist' 22:08:11 INFO - no previously-included directories found matching '.git*' 22:08:11 INFO - Installing collected packages: jsonschema, functools32 22:08:11 INFO - Running setup.py install for functools32 22:08:11 INFO - warning: no files found matching '*.txt' 22:08:11 INFO - no previously-included directories found matching 'build' 22:08:11 INFO - no previously-included directories found matching 'dist' 22:08:11 INFO - no previously-included directories found matching '.git*' 22:08:11 INFO - Successfully installed jsonschema functools32 22:08:11 INFO - Cleaning up... 22:08:11 INFO - Return code: 0 22:08:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f39c0fa2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', '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 22:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 22:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 22:08:11 INFO - Using env: {'DISPLAY': ':0', 22:08:11 INFO - 'HOME': '/home/cltbld', 22:08:11 INFO - 'LANG': 'en_US.UTF-8', 22:08:11 INFO - 'LANGUAGE': 'en_US:en', 22:08:11 INFO - 'LOGNAME': 'cltbld', 22:08:11 INFO - 'MAIL': '/var/mail/cltbld', 22:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:11 INFO - 'MOZ_NO_REMOTE': '1', 22:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:11 INFO - 'NO_EM_RESTART': '1', 22:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:11 INFO - 'PWD': '/builds/slave/test', 22:08:11 INFO - 'SHELL': '/bin/bash', 22:08:11 INFO - 'SHLVL': '1', 22:08:11 INFO - 'TERM': 'linux', 22:08:11 INFO - 'TMOUT': '86400', 22:08:11 INFO - 'USER': 'cltbld', 22:08:11 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:11 INFO - '_': '/tools/buildbot/bin/python'} 22:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:11 INFO - Downloading/unpacking flake8 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:08:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:08:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:08:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:08:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:08:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:08:14 INFO - no previously-included directories found matching 'docs/_build' 22:08:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:08:14 INFO - Running setup.py install for pep8 22:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:08:14 INFO - no previously-included directories found matching 'docs/_build' 22:08:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:08:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:08:14 INFO - Cleaning up... 22:08:14 INFO - Return code: 0 22:08:14 INFO - Running post-action listener: _resource_record_post_action 22:08:14 INFO - Running post-action listener: _start_resource_monitoring 22:08:14 INFO - Starting resource monitoring. 22:08:14 INFO - ##### 22:08:14 INFO - ##### Running install step. 22:08:14 INFO - ##### 22:08:14 INFO - Running pre-action listener: _resource_record_pre_action 22:08:14 INFO - Running main action method: install 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:14 INFO - Reading from file tmpfile_stdout 22:08:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:08:14 INFO - Reading from file tmpfile_stdout 22:08:14 INFO - Output received: 22:08:14 INFO - Usage: mozinstall [options] installer 22:08:14 INFO - Options: 22:08:14 INFO - -h, --help show this help message and exit 22:08:14 INFO - -d DEST, --destination=DEST 22:08:14 INFO - Directory to install application into. [default: 22:08:14 INFO - "/builds/slave/test"] 22:08:14 INFO - --app=APP Application being installed. [default: firefox] 22:08:14 INFO - mkdir: /builds/slave/test/build/application 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:08:29 INFO - Reading from file tmpfile_stdout 22:08:29 INFO - Output received: 22:08:29 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:29 INFO - Running post-action listener: _resource_record_post_action 22:08:29 INFO - ##### 22:08:29 INFO - ##### Running run-tests step. 22:08:29 INFO - ##### 22:08:29 INFO - Running pre-action listener: _resource_record_pre_action 22:08:29 INFO - Running main action method: run_tests 22:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:29 INFO - Python 2.7.3 22:08:29 INFO - Return code: 0 22:08:29 INFO - grabbing minidump binary from tooltool 22:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:29 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d00b0>, '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 0x19d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:29 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 22:08:29 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 22:08:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:29 INFO - Return code: 0 22:08:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:08:30 INFO - Return code: 0 22:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test/build 22:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 22:08:30 INFO - Using env: {'DISPLAY': ':0', 22:08:30 INFO - 'HOME': '/home/cltbld', 22:08:30 INFO - 'LANG': 'en_US.UTF-8', 22:08:30 INFO - 'LANGUAGE': 'en_US:en', 22:08:30 INFO - 'LOGNAME': 'cltbld', 22:08:30 INFO - 'MAIL': '/var/mail/cltbld', 22:08:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:30 INFO - 'MOZ_NO_REMOTE': '1', 22:08:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:30 INFO - 'NO_EM_RESTART': '1', 22:08:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:30 INFO - 'PWD': '/builds/slave/test', 22:08:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:30 INFO - 'SHELL': '/bin/bash', 22:08:30 INFO - 'SHLVL': '1', 22:08:30 INFO - 'TERM': 'linux', 22:08:30 INFO - 'TMOUT': '86400', 22:08:30 INFO - 'USER': 'cltbld', 22:08:30 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124', 22:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:30 INFO - '_': '/tools/buildbot/bin/python'} 22:08:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 22:08:30 INFO - mozversion INFO | application_buildid: 20151215213907 22:08:30 INFO - mozversion INFO | application_changeset: 154c2eaad666c31de75f34b6cb4b3552a9d04c80 22:08:30 INFO - mozversion INFO | application_display_name: Nightly 22:08:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:30 INFO - mozversion INFO | application_name: Firefox 22:08:30 INFO - mozversion INFO | application_remotingname: firefox 22:08:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:08:30 INFO - mozversion INFO | application_vendor: Mozilla 22:08:30 INFO - mozversion INFO | application_version: 46.0a1 22:08:30 INFO - mozversion INFO | platform_buildid: 20151215213907 22:08:30 INFO - mozversion INFO | platform_changeset: 154c2eaad666c31de75f34b6cb4b3552a9d04c80 22:08:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:08:30 INFO - mozversion INFO | platform_version: 46.0a1 22:08:30 INFO - 2015-12-15 22:08:30,636 DEBUG : using testdate: 1450246110 22:08:30 INFO - 2015-12-15 22:08:30,637 DEBUG : actual date: 1450246110 22:08:30 INFO - 2015-12-15 22:08:30,652 INFO : starting webserver on 'localhost:40888' 22:08:30 INFO - 2015-12-15 22:08:30,653 INFO : Starting test suite talos-linux64-ix-062.e 22:08:30 INFO - 2015-12-15 22:08:30,653 INFO : Starting test dromaeo_css 22:08:30 INFO - 2015-12-15 22:08:30,653 DEBUG : operating with platform_type : linux_ 22:08:30 INFO - 2015-12-15 22:08:30,654 INFO : Initialising browser for dromaeo_css test... 22:08:30 INFO - 2015-12-15 22:08:30,667 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV5gzp/profile http://localhost:40888/getInfo.html 22:08:35 INFO - 2015-12-15 22:08:35,408 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:08:35 INFO - 2015-12-15 22:08:35,408 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:08:35 INFO - 2015-12-15 22:08:35,408 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:08:35 INFO - 2015-12-15 22:08:35,408 DEBUG : BROWSER_OUTPUT: __metrics 22:08:35 INFO - 2015-12-15 22:08:35,524 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:08:36 INFO - 2015-12-15 22:08:36,457 INFO : Browser initialized. 22:08:36 INFO - 2015-12-15 22:08:36,458 INFO : Running cycle 1/1 for dromaeo_css test... 22:08:36 INFO - 2015-12-15 22:08:36,458 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIV5gzp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:08:48 INFO - 2015-12-15 22:08:48,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 143142912 22:08:48 INFO - 2015-12-15 22:08:48,524 DEBUG : BROWSER_OUTPUT: 22:09:38 INFO - 2015-12-15 22:09:38,182 DEBUG : BROWSER_OUTPUT: 1450246178174 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] 22:11:50 INFO - 2015-12-15 22:11:50,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40888/tests/dromaeo/cssquery-ext.html) 22:11:51 INFO - 2015-12-15 22:11:51,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 146010112 22:11:51 INFO - 2015-12-15 22:11:51,201 DEBUG : BROWSER_OUTPUT: 22:14:53 INFO - 2015-12-15 22:14:53,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/dromaeo/cssquery-ext.html (next: http://localhost:40888/tests/dromaeo/cssquery-jquery.html) 22:14:53 INFO - 2015-12-15 22:14:53,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 144887808 22:14:53 INFO - 2015-12-15 22:14:53,954 DEBUG : BROWSER_OUTPUT: 22:17:55 INFO - 2015-12-15 22:17:55,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40888/tests/dromaeo/cssquery-mootools.html) 22:17:56 INFO - 2015-12-15 22:17:56,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 144826368 22:17:56 INFO - 2015-12-15 22:17:56,363 DEBUG : BROWSER_OUTPUT: 22:20:58 INFO - 2015-12-15 22:20:58,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40888/tests/dromaeo/cssquery-prototype.html) 22:20:58 INFO - 2015-12-15 22:20:58,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 144027648 22:20:58 INFO - 2015-12-15 22:20:58,701 DEBUG : BROWSER_OUTPUT: 22:24:01 INFO - 2015-12-15 22:24:01,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40888/tests/dromaeo/cssquery-yui.html) 22:24:02 INFO - 2015-12-15 22:24:02,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 144781312 22:24:02 INFO - 2015-12-15 22:24:02,012 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/dromaeo/cssquery-yui.html (next: http://localhost:40888/tests/dromaeo/cssquery-dojo.html) 22:27:04 INFO - 2015-12-15 22:27:04,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 146997248 22:27:04 INFO - 2015-12-15 22:27:04,669 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,670 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:04 INFO - 2015-12-15 22:27:04,670 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:04 INFO - 2015-12-15 22:27:04,670 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:04 INFO - 2015-12-15 22:27:04,670 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:04 INFO - 2015-12-15 22:27:04,671 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2633.8156329056965;2704.0265504418417;2747.1621155547564;2764.8755805988735;2769.7784177265835;4599.908001839961;4709.481956984733;4725.362076119723;4757.90484190316;4785.401824771903;4661.510541393156;4696.929546056812;4707.717536947785;4736.644751643632;4807.903841923168;4320.740755554661;4431.800568974404;4436.933445998313;4443.333499974998;4485.686001979862;4220.810063547133;4423.911521769563;4432.734035957853;4453.955460445402;4458;4308.439902812645;4408.537103604108;4430.914425965627;4431;4463.4866990296205;4412.426384569985;4452.3989261449615;4457.751829487748;4461.754603496806;4516.54834516549;4223.239816832969;4316.26623474007;4360.760158191299;4448.043670610834;4510.391097201901;4702.341672165865;4730.810767569293;4737.786799594027;4754.78603462845;4792.969511555032;5046.697198168085;5116.437191908887;5116.6674166179455;5160.92258616121;5163.948360516422;4941.061198372334;5051.646384753069;5121.667091639031;5191.532762051434;5230.163173892159;4658.34783130362;4675.322078298627;4714.292856071616;4743.810247590092;4786.138495070851;5217.895642087137;5219.243209734567;5220.817271395559;5243.632945693841;5269.130593452114;4827.672390092753;4914.213725803854;5030.3963524377305;5073.239014147907;5170.198619213953;5130.410002849645;5162.92255616166;5191.532762051434;5205.6616319939085;5213;4813.566778989908;5119.744012799345;5129.410117836422;5139.948600513947;5156.432792392834;4962.354893863847;4981.37732783402;5021.472745361758;5021.799128034838;5043.672161309577;4177.4778152730905;4286.078493123993;4302.870913872589;4304.3543468479975;4335.436393268855;3661.7436779425184;3768.095657042345;3777.036855601859;3790.5261842269715;3842.366009608383;4334.111507141029;4345.587169218982;4398.846040388571;4406.559344065632;4428.6678499112695;5100.056489549445;5140.640155189101;5153.4073581538605;5155.561777248976;5218.295530103387;4187.43469631602;4333.198358303724;4374.19077470669;4412.801423935931;4464.843730469418;4526.660500462479;4544.363789069533;4610.792514336863;4615.561521655437;4616.469106052847;4889.877753056202;4904.166291730415;4915.901681966269;4931.778069986859;4961.08219979305;4924.359833221658;5068.721220332917;5233.293505376725;5244.003639308519;5247.895042099213;4866.099771542276;4933;4946.653734238713;4946.950530494649;4985.351904252424;5092.159793634157;5150.665206761549;5174.404943431554;5175.120229561059;5207.71357575337;4913.557779799835;5029.094762942559;5141.38303403594;5220.138677118233;5248;4949.802007919643;4951.876203094951;4953.603711702983;4957.330760347307;4994.5754610858485;4930.408350997904;4933.333999909966;4934.136526107988;4955.72743499111;5005.424376196784;4676.392069031004;4720.811167553396;4769.14155452022;4925;4931.9753401232765;5021.4225364083595;5042.520960508746;5052.494750524918;5056.418511871182;5073.746312684277;4912.066707325596;4942.629302802232;4952.380952380952;4978.47725988766;5003.974980125222 22:27:04 INFO - 2015-12-15 22:27:04,671 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.6725964421345;546.8578169675884;564.1763025982066;579.9155579067145;581.0557843504304;31520;31838.68161318386;32033.51949720756;32281.51577726336;32335.838320808423;37447.251054978886;38127.23745525088;38182.42726359107;38373.42439863397;38392;7610.69557217712;7736.34241089508;7742.458027938046;7751.573663448508;7773.339266162355;7435.925640743604;7619.695212191506;7637.732679356223;7639.433916047225;7645;7774.650140743652;7854.489458185229;7855.41084418668;7872.173421790715;7886.132525422227;7758.8448231035345;7770;7803;7803.5708036057995;7856.7250146244605;7654.502457340255;7770.922290777133;7800.687972481094;7825.491343062739;7844;35287.647123528695;35447.113822154395;35864;36270.27459450823;36350;2384.9489439082377;2899.913002609925;3015.2311160654112;3100.705432983863;3767.1335592813807;25399.74600254011;25746.742532574623;25873.870630646914;25906.22281331563;26043.348916277057;3188.8086714797187;3355.899323020313;3479.3389256041523;3539.5752509699;3543.3976224041976;199157;201106;201645;201711;202150.99999999852;52124.21813672798;53651.73174134104;54365.72817135968;54797.72601136969;55814.16278755822;48844.26733598928;48923.51076489189;48966.26550601744;48970.26544601834;48983.51016489861;13031.543895963785;13057.738845223043;13070.085094043516;13173.538926137539;13210.867891320964;10560.419176945188;10728.839067413996;10766.676999690022;10831.350118992885;10958.945205273923;18640.81359186418;18869.90565047166;18969.24945882839;19175.32886348971;19272.80727192738;7783.221677832172;7908.367330613537;7913.985371117877;8029.156938521488;8110.797230069177;764.3999460423652;788.7633709887011;836.615157027774;852.7356519478982;1005.6681295172575;25984;26482.47035059288;26712.732872671415;26736.19791406261;26950.32624184372;937.3625934364561;946.417952958939;976.0922342221802;1052.0478966535297;1064.6114168328659;13663.453461861414;14189.645258868612;14204;14337.85662143386;14622.707545849024;289515;291880;292398;294740;294841;45949.31076033862;46915.29627055597;47016.529834701214;47203.29195062077;47219;1172.6775136837268;1186.6558697977662;1200.8498937632796;1220.2434490615874;1227.6501197158766;25980.22059338223;26747.465050698487;27552.724472755017;27729;28187.71812281933;42184.57815421806;42693.14613707647;42706.57293427026;42848.14303713971;42901;236396;239599;240113;240293;240444;38718.225635487695;42532.78733606312;42860.78569607132;42891.785541072095;43423.34864976965;44259.77870110758;45469.317960229964;45682;45976.77011614921;46053.53946460626;32340.514892277104;35895.82052089723;36068;37791.43312850255;38106.61893381031;31846.01924759405;31959.201019974687;32183.195420114684;32532;32714.672853271164;36756.632433676394;37385.065373365884;37542.2491550162;37739.62260377361;37828;27973.720262797113;28418.00536981196;31792.364152716353;34375.31249375048;34721.65278347184;23221.41946451352;23597.882010589838;23917.760822391552;24105.638415424135;24195.63706544368 22:27:04 INFO - 2015-12-15 22:27:04,673 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.0446323514746;334.7690093835254;335.14872224549646;337.5510570940649;338.48043253605704;12022.256772767943;12581.496740130384;15808.762868556967;15851.207439628015;16976;12616.558420455285;13854.445822167101;15097.84902150978;15135.697286054272;15155.469558565452;4839.177339852234;4924.753762311888;4926.2364333528185;4935.358403407552;4943.060818444484;4903.632227582928;5014.1225285575065;5048.57087147591;5077.746112694369;5100.336956195708;4957.826476073338;5004.974975125119;5008.599312055045;5020.673656212334;5031.823886163985;4906.386701662293;5008.924866127011;5047.419546752134;5103.668261563023;5103.693778373309;4893.510648935114;4914.729689867056;4922.458529561745;4942.827001054946;4945.2582112683385;12017.579384721581;18758.437246882615;19172.520686982796;19302.517437064045;19375.4187374379;1771.477414162825;1793.2737241417117;1807.2319264312614;1848.0881503178018;1929.604431091623;10057.446840423774;11968.401579920968;12166.148369614131;12625.936870315682;12662.620121396372;1713.6315692126127;1756.3150371355182;1784.4646606018273;1792.2217575721431;1817.4002579148848;55084;55861;56265.43734562684;56288.43711562873;56837.431625683625;9489.762755931157;9612.807743845224;9660.613575457044;9681.564329605184;9713.36863103896;12204.32876191818;12247.571335003233;12259.38703064861;12309.138360314691;12366.258024518558;7223.422126229994;7243.311885370881;7289.635518224068;7295.270472952769;7385.150707668579;7044.366007059287;7063.223045464994;7082.752103676346;7083.858322833515;7153.998440218374;4017.9754162688328;4063.1061166543313;4064.3293856513346;4071.959280407217;4086.8569600063856;1519.5441367589679;1569.686062787447;1631.6736652669513;1651;1696.8981861088128;788.3693045563641;831.2061980808313;833.8749187621905;886.3086792302015;895.2032690905099;12447.439865206088;14542.636434089232;15320.540383788504;15643.765343519857;16447.506574802774;821.322409012567;834.3617132893341;881.4358810361374;885.2563846368952;904.6110172625835;8527.573621319034;9126.680566180152;9174.128457796498;9349.766255843659;9379.390339627902;419299;423357;426155;442526;443106;59998;65757.34242657608;69007.30992690008;69429.91749133763;69878.65060674766;1038.1072277841051;1039.3971496531992;1070.0476575847501;1098.9670309890716;1102.9779404411868;13903.930480347533;14295.92852035733;14547.127172369692;14841.40634374613;15107.848921510644;32943;32979.34041319208;33605.83197083999;34103.4884476738;34153.975380738615;42272;42555.57444425516;44897.32654010258;45341.54658453373;47681.523184767706;8747.15717391863;8768.298536116969;8861.291096712377;8888.64445422176;8995.370324077252;15899.364025439316;15956.281967311266;16249.918750406172;16363.590910226863;16647.50057498277;13513.189208647513;13816.032877698464;13940.860591394361;14021.228832414316;14043.859561404255;13112.934435327763;13116.868831311947;13287.867121328663;13864.168149911038;13957.651058723613;13635.659108522366;13981.370838312097;14049.719005620034;14143.222122783345;14248.857511424752;8256.25693687571;8795.120487951153;8899.332550058902;8928.375013748975;8928.776780580538;9140.862887056566;9310.72067837966;12100.213486123374;12794;13139.73720525565 22:27:04 INFO - 2015-12-15 22:27:04,673 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1452.941882324707;1608.8471595198455;1706.9146542672863;1706.9573260668483;1731.1430841733336;5963.07572326289;6133.141360209563;6695.899561506575;7182;7214.494985351028;6713.160854893138;6856.108705868231;6954.617496037716;6958.895616565743;6969.651517424121;1986.4835142862814;2027.5336672565318;2030.6446371884936;2036.775954644988;2052.5894821035777;2040.3266921915806;2064.07116797441;2084;2085.2076211039785;2092.5605622819226;2007;2009.2465325502938;2027.564073724149;2033.2375359240284;2039.6022775558772;2031.6038372517364;2044.37646517812;2044.9591008179752;2047.4164863014043;2058.125296748876;2028.847836412275;2030.0661695620033;2041.9285325013552;2044.080163926239;2061.628906796776;6976.302369763034;7011.789646310619;7061.435085193172;7072.504924655276;7086.433085353159;4184.790760461965;4269.765162916069;4273.316269396882;4276.636485898703;4286.39990401344;2652.8938842446278;2661.9866900665565;2691.7846572274366;2700.4599080183843;2704.2292946510347;817.4727300890952;834.5576844272546;837.5728378526934;840.6511297811401;847.3433089355736;9629.470379129145;9671.468069256189;9747.415155090646;9773.902260977371;9779.804403911952;3835.175437280998;3875.7286989911;3925.4111883217174;3934.940975885364;3939.7439166454087;8300.377471689526;8317.459365141247;8326.750197494084;8367.246947774729;8422.199891010345;4168.791560421967;4189.790510474464;4229.830806767694;4237.682173836913;4252.681048921343;3742.5883152853166;3819.4079917612817;3850.306944749972;3888.0279930017496;3894.123822139996;3156.210947263184;3161.65221825599;3184.251700850298;3192.808431494071;3194.9616374677857;891.2424439226605;897.1073781587362;901.2159421303508;906.3972458315146;917.4403613795579;1176.582313278791;1191.8569771627288;1194.4923407551755;1195.503865895661;1202.7113492761673;6895.793126206222;6902.654867256617;6938.618375989369;6962.1645402551;7014.719411223596;406.5812213420182;409.34504792332626;410.78433822242965;413.5244468860834;414.04769031228057;5365.1147560652835;5376.7042812644895;5408.378036525771;5411.377691565521;5434.3207099112615;8423.536705481134;8471.449355791854;8537.786555336166;8628.741137765877;8641.827163456695;8490.702825401082;8499.065102838682;8540.74377768668;8556.529390883561;8566.785830354167;6689.565178263398;6789.1852977643985;6821.113255276881;6823.761168359084;6833.726650934006;6525.771597994048;6544.181977252843;6574.4740420765265;6581.177352830896;6605.57063790852;7590.506617069873;7627.885581716389;7638.923610763822;7753.1859154787935;7882.09355924076;7651.617419129133;7800.102988156435;7909.485883417559;7921.32668723165;7981.042274927046;4919.163742163769;5200.97399513;5792.189093526994;5822.243108395882;5850.23946886902;6457.7094030767785;6658.1344425224415;6687.665616719048;6692.732290708317;6695.665216739241;6178.907316390168;6352.650604216812;6379.585326953733;6436.098946147449;6466.321036291121;6288.5598008138995;6297.307296197323;6322.956712142445;6334.303226644974;6404.743810247538;6555.344465553407;6582.605043697394;6633.668316584248;6634.402903738686;6635.236947750877;6076.270847498328;6114.48026917717;6131.908021379593;6136.6011209271255;6169.81490555284;6066.241719785027;6151.9384806151365;6189.535784816067;6189.783357582463;6246.750129994749 22:27:04 INFO - 2015-12-15 22:27:04,673 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.688787105346;305.5630448458705;308.6003625305229;313.3075902256014;313.6753460168726;5509.504144626982;5559.249501317321;5567.6659400436;5629.465200805927;5658.09470484722;5509.47659972303;5527.751251193696;5535.640183388077;5588.463172627529;5630.296212973379;4114.300568903279;4239.258129827268;4248.723832950848;4267.743935363888;4274.166537525184;4220.430241917333;4252.170826688797;4256.787160641956;4270.740131661168;4284.443022407083;4179.561146079648;4208.410822484854;4219.556946520617;4221.957780422187;4230.936535951963;4207.873763787091;4213.178430206111;4227.281362168439;4228.788560571959;4236.322188449864;3612.7832330060282;3641.289948460051;3666.9083272918124;3669.376206044952;3680.5583330000304;5250.65870718402;5374.951884382547;5383.084875571123;5384.326959130109;5421.864453388657;4877.0489754497885;4877.439094504107;4878.585320247747;4881.731504767236;4889.315495830587;5840.065589505702;5857.970710146422;5869.530437564985;5872.618279811842;5912.822615321547;3881.3013657541633;4009.8797036088963;4011.0574015106426;4023.8591649292134;4028.6575641070544;6007.7596896124105;6087.421694939018;6112.113743507211;6201.441870231701;6203.131561581337;4131.442255295497;4136.855210067693;4137.317342638491;4138.275801734684;4152.1280531088805;4188.979055104705;4198.8110535026;4202.747835129902;4205.810738516774;4206.158768246363;4737.407824021997;4829.879253018632;4840.177169881129;4845.442774081026;4851.078295123915;5828.504577110908;5840.5035571976005;5841.41585841421;5843.970780146072;5851.356350801409;1462.3419461242484;1466.171613038651;1467.119728163115;1472.374240947593;1473.145575566169;970.1075010989765;975.7755716185175;979.779549601334;992.93545919515;1005.1757558801712;5095.439501654815;5096.159133742965;5129.666571672829;5130.846074617767;5152.27868098459;6026.860464535114;6060.090986351995;6069.726862291208;6086.2696476422225;6088.847778805565;5045.495450454999;5116;5117;5117.078925793393;5121.820736274212;3199.120241933487;3255.860448842886;3273.525338825857;3299.851506682157;3301.4552598821406;5681.289838770153;5737.3688894221605;5755.309362876482;5758.654480731169;5822.243108395882;6316.842078948063;6324.08300796382;6328.936710632835;6337.461315788118;6354.078658594478;5766.308043034863;5772.913406298909;5783.8554036149435;5799.101139323411;5800.622959507618;5869.618474799125;6064.939350606437;6077.6353418795015;6105.572609917441;6115.388461153849;5975.043992961106;5986.9401305986385;6019.909701354396;6029.60807547508;6036.3058248302;5728.455796699307;5754.136879468113;5795.623284486495;5802.738876750641;5836.766529338949;4040.575739547423;4068.877933661995;4071.491063617048;4086.7752273625238;4126.587341265849;6009.158717779427;6102.908456373069;6104.938950610437;6122.908156377569;6126.448619624255;5844.181814546052;5861.560382971209;5884.911726324023;5903.114532820111;5906.527477801679;5834.883302334015;5885.234919460614;5887.793927212527;5896.14505896634;5902;5584.692841893735;5714.79998200061;5741.5406767459335;5767.826965191051;5773.769049237983;5857;5905.970470147622;5906.320773110975;5913.5564832636865;5952.940470595238;5769.221155144001;5771.307443106854;5772.797952071657;5776.306843178845;5782.2194003808945 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: |5;yui.html;787.6455594982258;791.157417350522;796.7171654062807;802.2779498451393;807.2815194476921;11619.825702614457;11832.822507662391;13474.12418192818;13584.184948903072;13602.659933501667;13037.543685970993;13197.670058248548;13202.933985330084;13240.602781916557;13263.867361326384;788.6372268756364;795.6300320351036;798.7164556582417;799.312591171592;813.0243707550933;795.5346122518305;795.5783434779576;797.3342259213534;797.4896066517433;799.3764863406552;828.3249151941179;831.4553967151526;836.8326334733048;837.0206857976183;839.2488722593275;826.5412695953773;826.6528058215564;836.1972506393839;840.7393707950555;841.524538635675;613.1538476901846;621.6611946489129;623.1680706257152;624.188554878656;624.4972796898495;11629.534818607246;11739.647810565697;11807.527698892034;11940.522379104825;12019.098567607465;10647.680569582924;11193.66419007431;11434.428278586121;11456.140789440826;12155.088368372408;9119.179273865318;9392.718218453458;9414.482203478807;9415.058494150599;9506.38208516451;3187.5059365798106;3212.4538828399227;3227.9677203227902;3240.22234663679;3313.453280208763;40920.59079409198;42004.36993445101;42251.57748422507;42392.57607423917;42561;9138.497382644018;9271.072892710676;9308.534573271309;9377.812443751223;9471.147596716191;16061.678766424606;16146.35414583427;16224.351025959066;16269.674606507804;16350.2204625214;6117.541184411098;6418.326075761977;6455.064015717695;6498.415142637091;6633.701483433257;3485.686288234071;3609.0796846803896;3612.8012959286966;3658.8536458541894;3662.7985460799378;2441.8046556275453;2467.198160597813;2477.6283557466522;2477.860184315235;2478.8140889433366;472.90069085492433;479.71217269638635;481.4246974865003;492.6305271046715;493.67910857942627;520.2794130129722;551.1622334052298;584.5382148102951;600.7056542294245;636.933122022181;7717.189695082048;7834.921650783534;7951.483153595113;7960.363170946311;8057.677692892219;582.7494177503629;597.856514436532;607.0651197156418;622.6450922973952;623.2863371439677;3676.191237927652;3980.7412518186225;3996.760194388346;4007.1785284016705;4169.228692691861;49457.25814112791;49474;49502;49621;49629.50370496249;46821;48250.27624585634;48554;49042.264366034535;49498.267560635206;37364.626353736116;38300.425493617615;40369.59630403658;43441.34837977433;43998;7910.7231246906085;8247.95876020616;8454.154584541497;8543.829123417621;8596.78508037279;32881.67118328786;32945.84689535951;32951.17622059468;33094.33811323808;33245.667543325224;36755.63244367522;37305.25389492249;37395.252094958494;42070;42143.789281053396;9792.80414391694;9940.751481213027;10037;10057.849132263169;10135.7466063349;11435.828462573234;11470.139739519402;11523.078153747512;11527.135464840003;11552.884471155181;10469.424181670081;10603.204759642904;10828;11104.777904442028;11451.370174640142;9985.45080020606;10156.289059765746;10169.44068076263;10221.693349199535;10561.577536898438;10646.148308135176;10655.413952232702;10810.405427701551;10878.45607719595;10952.835707464554;9071.818563628822;9229.861552076858;9366.391184573253;9427.670031548863;9727.80544389094;9044.954775226082;9286.767830804283;9523.999620756635;9723.513824308899;9778.266630002636 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,323 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: __startTimestamp1450247224663__endTimestamp 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,675 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:04 INFO - 2015-12-15 22:27:04,676 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:27:04 INFO - 2015-12-15 22:27:04,676 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,676 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4725.01 Median:4904.17 stddev:498.04 (10.2%) stddev-sans-first:471.77 22:27:04 INFO - 2015-12-15 22:27:04,677 DEBUG : BROWSER_OUTPUT: Values: 2633.8 2704.0 2747.2 2764.9 2769.8 4599.9 4709.5 4725.4 4757.9 4785.4 4661.5 4696.9 4707.7 4736.6 4807.9 4320.7 4431.8 4436.9 4443.3 4485.7 4220.8 4423.9 4432.7 4454.0 4458.0 4308.4 4408.5 4430.9 4431.0 4463.5 4412.4 4452.4 4457.8 4461.8 4516.5 4223.2 4316.3 4360.8 4448.0 4510.4 4702.3 4730.8 4737.8 4754.8 4793.0 5046.7 5116.4 5116.7 5160.9 5163.9 4941.1 5051.6 5121.7 5191.5 5230.2 4658.3 4675.3 4714.3 4743.8 4786.1 5217.9 5219.2 5220.8 5243.6 5269.1 4827.7 4914.2 5030.4 5073.2 5170.2 5130.4 5162.9 5191.5 5205.7 5213.0 4813.6 5119.7 5129.4 5139.9 5156.4 4962.4 4981.4 5021.5 5021.8 5043.7 4177.5 4286.1 4302.9 4304.4 4335.4 3661.7 3768.1 3777.0 3790.5 3842.4 4334.1 4345.6 4398.8 4406.6 4428.7 5100.1 5140.6 5153.4 5155.6 5218.3 4187.4 4333.2 4374.2 4412.8 4464.8 4526.7 4544.4 4610.8 4615.6 4616.5 4889.9 4904.2 4915.9 4931.8 4961.1 4924.4 5068.7 5233.3 5244.0 5247.9 4866.1 4933.0 4946.7 4947.0 4985.4 5092.2 5150.7 5174.4 5175.1 5207.7 4913.6 5029.1 5141.4 5220.1 5248.0 4949.8 4951.9 4953.6 4957.3 4994.6 4930.4 4933.3 4934.1 4955.7 5005.4 4676.4 4720.8 4769.1 4925.0 4932.0 5021.4 5042.5 5052.5 5056.4 5073.7 4912.1 4942.6 4952.4 4978.5 5004.0 22:27:04 INFO - 2015-12-15 22:27:04,677 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,677 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40938.10 Median:35879.91 stddev:64449.98 (179.6%) stddev-sans-first:64559.42 22:27:04 INFO - 2015-12-15 22:27:04,677 DEBUG : BROWSER_OUTPUT: Values: 545.7 546.9 564.2 579.9 581.1 31520.0 31838.7 32033.5 32281.5 32335.8 37447.3 38127.2 38182.4 38373.4 38392.0 7610.7 7736.3 7742.5 7751.6 7773.3 7435.9 7619.7 7637.7 7639.4 7645.0 7774.7 7854.5 7855.4 7872.2 7886.1 7758.8 7770.0 7803.0 7803.6 7856.7 7654.5 7770.9 7800.7 7825.5 7844.0 35287.6 35447.1 35864.0 36270.3 36350.0 2384.9 2899.9 3015.2 3100.7 3767.1 25399.7 25746.7 25873.9 25906.2 26043.3 3188.8 3355.9 3479.3 3539.6 3543.4 199157.0 201106.0 201645.0 201711.0 202151.0 52124.2 53651.7 54365.7 54797.7 55814.2 48844.3 48923.5 48966.3 48970.3 48983.5 13031.5 13057.7 13070.1 13173.5 13210.9 10560.4 10728.8 10766.7 10831.4 10958.9 18640.8 18869.9 18969.2 19175.3 19272.8 7783.2 7908.4 7914.0 8029.2 8110.8 764.4 788.8 836.6 852.7 1005.7 25984.0 26482.5 26712.7 26736.2 26950.3 937.4 946.4 976.1 1052.0 1064.6 13663.5 14189.6 14204.0 14337.9 14622.7 289515.0 291880.0 292398.0 294740.0 294841.0 45949.3 46915.3 47016.5 47203.3 47219.0 1172.7 1186.7 1200.8 1220.2 1227.7 25980.2 26747.5 27552.7 27729.0 28187.7 42184.6 42693.1 42706.6 42848.1 42901.0 236396.0 239599.0 240113.0 240293.0 240444.0 38718.2 42532.8 42860.8 42891.8 43423.3 44259.8 45469.3 45682.0 45976.8 46053.5 32340.5 35895.8 36068.0 37791.4 38106.6 31846.0 31959.2 32183.2 32532.0 32714.7 36756.6 37385.1 37542.2 37739.6 37828.0 27973.7 28418.0 31792.4 34375.3 34721.7 23221.4 23597.9 23917.8 24105.6 24195.6 22:27:04 INFO - 2015-12-15 22:27:04,677 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,678 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24697.58 Median:4068.14 stddev:70427.60 (1731.2%) stddev-sans-first:70601.41 22:27:04 INFO - 2015-12-15 22:27:04,678 DEBUG : BROWSER_OUTPUT: Values: 334.0 334.8 335.1 337.6 338.5 12022.3 12581.5 15808.8 15851.2 16976.0 12616.6 13854.4 15097.8 15135.7 15155.5 4839.2 4924.8 4926.2 4935.4 4943.1 4903.6 5014.1 5048.6 5077.7 5100.3 4957.8 5005.0 5008.6 5020.7 5031.8 4906.4 5008.9 5047.4 5103.7 5103.7 4893.5 4914.7 4922.5 4942.8 4945.3 12017.6 18758.4 19172.5 19302.5 19375.4 1771.5 1793.3 1807.2 1848.1 1929.6 10057.4 11968.4 12166.1 12625.9 12662.6 1713.6 1756.3 1784.5 1792.2 1817.4 55084.0 55861.0 56265.4 56288.4 56837.4 9489.8 9612.8 9660.6 9681.6 9713.4 12204.3 12247.6 12259.4 12309.1 12366.3 7223.4 7243.3 7289.6 7295.3 7385.2 7044.4 7063.2 7082.8 7083.9 7154.0 4018.0 4063.1 4064.3 4072.0 4086.9 1519.5 1569.7 1631.7 1651.0 1696.9 788.4 831.2 833.9 886.3 895.2 12447.4 14542.6 15320.5 15643.8 16447.5 821.3 834.4 881.4 885.3 904.6 8527.6 9126.7 9174.1 9349.8 9379.4 419299.0 423357.0 426155.0 442526.0 443106.0 59998.0 65757.3 69007.3 69429.9 69878.7 1038.1 1039.4 1070.0 1099.0 1103.0 13903.9 14295.9 14547.1 14841.4 15107.8 32943.0 32979.3 33605.8 34103.5 34154.0 42272.0 42555.6 44897.3 45341.5 47681.5 8747.2 8768.3 8861.3 8888.6 8995.4 15899.4 15956.3 16249.9 16363.6 16647.5 13513.2 13816.0 13940.9 14021.2 14043.9 13112.9 13116.9 13287.9 13864.2 13957.7 13635.7 13981.4 14049.7 14143.2 14248.9 8256.3 8795.1 8899.3 8928.4 8928.8 9140.9 9310.7 12100.2 12794.0 13139.7 22:27:04 INFO - 2015-12-15 22:27:04,678 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,678 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4943.83 Median:6189.66 stddev:2606.71 (42.1%) stddev-sans-first:2600.82 22:27:04 INFO - 2015-12-15 22:27:04,679 DEBUG : BROWSER_OUTPUT: Values: 1452.9 1608.8 1706.9 1707.0 1731.1 5963.1 6133.1 6695.9 7182.0 7214.5 6713.2 6856.1 6954.6 6958.9 6969.7 1986.5 2027.5 2030.6 2036.8 2052.6 2040.3 2064.1 2084.0 2085.2 2092.6 2007.0 2009.2 2027.6 2033.2 2039.6 2031.6 2044.4 2045.0 2047.4 2058.1 2028.8 2030.1 2041.9 2044.1 2061.6 6976.3 7011.8 7061.4 7072.5 7086.4 4184.8 4269.8 4273.3 4276.6 4286.4 2652.9 2662.0 2691.8 2700.5 2704.2 817.5 834.6 837.6 840.7 847.3 9629.5 9671.5 9747.4 9773.9 9779.8 3835.2 3875.7 3925.4 3934.9 3939.7 8300.4 8317.5 8326.8 8367.2 8422.2 4168.8 4189.8 4229.8 4237.7 4252.7 3742.6 3819.4 3850.3 3888.0 3894.1 3156.2 3161.7 3184.3 3192.8 3195.0 891.2 897.1 901.2 906.4 917.4 1176.6 1191.9 1194.5 1195.5 1202.7 6895.8 6902.7 6938.6 6962.2 7014.7 406.6 409.3 410.8 413.5 414.0 5365.1 5376.7 5408.4 5411.4 5434.3 8423.5 8471.4 8537.8 8628.7 8641.8 8490.7 8499.1 8540.7 8556.5 8566.8 6689.6 6789.2 6821.1 6823.8 6833.7 6525.8 6544.2 6574.5 6581.2 6605.6 7590.5 7627.9 7638.9 7753.2 7882.1 7651.6 7800.1 7909.5 7921.3 7981.0 4919.2 5201.0 5792.2 5822.2 5850.2 6457.7 6658.1 6687.7 6692.7 6695.7 6178.9 6352.7 6379.6 6436.1 6466.3 6288.6 6297.3 6323.0 6334.3 6404.7 6555.3 6582.6 6633.7 6634.4 6635.2 6076.3 6114.5 6131.9 6136.6 6169.8 6066.2 6151.9 6189.5 6189.8 6246.8 22:27:04 INFO - 2015-12-15 22:27:04,679 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4841.78 Median:5563.46 stddev:1450.07 (26.1%) stddev-sans-first:1413.52 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: Values: 300.7 305.6 308.6 313.3 313.7 5509.5 5559.2 5567.7 5629.5 5658.1 5509.5 5527.8 5535.6 5588.5 5630.3 4114.3 4239.3 4248.7 4267.7 4274.2 4220.4 4252.2 4256.8 4270.7 4284.4 4179.6 4208.4 4219.6 4222.0 4230.9 4207.9 4213.2 4227.3 4228.8 4236.3 3612.8 3641.3 3666.9 3669.4 3680.6 5250.7 5375.0 5383.1 5384.3 5421.9 4877.0 4877.4 4878.6 4881.7 4889.3 5840.1 5858.0 5869.5 5872.6 5912.8 3881.3 4009.9 4011.1 4023.9 4028.7 6007.8 6087.4 6112.1 6201.4 6203.1 4131.4 4136.9 4137.3 4138.3 4152.1 4189.0 4198.8 4202.7 4205.8 4206.2 4737.4 4829.9 4840.2 4845.4 4851.1 5828.5 5840.5 5841.4 5844.0 5851.4 1462.3 1466.2 1467.1 1472.4 1473.1 970.1 975.8 979.8 992.9 1005.2 5095.4 5096.2 5129.7 5130.8 5152.3 6026.9 6060.1 6069.7 6086.3 6088.8 5045.5 5116.0 5117.0 5117.1 5121.8 3199.1 3255.9 3273.5 3299.9 3301.5 5681.3 5737.4 5755.3 5758.7 5822.2 6316.8 6324.1 6328.9 6337.5 6354.1 5766.3 5772.9 5783.9 5799.1 5800.6 5869.6 6064.9 6077.6 6105.6 6115.4 5975.0 5986.9 6019.9 6029.6 6036.3 5728.5 5754.1 5795.6 5802.7 5836.8 4040.6 4068.9 4071.5 4086.8 4126.6 6009.2 6102.9 6104.9 6122.9 6126.4 5844.2 5861.6 5884.9 5903.1 5906.5 5834.9 5885.2 5887.8 5896.1 5902.0 5584.7 5714.8 5741.5 5767.8 5773.8 5857.0 5906.0 5906.3 5913.6 5952.9 5769.2 5771.3 5772.8 5776.3 5782.2 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12541.58 Median:24365.85 stddev:14196.00 (58.3%) stddev-sans-first:14208.38 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: Values: 787.6 791.2 796.7 802.3 807.3 11619.8 11832.8 13474.1 13584.2 13602.7 13037.5 13197.7 13202.9 13240.6 13263.9 788.6 795.6 798.7 799.3 813.0 795.5 795.6 797.3 797.5 799.4 828.3 831.5 836.8 837.0 839.2 826.5 826.7 836.2 840.7 841.5 613.2 621.7 623.2 624.2 624.5 11629.5 11739.6 11807.5 11940.5 12019.1 10647.7 11193.7 11434.4 11456.1 12155.1 9119.2 9392.7 9414.5 9415.1 9506.4 3187.5 3212.5 3228.0 3240.2 3313.5 40920.6 42004.4 42251.6 42392.6 42561.0 9138.5 9271.1 9308.5 9377.8 9471.1 16061.7 16146.4 16224.4 16269.7 16350.2 6117.5 6418.3 6455.1 6498.4 6633.7 3485.7 3609.1 3612.8 3658.9 3662.8 2441.8 2467.2 2477.6 2477.9 2478.8 472.9 479.7 481.4 492.6 493.7 520.3 551.2 584.5 600.7 636.9 7717.2 7834.9 7951.5 7960.4 8057.7 582.7 597.9 607.1 622.6 623.3 3676.2 3980.7 3996.8 4007.2 4169.2 49457.3 49474.0 49502.0 49621.0 49629.5 46821.0 48250.3 48554.0 49042.3 49498.3 37364.6 38300.4 40369.6 43441.3 43998.0 7910.7 8248.0 8454.2 8543.8 8596.8 32881.7 32945.8 32951.2 33094.3 33245.7 36755.6 37305.3 37395.3 42070.0 42143.8 9792.8 9940.8 10037.0 10057.8 10135.7 11435.8 11470.1 11523.1 11527.1 11552.9 10469.4 10603.2 10828.0 11104.8 11451.4 9985.5 10156.3 10169.4 10221.7 10561.6 10646.1 10655.4 10810.4 10878.5 10952.8 9071.8 9229.9 9366.4 9427.7 9727.8 9045.0 9286.8 9524.0 9723.5 9778.3 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:04 INFO - 2015-12-15 22:27:04,680 DEBUG : BROWSER_OUTPUT: 22:27:05 INFO - 2015-12-15 22:27:05,398 INFO : Browser exited with error code: 0 22:27:05 INFO - 2015-12-15 22:27:05,414 INFO : Completed test dromaeo_css (00:18:34) 22:27:05 INFO - 2015-12-15 22:27:05,414 INFO : Starting test kraken 22:27:05 INFO - 2015-12-15 22:27:05,414 DEBUG : operating with platform_type : linux_ 22:27:05 INFO - 2015-12-15 22:27:05,414 INFO : Initialising browser for kraken test... 22:27:05 INFO - 2015-12-15 22:27:05,420 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfuENb/profile http://localhost:40888/getInfo.html 22:27:10 INFO - 2015-12-15 22:27:10,193 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:27:10 INFO - 2015-12-15 22:27:10,193 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:27:10 INFO - 2015-12-15 22:27:10,193 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:27:10 INFO - 2015-12-15 22:27:10,193 DEBUG : BROWSER_OUTPUT: __metrics 22:27:10 INFO - 2015-12-15 22:27:10,322 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:27:11 INFO - 2015-12-15 22:27:11,251 INFO : Browser initialized. 22:27:11 INFO - 2015-12-15 22:27:11,252 INFO : Running cycle 1/1 for kraken test... 22:27:11 INFO - 2015-12-15 22:27:11,252 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfuENb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:27:23 INFO - 2015-12-15 22:27:23,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 143253504 22:27:23 INFO - 2015-12-15 22:27:23,305 DEBUG : BROWSER_OUTPUT: 22:27:25 INFO - 2015-12-15 22:27:25,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40888/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:26 INFO - 2015-12-15 22:27:26,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 142860288 22:27:26 INFO - 2015-12-15 22:27:26,527 DEBUG : BROWSER_OUTPUT: 22:27:29 INFO - 2015-12-15 22:27:29,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40888/tests/kraken/driver.html?testName=audio-dft) 22:27:29 INFO - 2015-12-15 22:27:29,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 142462976 22:27:29 INFO - 2015-12-15 22:27:29,900 DEBUG : BROWSER_OUTPUT: 22:27:32 INFO - 2015-12-15 22:27:32,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40888/tests/kraken/driver.html?testName=audio-fft) 22:27:33 INFO - 2015-12-15 22:27:33,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 138162176 22:27:33 INFO - 2015-12-15 22:27:33,383 DEBUG : BROWSER_OUTPUT: 22:27:35 INFO - 2015-12-15 22:27:35,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40888/tests/kraken/driver.html?testName=audio-oscillator) 22:27:36 INFO - 2015-12-15 22:27:36,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 22:27:36 INFO - 2015-12-15 22:27:36,121 DEBUG : BROWSER_OUTPUT: 22:27:38 INFO - 2015-12-15 22:27:38,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40888/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:38 INFO - 2015-12-15 22:27:38,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 139993088 22:27:38 INFO - 2015-12-15 22:27:38,989 DEBUG : BROWSER_OUTPUT: 22:27:42 INFO - 2015-12-15 22:27:42,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40888/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:42 INFO - 2015-12-15 22:27:42,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 141656064 22:27:42 INFO - 2015-12-15 22:27:42,645 DEBUG : BROWSER_OUTPUT: 22:27:46 INFO - 2015-12-15 22:27:46,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40888/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:46 INFO - 2015-12-15 22:27:46,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 137568256 22:27:46 INFO - 2015-12-15 22:27:46,722 DEBUG : BROWSER_OUTPUT: 22:27:49 INFO - 2015-12-15 22:27:49,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40888/tests/kraken/driver.html?testName=json-parse-financial) 22:27:50 INFO - 2015-12-15 22:27:50,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 137732096 22:27:50 INFO - 2015-12-15 22:27:50,246 DEBUG : BROWSER_OUTPUT: 22:27:52 INFO - 2015-12-15 22:27:52,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40888/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:52 INFO - 2015-12-15 22:27:52,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 140853248 22:27:52 INFO - 2015-12-15 22:27:52,602 DEBUG : BROWSER_OUTPUT: 22:27:54 INFO - 2015-12-15 22:27:54,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:55 INFO - 2015-12-15 22:27:55,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 22:27:55 INFO - 2015-12-15 22:27:55,119 DEBUG : BROWSER_OUTPUT: 22:27:57 INFO - 2015-12-15 22:27:57,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:57 INFO - 2015-12-15 22:27:57,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 140238848 22:27:57 INFO - 2015-12-15 22:27:57,867 DEBUG : BROWSER_OUTPUT: 22:28:00 INFO - 2015-12-15 22:28:00,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:28:01 INFO - 2015-12-15 22:28:01,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 140414976 22:28:01 INFO - 2015-12-15 22:28:01,092 DEBUG : BROWSER_OUTPUT: 22:28:03 INFO - 2015-12-15 22:28:03,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:28:04 INFO - 2015-12-15 22:28:04,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 141484032 22:28:04 INFO - 2015-12-15 22:28:04,315 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40888/tests/kraken/driver.html?testName=ai-astar) 22:28:06 INFO - 2015-12-15 22:28:06,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 140664832 22:28:06 INFO - 2015-12-15 22:28:06,348 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,348 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:28:06 INFO - 2015-12-15 22:28:06,349 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:28:06 INFO - 2015-12-15 22:28:06,350 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:28:06 INFO - 2015-12-15 22:28:06,350 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:28:06 INFO - 2015-12-15 22:28:06,350 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;114;115;115;124;116;113;112;114 22:28:06 INFO - 2015-12-15 22:28:06,350 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;131;151;170;131;168;158;138;179;131 22:28:06 INFO - 2015-12-15 22:28:06,350 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;164;162;164;167;166;167;164;166 22:28:06 INFO - 2015-12-15 22:28:06,350 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;74;74;73;78;136;73;72;73 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;138;95;96;96;143;94;96;130 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;111;112;112;111;111;111;115;110;111 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;149;150;149;149;149;147;149;149;148 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;96;97;96;97;96;97 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;73;73;75;74;72;74;74;73;71 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;69;69;69;68;69 22:28:06 INFO - 2015-12-15 22:28:06,351 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;86;85;83;93;84;83;83;86 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;137;126;122;131;123;131;123;146;131 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;150;154;142;147;143;150;151;151;142 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;71;74;72;72;72;71;70;70;72 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,783 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:28:06 INFO - 2015-12-15 22:28:06,352 DEBUG : BROWSER_OUTPUT: __startTimestamp1450247286347__endTimestamp 22:28:06 INFO - 2015-12-15 22:28:06,353 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:3.68 (3.2%) stddev-sans-first:3.90 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 114.0 115.0 115.0 124.0 116.0 113.0 112.0 114.0 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.90 Median:160.00 stddev:18.15 (11.3%) stddev-sans-first:18.88 22:28:06 INFO - 2015-12-15 22:28:06,356 DEBUG : BROWSER_OUTPUT: Values: 162.0 131.0 151.0 170.0 131.0 168.0 158.0 138.0 179.0 131.0 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 162.0 164.0 167.0 166.0 167.0 164.0 166.0 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.50 stddev:19.71 (26.8%) stddev-sans-first:20.74 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 74.0 74.0 73.0 78.0 136.0 73.0 72.0 73.0 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.50 stddev:20.33 (21.3%) stddev-sans-first:21.02 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 138.0 95.0 96.0 96.0 143.0 94.0 96.0 130.0 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,357 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.60 Median:111.50 stddev:1.35 (1.2%) stddev-sans-first:1.42 22:28:06 INFO - 2015-12-15 22:28:06,358 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 112.0 112.0 111.0 111.0 111.0 115.0 110.0 111.0 22:28:06 INFO - 2015-12-15 22:28:06,358 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,358 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 22:28:06 INFO - 2015-12-15 22:28:06,358 DEBUG : BROWSER_OUTPUT: Values: 150.0 149.0 150.0 149.0 149.0 149.0 147.0 149.0 149.0 148.0 22:28:06 INFO - 2015-12-15 22:28:06,358 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,358 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:73.50 stddev:1.33 (1.8%) stddev-sans-first:1.20 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 73.0 75.0 74.0 72.0 74.0 74.0 73.0 71.0 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 22:28:06 INFO - 2015-12-15 22:28:06,359 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:2.95 (3.5%) stddev-sans-first:3.12 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 86.0 85.0 83.0 93.0 84.0 83.0 83.0 86.0 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:131.00 stddev:7.35 (5.6%) stddev-sans-first:7.79 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: Values: 130.0 137.0 126.0 122.0 131.0 123.0 131.0 123.0 146.0 131.0 22:28:06 INFO - 2015-12-15 22:28:06,360 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:5.22 (3.5%) stddev-sans-first:4.47 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: Values: 138.0 150.0 154.0 142.0 147.0 143.0 150.0 151.0 151.0 142.0 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.25 (1.7%) stddev-sans-first:1.24 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 74.0 72.0 72.0 72.0 71.0 70.0 70.0 72.0 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:28:06 INFO - 2015-12-15 22:28:06,361 DEBUG : BROWSER_OUTPUT: 22:28:07 INFO - 2015-12-15 22:28:07,290 INFO : Browser exited with error code: 0 22:28:07 INFO - 2015-12-15 22:28:07,341 INFO : Completed test kraken (00:01:01) 22:28:07 INFO - 2015-12-15 22:28:07,341 INFO : Starting test v8_7 22:28:07 INFO - 2015-12-15 22:28:07,341 DEBUG : operating with platform_type : linux_ 22:28:07 INFO - 2015-12-15 22:28:07,341 INFO : Initialising browser for v8_7 test... 22:28:07 INFO - 2015-12-15 22:28:07,347 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDyLDk/profile http://localhost:40888/getInfo.html 22:28:11 INFO - 2015-12-15 22:28:11,948 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:28:11 INFO - 2015-12-15 22:28:11,949 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:28:11 INFO - 2015-12-15 22:28:11,949 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:28:11 INFO - 2015-12-15 22:28:11,949 DEBUG : BROWSER_OUTPUT: __metrics 22:28:12 INFO - 2015-12-15 22:28:12,066 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:28:12 INFO - 2015-12-15 22:28:12,966 INFO : Browser initialized. 22:28:12 INFO - 2015-12-15 22:28:12,966 INFO : Running cycle 1/1 for v8_7 test... 22:28:12 INFO - 2015-12-15 22:28:12,966 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDyLDk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:28:25 INFO - 2015-12-15 22:28:25,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 142807040 22:28:25 INFO - 2015-12-15 22:28:25,004 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40888/tests/v8_7/run.html (next: http://localhost:40888/tests/v8_7/run.html) 22:28:46 INFO - 2015-12-15 22:28:46,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 137351168 22:28:46 INFO - 2015-12-15 22:28:46,708 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,708 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:28:46 INFO - 2015-12-15 22:28:46,709 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:28:46 INFO - 2015-12-15 22:28:46,709 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:28:46 INFO - 2015-12-15 22:28:46,709 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:28:46 INFO - 2015-12-15 22:28:46,709 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 22:28:46 INFO - 2015-12-15 22:28:46,709 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.01190476190476 22:28:46 INFO - 2015-12-15 22:28:46,709 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 22:28:46 INFO - 2015-12-15 22:28:46,710 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 22:28:46 INFO - 2015-12-15 22:28:46,710 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1061.5711252653928 22:28:46 INFO - 2015-12-15 22:28:46,710 DEBUG : BROWSER_OUTPUT: |5;Earley;711.7437722419929 22:28:46 INFO - 2015-12-15 22:28:46,710 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 22:28:46 INFO - 2015-12-15 22:28:46,710 DEBUG : BROWSER_OUTPUT: |7;RegExp;26230.76923076923 22:28:46 INFO - 2015-12-15 22:28:46,711 DEBUG : BROWSER_OUTPUT: |8;Splay;602.0469596628537 22:28:46 INFO - 2015-12-15 22:28:46,711 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4868.9320388349515 22:28:46 INFO - 2015-12-15 22:28:46,711 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:28:46 INFO - 2015-12-15 22:28:46,711 DEBUG : BROWSER_OUTPUT: __startTimestamp1450247326707__endTimestamp 22:28:46 INFO - 2015-12-15 22:28:46,711 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,711 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:28:46 INFO - 2015-12-15 22:28:46,712 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:28:46 INFO - 2015-12-15 22:28:46,712 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,712 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,712 DEBUG : BROWSER_OUTPUT: Values: 166.0 22:28:46 INFO - 2015-12-15 22:28:46,712 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,712 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.01 Median:186.01 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,713 DEBUG : BROWSER_OUTPUT: Values: 186.0 22:28:46 INFO - 2015-12-15 22:28:46,713 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,713 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,713 DEBUG : BROWSER_OUTPUT: Values: 278.0 22:28:46 INFO - 2015-12-15 22:28:46,713 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,713 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,714 DEBUG : BROWSER_OUTPUT: Values: 5202.1 22:28:46 INFO - 2015-12-15 22:28:46,714 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,715 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,715 DEBUG : BROWSER_OUTPUT: Values: 1061.6 22:28:46 INFO - 2015-12-15 22:28:46,715 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,715 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:711.74 Median:711.74 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: Values: 711.7 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: Values: 12231.7 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: Values: 26230.8 22:28:46 INFO - 2015-12-15 22:28:46,716 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.05 Median:602.05 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: Values: 602.0 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: Values: 4868.9 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:28:46 INFO - 2015-12-15 22:28:46,717 DEBUG : BROWSER_OUTPUT: 22:28:47 INFO - 2015-12-15 22:28:47,666 INFO : Browser exited with error code: 0 22:28:47 INFO - 2015-12-15 22:28:47,683 INFO : Completed test v8_7 (00:00:40) 22:28:48 INFO - 2015-12-15 22:28:48,160 INFO : Completed test suite (00:20:17) 22:28:48 INFO - 2015-12-15 22:28:48,160 DEBUG : Working with test: dromaeo_css 22:28:48 INFO - 2015-12-15 22:28:48,160 DEBUG : Generating results file: dromaeo_css 22:28:48 INFO - 2015-12-15 22:28:48,161 DEBUG : Working with test: kraken 22:28:48 INFO - 2015-12-15 22:28:48,161 DEBUG : Generating results file: kraken 22:28:48 INFO - 2015-12-15 22:28:48,161 INFO : javascript benchmark 22:28:48 INFO - 2015-12-15 22:28:48,162 DEBUG : Working with test: v8_7 22:28:48 INFO - 2015-12-15 22:28:48,162 DEBUG : Generating results file: v8_7 22:28:48 INFO - 2015-12-15 22:28:48,162 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:48 INFO - 2015-12-15 22:28:48,217 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 22:28:48 INFO - 2015-12-15 22:28:48,217 DEBUG : process_Request line: dromaeo_css 6361.25 graph.html#tests=[[72,132,43]] 22:28:48 INFO - 2015-12-15 22:28:48,218 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:48 INFO - 2015-12-15 22:28:48,247 DEBUG : process_Request line: kraken 1551.90 graph.html#tests=[[232,132,43]] 22:28:48 INFO - 2015-12-15 22:28:48,247 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:48 INFO - 2015-12-15 22:28:48,280 DEBUG : process_Request line: v8_7 21348.15 graph.html#tests=[[230,132,43]] 22:28:48 INFO - 2015-12-15 22:28:48,281 INFO : javascript benchmark 22:28:48 INFO - 2015-12-15 22:28:48,285 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.8156329056965, 2704.0265504418417, 2747.1621155547564, 2764.8755805988735, 2769.7784177265835, 4599.908001839961, 4709.481956984733, 4725.362076119723, 4757.90484190316, 4785.401824771903, 4661.510541393156, 4696.929546056812, 4707.717536947785, 4736.644751643632, 4807.903841923168, 4320.740755554661, 4431.800568974404, 4436.933445998313, 4443.333499974998, 4485.686001979862, 4220.810063547133, 4423.911521769563, 4432.734035957853, 4453.955460445402, 4458.0, 4308.439902812645, 4408.537103604108, 4430.914425965627, 4431.0, 4463.4866990296205, 4412.426384569985, 4452.3989261449615, 4457.751829487748, 4461.754603496806, 4516.54834516549, 4223.239816832969, 4316.26623474007, 4360.760158191299, 4448.043670610834, 4510.391097201901, 4702.341672165865, 4730.810767569293, 4737.786799594027, 4754.78603462845, 4792.969511555032, 5046.697198168085, 5116.437191908887, 5116.6674166179455, 5160.92258616121, 5163.948360516422, 4941.061198372334, 5051.646384753069, 5121.667091639031, 5191.532762051434, 5230.163173892159, 4658.34783130362, 4675.322078298627, 4714.292856071616, 4743.810247590092, 4786.138495070851, 5217.895642087137, 5219.243209734567, 5220.817271395559, 5243.632945693841, 5269.130593452114, 4827.672390092753, 4914.213725803854, 5030.3963524377305, 5073.239014147907, 5170.198619213953, 5130.410002849645, 5162.92255616166, 5191.532762051434, 5205.6616319939085, 5213.0, 4813.566778989908, 5119.744012799345, 5129.410117836422, 5139.948600513947, 5156.432792392834, 4962.354893863847, 4981.37732783402, 5021.472745361758, 5021.799128034838, 5043.672161309577, 4177.4778152730905, 4286.078493123993, 4302.870913872589, 4304.3543468479975, 4335.436393268855, 3661.7436779425184, 3768.095657042345, 3777.036855601859, 3790.5261842269715, 3842.366009608383, 4334.111507141029, 4345.587169218982, 4398.846040388571, 4406.559344065632, 4428.6678499112695, 5100.056489549445, 5140.640155189101, 5153.4073581538605, 5155.561777248976, 5218.295530103387, 4187.43469631602, 4333.198358303724, 4374.19077470669, 4412.801423935931, 4464.843730469418, 4526.660500462479, 4544.363789069533, 4610.792514336863, 4615.561521655437, 4616.469106052847, 4889.877753056202, 4904.166291730415, 4915.901681966269, 4931.778069986859, 4961.08219979305, 4924.359833221658, 5068.721220332917, 5233.293505376725, 5244.003639308519, 5247.895042099213, 4866.099771542276, 4933.0, 4946.653734238713, 4946.950530494649, 4985.351904252424, 5092.159793634157, 5150.665206761549, 5174.404943431554, 5175.120229561059, 5207.71357575337, 4913.557779799835, 5029.094762942559, 5141.38303403594, 5220.138677118233, 5248.0, 4949.802007919643, 4951.876203094951, 4953.603711702983, 4957.330760347307, 4994.5754610858485, 4930.408350997904, 4933.333999909966, 4934.136526107988, 4955.72743499111, 5005.424376196784, 4676.392069031004, 4720.811167553396, 4769.14155452022, 4925.0, 4931.9753401232765, 5021.4225364083595, 5042.520960508746, 5052.494750524918, 5056.418511871182, 5073.746312684277, 4912.066707325596, 4942.629302802232, 4952.380952380952, 4978.47725988766, 5003.974980125222], "unit": "score", "name": "dojo.html", "value": 4693.847379932828}, {"lowerIsBetter": false, "replicates": [545.6725964421345, 546.8578169675884, 564.1763025982066, 579.9155579067145, 581.0557843504304, 31520.0, 31838.68161318386, 32033.51949720756, 32281.51577726336, 32335.838320808423, 37447.251054978886, 38127.23745525088, 38182.42726359107, 38373.42439863397, 38392.0, 7610.69557217712, 7736.34241089508, 7742.458027938046, 7751.573663448508, 7773.339266162355, 7435.925640743604, 7619.695212191506, 7637.732679356223, 7639.433916047225, 7645.0, 7774.650140743652, 7854.489458185229, 7855.41084418668, 7872.173421790715, 7886.132525422227, 7758.8448231035345, 7770.0, 7803.0, 7803.5708036057995, 7856.7250146244605, 7654.502457340255, 7770.922290777133, 7800.687972481094, 7825.491343062739, 7844.0, 35287.647123528695, 35447.113822154395, 35864.0, 36270.27459450823, 36350.0, 2384.9489439082377, 2899.913002609925, 3015.2311160654112, 3100.705432983863, 3767.1335592813807, 25399.74600254011, 25746.742532574623, 25873.870630646914, 25906.22281331563, 26043.348916277057, 3188.8086714797187, 3355.899323020313, 3479.3389256041523, 3539.5752509699, 3543.3976224041976, 199157.0, 201106.0, 201645.0, 201711.0, 202150.99999999852, 52124.21813672798, 53651.73174134104, 54365.72817135968, 54797.72601136969, 55814.16278755822, 48844.26733598928, 48923.51076489189, 48966.26550601744, 48970.26544601834, 48983.51016489861, 13031.543895963785, 13057.738845223043, 13070.085094043516, 13173.538926137539, 13210.867891320964, 10560.419176945188, 10728.839067413996, 10766.676999690022, 10831.350118992885, 10958.945205273923, 18640.81359186418, 18869.90565047166, 18969.24945882839, 19175.32886348971, 19272.80727192738, 7783.221677832172, 7908.367330613537, 7913.985371117877, 8029.156938521488, 8110.797230069177, 764.3999460423652, 788.7633709887011, 836.615157027774, 852.7356519478982, 1005.6681295172575, 25984.0, 26482.47035059288, 26712.732872671415, 26736.19791406261, 26950.32624184372, 937.3625934364561, 946.417952958939, 976.0922342221802, 1052.0478966535297, 1064.6114168328659, 13663.453461861414, 14189.645258868612, 14204.0, 14337.85662143386, 14622.707545849024, 289515.0, 291880.0, 292398.0, 294740.0, 294841.0, 45949.31076033862, 46915.29627055597, 47016.529834701214, 47203.29195062077, 47219.0, 1172.6775136837268, 1186.6558697977662, 1200.8498937632796, 1220.2434490615874, 1227.6501197158766, 25980.22059338223, 26747.465050698487, 27552.724472755017, 27729.0, 28187.71812281933, 42184.57815421806, 42693.14613707647, 42706.57293427026, 42848.14303713971, 42901.0, 236396.0, 239599.0, 240113.0, 240293.0, 240444.0, 38718.225635487695, 42532.78733606312, 42860.78569607132, 42891.785541072095, 43423.34864976965, 44259.77870110758, 45469.317960229964, 45682.0, 45976.77011614921, 46053.53946460626, 32340.514892277104, 35895.82052089723, 36068.0, 37791.43312850255, 38106.61893381031, 31846.01924759405, 31959.201019974687, 32183.195420114684, 32532.0, 32714.672853271164, 36756.632433676394, 37385.065373365884, 37542.2491550162, 37739.62260377361, 37828.0, 27973.720262797113, 28418.00536981196, 31792.364152716353, 34375.31249375048, 34721.65278347184, 23221.41946451352, 23597.882010589838, 23917.760822391552, 24105.638415424135, 24195.63706544368], "unit": "score", "name": "ext.html", "value": 16985.846052932975}, {"lowerIsBetter": false, "replicates": [334.0446323514746, 334.7690093835254, 335.14872224549646, 337.5510570940649, 338.48043253605704, 12022.256772767943, 12581.496740130384, 15808.762868556967, 15851.207439628015, 16976.0, 12616.558420455285, 13854.445822167101, 15097.84902150978, 15135.697286054272, 15155.469558565452, 4839.177339852234, 4924.753762311888, 4926.2364333528185, 4935.358403407552, 4943.060818444484, 4903.632227582928, 5014.1225285575065, 5048.57087147591, 5077.746112694369, 5100.336956195708, 4957.826476073338, 5004.974975125119, 5008.599312055045, 5020.673656212334, 5031.823886163985, 4906.386701662293, 5008.924866127011, 5047.419546752134, 5103.668261563023, 5103.693778373309, 4893.510648935114, 4914.729689867056, 4922.458529561745, 4942.827001054946, 4945.2582112683385, 12017.579384721581, 18758.437246882615, 19172.520686982796, 19302.517437064045, 19375.4187374379, 1771.477414162825, 1793.2737241417117, 1807.2319264312614, 1848.0881503178018, 1929.604431091623, 10057.446840423774, 11968.401579920968, 12166.148369614131, 12625.936870315682, 12662.620121396372, 1713.6315692126127, 1756.3150371355182, 1784.4646606018273, 1792.2217575721431, 1817.4002579148848, 55084.0, 55861.0, 56265.43734562684, 56288.43711562873, 56837.431625683625, 9489.762755931157, 9612.807743845224, 9660.613575457044, 9681.564329605184, 9713.36863103896, 12204.32876191818, 12247.571335003233, 12259.38703064861, 12309.138360314691, 12366.258024518558, 7223.422126229994, 7243.311885370881, 7289.635518224068, 7295.270472952769, 7385.150707668579, 7044.366007059287, 7063.223045464994, 7082.752103676346, 7083.858322833515, 7153.998440218374, 4017.9754162688328, 4063.1061166543313, 4064.3293856513346, 4071.959280407217, 4086.8569600063856, 1519.5441367589679, 1569.686062787447, 1631.6736652669513, 1651.0, 1696.8981861088128, 788.3693045563641, 831.2061980808313, 833.8749187621905, 886.3086792302015, 895.2032690905099, 12447.439865206088, 14542.636434089232, 15320.540383788504, 15643.765343519857, 16447.506574802774, 821.322409012567, 834.3617132893341, 881.4358810361374, 885.2563846368952, 904.6110172625835, 8527.573621319034, 9126.680566180152, 9174.128457796498, 9349.766255843659, 9379.390339627902, 419299.0, 423357.0, 426155.0, 442526.0, 443106.0, 59998.0, 65757.34242657608, 69007.30992690008, 69429.91749133763, 69878.65060674766, 1038.1072277841051, 1039.3971496531992, 1070.0476575847501, 1098.9670309890716, 1102.9779404411868, 13903.930480347533, 14295.92852035733, 14547.127172369692, 14841.40634374613, 15107.848921510644, 32943.0, 32979.34041319208, 33605.83197083999, 34103.4884476738, 34153.975380738615, 42272.0, 42555.57444425516, 44897.32654010258, 45341.54658453373, 47681.523184767706, 8747.15717391863, 8768.298536116969, 8861.291096712377, 8888.64445422176, 8995.370324077252, 15899.364025439316, 15956.281967311266, 16249.918750406172, 16363.590910226863, 16647.50057498277, 13513.189208647513, 13816.032877698464, 13940.860591394361, 14021.228832414316, 14043.859561404255, 13112.934435327763, 13116.868831311947, 13287.867121328663, 13864.168149911038, 13957.651058723613, 13635.659108522366, 13981.370838312097, 14049.719005620034, 14143.222122783345, 14248.857511424752, 8256.25693687571, 8795.120487951153, 8899.332550058902, 8928.375013748975, 8928.776780580538, 9140.862887056566, 9310.72067837966, 12100.213486123374, 12794.0, 13139.73720525565], "unit": "score", "name": "jquery.html", "value": 8211.132414246167}, {"lowerIsBetter": false, "replicates": [1452.941882324707, 1608.8471595198455, 1706.9146542672863, 1706.9573260668483, 1731.1430841733336, 5963.07572326289, 6133.141360209563, 6695.899561506575, 7182.0, 7214.494985351028, 6713.160854893138, 6856.108705868231, 6954.617496037716, 6958.895616565743, 6969.651517424121, 1986.4835142862814, 2027.5336672565318, 2030.6446371884936, 2036.775954644988, 2052.5894821035777, 2040.3266921915806, 2064.07116797441, 2084.0, 2085.2076211039785, 2092.5605622819226, 2007.0, 2009.2465325502938, 2027.564073724149, 2033.2375359240284, 2039.6022775558772, 2031.6038372517364, 2044.37646517812, 2044.9591008179752, 2047.4164863014043, 2058.125296748876, 2028.847836412275, 2030.0661695620033, 2041.9285325013552, 2044.080163926239, 2061.628906796776, 6976.302369763034, 7011.789646310619, 7061.435085193172, 7072.504924655276, 7086.433085353159, 4184.790760461965, 4269.765162916069, 4273.316269396882, 4276.636485898703, 4286.39990401344, 2652.8938842446278, 2661.9866900665565, 2691.7846572274366, 2700.4599080183843, 2704.2292946510347, 817.4727300890952, 834.5576844272546, 837.5728378526934, 840.6511297811401, 847.3433089355736, 9629.470379129145, 9671.468069256189, 9747.415155090646, 9773.902260977371, 9779.804403911952, 3835.175437280998, 3875.7286989911, 3925.4111883217174, 3934.940975885364, 3939.7439166454087, 8300.377471689526, 8317.459365141247, 8326.750197494084, 8367.246947774729, 8422.199891010345, 4168.791560421967, 4189.790510474464, 4229.830806767694, 4237.682173836913, 4252.681048921343, 3742.5883152853166, 3819.4079917612817, 3850.306944749972, 3888.0279930017496, 3894.123822139996, 3156.210947263184, 3161.65221825599, 3184.251700850298, 3192.808431494071, 3194.9616374677857, 891.2424439226605, 897.1073781587362, 901.2159421303508, 906.3972458315146, 917.4403613795579, 1176.582313278791, 1191.8569771627288, 1194.4923407551755, 1195.503865895661, 1202.7113492761673, 6895.793126206222, 6902.654867256617, 6938.618375989369, 6962.1645402551, 7014.719411223596, 406.5812213420182, 409.34504792332626, 410.78433822242965, 413.5244468860834, 414.04769031228057, 5365.1147560652835, 5376.7042812644895, 5408.378036525771, 5411.377691565521, 5434.3207099112615, 8423.536705481134, 8471.449355791854, 8537.786555336166, 8628.741137765877, 8641.827163456695, 8490.702825401082, 8499.065102838682, 8540.74377768668, 8556.529390883561, 8566.785830354167, 6689.565178263398, 6789.1852977643985, 6821.113255276881, 6823.761168359084, 6833.726650934006, 6525.771597994048, 6544.181977252843, 6574.4740420765265, 6581.177352830896, 6605.57063790852, 7590.506617069873, 7627.885581716389, 7638.923610763822, 7753.1859154787935, 7882.09355924076, 7651.617419129133, 7800.102988156435, 7909.485883417559, 7921.32668723165, 7981.042274927046, 4919.163742163769, 5200.97399513, 5792.189093526994, 5822.243108395882, 5850.23946886902, 6457.7094030767785, 6658.1344425224415, 6687.665616719048, 6692.732290708317, 6695.665216739241, 6178.907316390168, 6352.650604216812, 6379.585326953733, 6436.098946147449, 6466.321036291121, 6288.5598008138995, 6297.307296197323, 6322.956712142445, 6334.303226644974, 6404.743810247538, 6555.344465553407, 6582.605043697394, 6633.668316584248, 6634.402903738686, 6635.236947750877, 6076.270847498328, 6114.48026917717, 6131.908021379593, 6136.6011209271255, 6169.81490555284, 6066.241719785027, 6151.9384806151365, 6189.535784816067, 6189.783357582463, 6246.750129994749], "unit": "score", "name": "mootools.html", "value": 3967.2020898233254}, {"lowerIsBetter": false, "replicates": [300.688787105346, 305.5630448458705, 308.6003625305229, 313.3075902256014, 313.6753460168726, 5509.504144626982, 5559.249501317321, 5567.6659400436, 5629.465200805927, 5658.09470484722, 5509.47659972303, 5527.751251193696, 5535.640183388077, 5588.463172627529, 5630.296212973379, 4114.300568903279, 4239.258129827268, 4248.723832950848, 4267.743935363888, 4274.166537525184, 4220.430241917333, 4252.170826688797, 4256.787160641956, 4270.740131661168, 4284.443022407083, 4179.561146079648, 4208.410822484854, 4219.556946520617, 4221.957780422187, 4230.936535951963, 4207.873763787091, 4213.178430206111, 4227.281362168439, 4228.788560571959, 4236.322188449864, 3612.7832330060282, 3641.289948460051, 3666.9083272918124, 3669.376206044952, 3680.5583330000304, 5250.65870718402, 5374.951884382547, 5383.084875571123, 5384.326959130109, 5421.864453388657, 4877.0489754497885, 4877.439094504107, 4878.585320247747, 4881.731504767236, 4889.315495830587, 5840.065589505702, 5857.970710146422, 5869.530437564985, 5872.618279811842, 5912.822615321547, 3881.3013657541633, 4009.8797036088963, 4011.0574015106426, 4023.8591649292134, 4028.6575641070544, 6007.7596896124105, 6087.421694939018, 6112.113743507211, 6201.441870231701, 6203.131561581337, 4131.442255295497, 4136.855210067693, 4137.317342638491, 4138.275801734684, 4152.1280531088805, 4188.979055104705, 4198.8110535026, 4202.747835129902, 4205.810738516774, 4206.158768246363, 4737.407824021997, 4829.879253018632, 4840.177169881129, 4845.442774081026, 4851.078295123915, 5828.504577110908, 5840.5035571976005, 5841.41585841421, 5843.970780146072, 5851.356350801409, 1462.3419461242484, 1466.171613038651, 1467.119728163115, 1472.374240947593, 1473.145575566169, 970.1075010989765, 975.7755716185175, 979.779549601334, 992.93545919515, 1005.1757558801712, 5095.439501654815, 5096.159133742965, 5129.666571672829, 5130.846074617767, 5152.27868098459, 6026.860464535114, 6060.090986351995, 6069.726862291208, 6086.2696476422225, 6088.847778805565, 5045.495450454999, 5116.0, 5117.0, 5117.078925793393, 5121.820736274212, 3199.120241933487, 3255.860448842886, 3273.525338825857, 3299.851506682157, 3301.4552598821406, 5681.289838770153, 5737.3688894221605, 5755.309362876482, 5758.654480731169, 5822.243108395882, 6316.842078948063, 6324.08300796382, 6328.936710632835, 6337.461315788118, 6354.078658594478, 5766.308043034863, 5772.913406298909, 5783.8554036149435, 5799.101139323411, 5800.622959507618, 5869.618474799125, 6064.939350606437, 6077.6353418795015, 6105.572609917441, 6115.388461153849, 5975.043992961106, 5986.9401305986385, 6019.909701354396, 6029.60807547508, 6036.3058248302, 5728.455796699307, 5754.136879468113, 5795.623284486495, 5802.738876750641, 5836.766529338949, 4040.575739547423, 4068.877933661995, 4071.491063617048, 4086.7752273625238, 4126.587341265849, 6009.158717779427, 6102.908456373069, 6104.938950610437, 6122.908156377569, 6126.448619624255, 5844.181814546052, 5861.560382971209, 5884.911726324023, 5903.114532820111, 5906.527477801679, 5834.883302334015, 5885.234919460614, 5887.793927212527, 5896.14505896634, 5902.0, 5584.692841893735, 5714.79998200061, 5741.5406767459335, 5767.826965191051, 5773.769049237983, 5857.0, 5905.970470147622, 5906.320773110975, 5913.5564832636865, 5952.940470595238, 5769.221155144001, 5771.307443106854, 5772.797952071657, 5776.306843178845, 5782.2194003808945], "unit": "score", "name": "prototype.html", "value": 4370.657315512412}, {"lowerIsBetter": false, "replicates": [787.6455594982258, 791.157417350522, 796.7171654062807, 802.2779498451393, 807.2815194476921, 11619.825702614457, 11832.822507662391, 13474.12418192818, 13584.184948903072, 13602.659933501667, 13037.543685970993, 13197.670058248548, 13202.933985330084, 13240.602781916557, 13263.867361326384, 788.6372268756364, 795.6300320351036, 798.7164556582417, 799.312591171592, 813.0243707550933, 795.5346122518305, 795.5783434779576, 797.3342259213534, 797.4896066517433, 799.3764863406552, 828.3249151941179, 831.4553967151526, 836.8326334733048, 837.0206857976183, 839.2488722593275, 826.5412695953773, 826.6528058215564, 836.1972506393839, 840.7393707950555, 841.524538635675, 613.1538476901846, 621.6611946489129, 623.1680706257152, 624.188554878656, 624.4972796898495, 11629.534818607246, 11739.647810565697, 11807.527698892034, 11940.522379104825, 12019.098567607465, 10647.680569582924, 11193.66419007431, 11434.428278586121, 11456.140789440826, 12155.088368372408, 9119.179273865318, 9392.718218453458, 9414.482203478807, 9415.058494150599, 9506.38208516451, 3187.5059365798106, 3212.4538828399227, 3227.9677203227902, 3240.22234663679, 3313.453280208763, 40920.59079409198, 42004.36993445101, 42251.57748422507, 42392.57607423917, 42561.0, 9138.497382644018, 9271.072892710676, 9308.534573271309, 9377.812443751223, 9471.147596716191, 16061.678766424606, 16146.35414583427, 16224.351025959066, 16269.674606507804, 16350.2204625214, 6117.541184411098, 6418.326075761977, 6455.064015717695, 6498.415142637091, 6633.701483433257, 3485.686288234071, 3609.0796846803896, 3612.8012959286966, 3658.8536458541894, 3662.7985460799378, 2441.8046556275453, 2467.198160597813, 2477.6283557466522, 2477.860184315235, 2478.8140889433366, 472.90069085492433, 479.71217269638635, 481.4246974865003, 492.6305271046715, 493.67910857942627, 520.2794130129722, 551.1622334052298, 584.5382148102951, 600.7056542294245, 636.933122022181, 7717.189695082048, 7834.921650783534, 7951.483153595113, 7960.363170946311, 8057.677692892219, 582.7494177503629, 597.856514436532, 607.0651197156418, 622.6450922973952, 623.2863371439677, 3676.191237927652, 3980.7412518186225, 3996.760194388346, 4007.1785284016705, 4169.228692691861, 49457.25814112791, 49474.0, 49502.0, 49621.0, 49629.50370496249, 46821.0, 48250.27624585634, 48554.0, 49042.264366034535, 49498.267560635206, 37364.626353736116, 38300.425493617615, 40369.59630403658, 43441.34837977433, 43998.0, 7910.7231246906085, 8247.95876020616, 8454.154584541497, 8543.829123417621, 8596.78508037279, 32881.67118328786, 32945.84689535951, 32951.17622059468, 33094.33811323808, 33245.667543325224, 36755.63244367522, 37305.25389492249, 37395.252094958494, 42070.0, 42143.789281053396, 9792.80414391694, 9940.751481213027, 10037.0, 10057.849132263169, 10135.7466063349, 11435.828462573234, 11470.139739519402, 11523.078153747512, 11527.135464840003, 11552.884471155181, 10469.424181670081, 10603.204759642904, 10828.0, 11104.777904442028, 11451.370174640142, 9985.45080020606, 10156.289059765746, 10169.44068076263, 10221.693349199535, 10561.577536898438, 10646.148308135176, 10655.413952232702, 10810.405427701551, 10878.45607719595, 10952.835707464554, 9071.818563628822, 9229.861552076858, 9366.391184573253, 9427.670031548863, 9727.80544389094, 9044.954775226082, 9286.767830804283, 9523.999620756635, 9723.513824308899, 9778.266630002636], "unit": "score", "name": "yui.html", "value": 5836.612809000854}], "name": "dromaeo_css", "value": 6361.252367542677}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 115.0, 115.0, 124.0, 116.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [162.0, 131.0, 151.0, 170.0, 131.0, 168.0, 158.0, 138.0, 179.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 162.0, 164.0, 167.0, 166.0, 167.0, 164.0, 166.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 74.0, 74.0, 73.0, 78.0, 136.0, 73.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 95.0, 96.0, 96.0, 143.0, 94.0, 96.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 115.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.6}, {"lowerIsBetter": true, "replicates": [150.0, 149.0, 150.0, 149.0, 149.0, 149.0, 147.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 73.0, 75.0, 74.0, 72.0, 74.0, 74.0, 73.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 85.0, 83.0, 93.0, 84.0, 83.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [130.0, 137.0, 126.0, 122.0, 131.0, 123.0, 131.0, 123.0, 146.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.0}, {"lowerIsBetter": true, "replicates": [138.0, 150.0, 154.0, 142.0, 147.0, 143.0, 150.0, 151.0, 151.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 74.0, 72.0, 72.0, 72.0, 71.0, 70.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1551.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [186.01190476190476], "unit": "score", "name": "DeltaBlue", "value": 355.4503679999999}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [711.7437722419929], "unit": "score", "name": "Earley", "value": 936.3805150000001}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [602.0469596628537], "unit": "score", "name": "Splay", "value": 135.35655099999997}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 21348.15348198982}]} 22:28:48 INFO - RETURN: dromaeo_css: 6361.25 22:28:48 INFO - RETURN: kraken: 1551.90 22:28:48 INFO - RETURN: v8_7: 21348.15 22:28:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21348.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6361.25"}}} 22:28:48 INFO - Return code: 0 22:28:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:28:48 INFO - # TBPL SUCCESS # 22:28:48 INFO - Running post-action listener: _resource_record_post_action 22:28:48 INFO - Running post-run listener: _resource_record_post_run 22:28:49 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 505593856; Read time: 0; Write time: 333668 22:28:49 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231460864; Read time: 0; Write time: 197380 22:28:49 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 273268736; Read time: 0; Write time: 136244 22:28:49 INFO - Running post-run listener: _upload_blobber_files 22:28:49 INFO - Blob upload gear active. 22:28:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:28:49 INFO - Copying logs to upload dir... 22:28:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.143396 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-15 22:28:49.308918) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 22:28:49.312860) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009964 build_url: 'https://queue.taskcluster.net/v1/task/uNKhAzQaRu6oaAgwyyUFpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 22:28:49.364997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:28:49.365388) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450242360.494534-708490124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 22:28:49.415615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 22:28:49.415978) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 22:28:49.416366) ========= ========= Total master_lag: 0.30 =========