builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1449793128.23 results: success (0) buildid: 20151210155738 builduid: 33a82667b1e6466f92b604a0e1175f51 revision: df507dc13e43a63fd2cf4870e703f31bbde6dde8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.230640) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.231065) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.231353) ========= 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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006307 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.321641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.321929) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.515941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.516233) ========= 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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.572431) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.572777) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.573120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.573430) ========= 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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 16:18:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-10 16:18:48 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182153 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.789384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.789721) ========= 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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016146 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.847158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:48.847505) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df507dc13e43a63fd2cf4870e703f31bbde6dde8 --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 df507dc13e43a63fd2cf4870e703f31bbde6dde8 --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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 16:18:48,971 truncating revision to first 12 chars 2015-12-10 16:18:48,971 Setting DEBUG logging. 2015-12-10 16:18:48,971 attempt 1/10 2015-12-10 16:18:48,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df507dc13e43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 16:18:49,215 unpacking tar archive at: fx-team-df507dc13e43/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:49.399131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:49.399446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:49.409261) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:49.409533) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 16:18:49.409937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 16:18:49.410214) ========= /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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:18:49 INFO - MultiFileLogger online at 20151210 16:18:49 in /builds/slave/test 16:18:49 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 16:18:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:49 INFO - {'append_to_log': False, 16:18:49 INFO - 'base_work_dir': '/builds/slave/test', 16:18:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:18:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:49 INFO - 'branch': 'Fx-Team-Non-PGO', 16:18:49 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:49 INFO - 'config_files': ('talos/linux_config.py',), 16:18:49 INFO - 'default_actions': ('clobber', 16:18:49 INFO - 'read-buildbot-config', 16:18:49 INFO - 'download-and-extract', 16:18:49 INFO - 'populate-webroot', 16:18:49 INFO - 'create-virtualenv', 16:18:49 INFO - 'install', 16:18:49 INFO - 'run-tests'), 16:18:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:49 INFO - 'download_minidump_stackwalk': True, 16:18:49 INFO - 'download_symbols': 'ondemand', 16:18:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:49 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:49 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:49 INFO - 'installer_path': 'installer.exe', 16:18:49 INFO - 'log_level': 'info', 16:18:49 INFO - 'log_name': 'talos', 16:18:49 INFO - 'log_to_console': True, 16:18:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:18:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:18:49 INFO - 'opt_config_files': (), 16:18:49 INFO - 'pip_index': False, 16:18:49 INFO - 'sps_profile': False, 16:18:49 INFO - 'sps_profile_interval': 0, 16:18:49 INFO - 'suite': 'dromaeojs-e10s', 16:18:49 INFO - 'system_bits': '64', 16:18:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:49 INFO - 'title': 'talos-linux64-ix-063', 16:18:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:49 INFO - 'use_talos_json': True, 16:18:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:49 INFO - 'work_dir': 'build'} 16:18:49 INFO - ##### 16:18:49 INFO - ##### Running clobber step. 16:18:49 INFO - ##### 16:18:49 INFO - Running pre-action listener: _resource_record_pre_action 16:18:49 INFO - Running main action method: clobber 16:18:49 INFO - rmtree: /builds/slave/test/build 16:18:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:50 INFO - Running post-action listener: _resource_record_post_action 16:18:50 INFO - ##### 16:18:50 INFO - ##### Running read-buildbot-config step. 16:18:50 INFO - ##### 16:18:50 INFO - Running pre-action listener: _resource_record_pre_action 16:18:50 INFO - Running main action method: read_buildbot_config 16:18:50 INFO - Using buildbot properties: 16:18:50 INFO - { 16:18:50 INFO - "properties": { 16:18:50 INFO - "buildnumber": 561, 16:18:50 INFO - "product": "firefox", 16:18:50 INFO - "script_repo_revision": "production", 16:18:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:18:50 INFO - "repository": "", 16:18:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:18:50 INFO - "buildid": "20151210155738", 16:18:50 INFO - "slavename": "talos-linux64-ix-063", 16:18:50 INFO - "pgo_build": "False", 16:18:50 INFO - "basedir": "/builds/slave/test", 16:18:50 INFO - "project": "", 16:18:50 INFO - "platform": "ubuntu64_hw", 16:18:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:18:50 INFO - "slavebuilddir": "test", 16:18:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:18:50 INFO - "branch": "fx-team", 16:18:50 INFO - "repo_path": "integration/fx-team", 16:18:50 INFO - "stage_platform": "linux64", 16:18:50 INFO - "builduid": "33a82667b1e6466f92b604a0e1175f51", 16:18:50 INFO - "revision": "df507dc13e43a63fd2cf4870e703f31bbde6dde8" 16:18:50 INFO - }, 16:18:50 INFO - "sourcestamp": { 16:18:50 INFO - "repository": "", 16:18:50 INFO - "hasPatch": false, 16:18:50 INFO - "project": "", 16:18:50 INFO - "branch": "fx-team-linux64-talos", 16:18:50 INFO - "changes": [ 16:18:50 INFO - { 16:18:50 INFO - "category": null, 16:18:50 INFO - "files": [ 16:18:50 INFO - { 16:18:50 INFO - "url": null, 16:18:50 INFO - "name": "https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:18:50 INFO - } 16:18:50 INFO - ], 16:18:50 INFO - "repository": "", 16:18:50 INFO - "rev": "df507dc13e43a63fd2cf4870e703f31bbde6dde8", 16:18:50 INFO - "who": "markcapella@twcny.rr.com", 16:18:50 INFO - "when": 1449793092, 16:18:50 INFO - "number": 7283771, 16:18:50 INFO - "comments": "Bug 1226431 - Toggling find in page match case removes focus, r=margaret", 16:18:50 INFO - "project": "", 16:18:50 INFO - "at": "Thu 10 Dec 2015 16:18:12", 16:18:50 INFO - "branch": "fx-team-linux64-talos", 16:18:50 INFO - "revlink": "", 16:18:50 INFO - "properties": [ 16:18:50 INFO - [ 16:18:50 INFO - "buildid", 16:18:50 INFO - "20151210155738", 16:18:50 INFO - "Change" 16:18:50 INFO - ], 16:18:50 INFO - [ 16:18:50 INFO - "builduid", 16:18:50 INFO - "33a82667b1e6466f92b604a0e1175f51", 16:18:50 INFO - "Change" 16:18:50 INFO - ], 16:18:50 INFO - [ 16:18:50 INFO - "pgo_build", 16:18:50 INFO - "False", 16:18:50 INFO - "Change" 16:18:50 INFO - ] 16:18:50 INFO - ], 16:18:50 INFO - "revision": "df507dc13e43a63fd2cf4870e703f31bbde6dde8" 16:18:50 INFO - } 16:18:50 INFO - ], 16:18:50 INFO - "revision": "df507dc13e43a63fd2cf4870e703f31bbde6dde8" 16:18:50 INFO - } 16:18:50 INFO - } 16:18:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:18:50 INFO - Running post-action listener: _resource_record_post_action 16:18:50 INFO - ##### 16:18:50 INFO - ##### Running download-and-extract step. 16:18:50 INFO - ##### 16:18:50 INFO - Running pre-action listener: _resource_record_pre_action 16:18:50 INFO - Running main action method: download_and_extract 16:18:50 INFO - mkdir: /builds/slave/test/build/tests 16:18: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')]} 16:18:50 INFO - https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/test_packages.json 16:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/test_packages.json 16:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:18:56 INFO - Downloaded 1302 bytes. 16:18:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:18:56 INFO - Using the following test package requirements: 16:18:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:18:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'jsshell-linux-x86_64.zip'], 16:18:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:18:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:18:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:18:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:18:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:18:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:18: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')]} 16:18:56 INFO - https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:19:06 INFO - Downloaded 21867102 bytes. 16:19:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:19:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:19:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:19:07 INFO - Return code: 0 16:19:07 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:07 INFO - https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:19:08 INFO - Downloaded 21867102 bytes. 16:19:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:19:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:19:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:19:09 INFO - Return code: 0 16:19: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')]} 16:19:09 INFO - https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:19:10 INFO - Downloaded 11132038 bytes. 16:19:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 16:19:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:19:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:19:10 INFO - Return code: 0 16:19:10 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')]} 16:19:10 INFO - https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:19:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:19:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:19:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:19:11 INFO - Downloaded 57728928 bytes. 16:19:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:19:11 INFO - mkdir: /builds/slave/test/properties 16:19:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:11 INFO - Contents: 16:19:11 INFO - build_url:https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:19:11 INFO - Running post-action listener: _resource_record_post_action 16:19:11 INFO - Running post-action listener: set_extra_try_arguments 16:19:11 INFO - ##### 16:19:11 INFO - ##### Running populate-webroot step. 16:19:11 INFO - ##### 16:19:11 INFO - Running pre-action listener: _resource_record_pre_action 16:19:11 INFO - Running main action method: populate_webroot 16:19:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:19:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:19:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:19:11 INFO - '--tppagecycles', 16:19:11 INFO - '7'], 16:19:11 INFO - 'tests': ['tsvgm']}}, 16:19:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:19:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:19:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:19:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:19:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'tests': ['damp', 'tps']}, 16:19:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['damp', 'tps']}, 16:19:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:19:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:11 INFO - 'other': {'tests': ['a11yr', 16:19:11 INFO - 'ts_paint', 16:19:11 INFO - 'tpaint', 16:19:11 INFO - 'sessionrestore', 16:19:11 INFO - 'sessionrestore_no_auto_restore']}, 16:19:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['a11yr', 16:19:11 INFO - 'ts_paint', 16:19:11 INFO - 'tpaint', 16:19:11 INFO - 'sessionrestore', 16:19:11 INFO - 'sessionrestore_no_auto_restore']}, 16:19:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['a11yr', 16:19:11 INFO - 'ts_paint', 16:19:11 INFO - 'tpaint', 16:19:11 INFO - 'sessionrestore', 16:19:11 INFO - 'sessionrestore_no_auto_restore']}, 16:19:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['a11yr', 16:19:11 INFO - 'ts_paint', 16:19:11 INFO - 'tpaint', 16:19:11 INFO - 'sessionrestore', 16:19:11 INFO - 'sessionrestore_no_auto_restore']}, 16:19:11 INFO - 'other_l64': {'tests': ['a11yr', 16:19:11 INFO - 'ts_paint', 16:19:11 INFO - 'tpaint', 16:19:11 INFO - 'sessionrestore', 16:19:11 INFO - 'sessionrestore_no_auto_restore']}, 16:19:11 INFO - 'other_nol64': {'tests': ['a11yr', 16:19:11 INFO - 'ts_paint', 16:19:11 INFO - 'tpaint', 16:19:11 INFO - 'sessionrestore', 16:19:11 INFO - 'sessionrestore_no_auto_restore']}, 16:19:11 INFO - 'svgr': {'tests': ['tsvgx', 16:19:11 INFO - 'tsvgr_opacity', 16:19:11 INFO - 'tart', 16:19:11 INFO - 'tscrollx', 16:19:11 INFO - 'cart']}, 16:19:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['tsvgx', 16:19:11 INFO - 'tsvgr_opacity', 16:19:11 INFO - 'tart', 16:19:11 INFO - 'tscrollx', 16:19:11 INFO - 'cart']}, 16:19:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'tests': ['tp5o']}, 16:19:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'talos_options': ['--e10s'], 16:19:11 INFO - 'tests': ['tp5o']}, 16:19:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'talos_options': ['--xperf_path', 16:19:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:11 INFO - 'tests': ['tp5n']}, 16:19:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:11 INFO - 'talos_options': ['--e10s', 16:19:11 INFO - '--xperf_path', 16:19:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:11 INFO - 'tests': ['tp5n']}}, 16:19:11 INFO - 'talos.zip': {'path': '', 16:19:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:19:11 INFO - Running post-action listener: _resource_record_post_action 16:19:11 INFO - ##### 16:19:11 INFO - ##### Running create-virtualenv step. 16:19:11 INFO - ##### 16:19:11 INFO - Running pre-action listener: _resource_record_pre_action 16:19:11 INFO - Running main action method: create_virtualenv 16:19:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:11 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 16:19:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:11 INFO - Using real prefix '/usr' 16:19:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:14 INFO - Installing pip.................done. 16:19:14 INFO - Return code: 0 16:19:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:14 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')]} 16:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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')]} 16:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:14 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 16:19:14 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 16:19:14 INFO - Using env: {'DISPLAY': ':0', 16:19:14 INFO - 'HOME': '/home/cltbld', 16:19:14 INFO - 'LANG': 'en_US.UTF-8', 16:19:14 INFO - 'LANGUAGE': 'en_US:en', 16:19:14 INFO - 'LOGNAME': 'cltbld', 16:19:14 INFO - 'MAIL': '/var/mail/cltbld', 16:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:14 INFO - 'MOZ_NO_REMOTE': '1', 16:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:14 INFO - 'NO_EM_RESTART': '1', 16:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:14 INFO - 'PWD': '/builds/slave/test', 16:19:14 INFO - 'SHELL': '/bin/bash', 16:19:14 INFO - 'SHLVL': '1', 16:19:14 INFO - 'TERM': 'linux', 16:19:14 INFO - 'TMOUT': '86400', 16:19:14 INFO - 'USER': 'cltbld', 16:19:14 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:14 INFO - '_': '/tools/buildbot/bin/python'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 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 16:19:14 INFO - Cleaning up... 16:19:14 INFO - Return code: 0 16:19:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:19:14 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')]} 16:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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')]} 16:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:14 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 16:19:14 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 16:19:14 INFO - Using env: {'DISPLAY': ':0', 16:19:14 INFO - 'HOME': '/home/cltbld', 16:19:14 INFO - 'LANG': 'en_US.UTF-8', 16:19:14 INFO - 'LANGUAGE': 'en_US:en', 16:19:14 INFO - 'LOGNAME': 'cltbld', 16:19:14 INFO - 'MAIL': '/var/mail/cltbld', 16:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:14 INFO - 'MOZ_NO_REMOTE': '1', 16:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:14 INFO - 'NO_EM_RESTART': '1', 16:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:14 INFO - 'PWD': '/builds/slave/test', 16:19:14 INFO - 'SHELL': '/bin/bash', 16:19:14 INFO - 'SHLVL': '1', 16:19:14 INFO - 'TERM': 'linux', 16:19:14 INFO - 'TMOUT': '86400', 16:19:14 INFO - 'USER': 'cltbld', 16:19:14 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:14 INFO - '_': '/tools/buildbot/bin/python'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 INFO - Downloading/unpacking psutil>=0.7.1 16:19:14 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 16:19:14 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 16:19:14 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 16:19:14 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 16:19:14 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 16:19:14 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 16:19:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:19:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:16 INFO - Installing collected packages: psutil 16:19:16 INFO - Running setup.py install for psutil 16:19:16 INFO - building 'psutil._psutil_linux' extension 16:19:16 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 16:19:16 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 16:19:16 INFO - building 'psutil._psutil_posix' extension 16:19:16 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 16:19:17 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 16:19:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:17 INFO - Successfully installed psutil 16:19:17 INFO - Cleaning up... 16:19:17 INFO - Return code: 0 16:19:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:17 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:17 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 16:19:17 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 16:19:17 INFO - Using env: {'DISPLAY': ':0', 16:19:17 INFO - 'HOME': '/home/cltbld', 16:19:17 INFO - 'LANG': 'en_US.UTF-8', 16:19:17 INFO - 'LANGUAGE': 'en_US:en', 16:19:17 INFO - 'LOGNAME': 'cltbld', 16:19:17 INFO - 'MAIL': '/var/mail/cltbld', 16:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:17 INFO - 'MOZ_NO_REMOTE': '1', 16:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:17 INFO - 'NO_EM_RESTART': '1', 16:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:17 INFO - 'PWD': '/builds/slave/test', 16:19:17 INFO - 'SHELL': '/bin/bash', 16:19:17 INFO - 'SHLVL': '1', 16:19:17 INFO - 'TERM': 'linux', 16:19:17 INFO - 'TMOUT': '86400', 16:19:17 INFO - 'USER': 'cltbld', 16:19:17 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:17 INFO - '_': '/tools/buildbot/bin/python'} 16:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:19:17 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 16:19:17 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 16:19:17 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 16:19:17 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 16:19:17 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 16:19:17 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 16:19:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:19:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:19:19 INFO - Installing collected packages: mozsystemmonitor 16:19:19 INFO - Running setup.py install for mozsystemmonitor 16:19:19 INFO - Successfully installed mozsystemmonitor 16:19:19 INFO - Cleaning up... 16:19:19 INFO - Return code: 0 16:19:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:19 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 16:19:19 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 16:19:19 INFO - Using env: {'DISPLAY': ':0', 16:19:19 INFO - 'HOME': '/home/cltbld', 16:19:19 INFO - 'LANG': 'en_US.UTF-8', 16:19:19 INFO - 'LANGUAGE': 'en_US:en', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MAIL': '/var/mail/cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SHLVL': '1', 16:19:19 INFO - 'TERM': 'linux', 16:19:19 INFO - 'TMOUT': '86400', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - '_': '/tools/buildbot/bin/python'} 16:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:20 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 16:19:20 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 16:19:20 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 16:19:20 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 16:19:20 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 16:19:20 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 16:19:21 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:21 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 16:19:21 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 16:19:21 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 16:19:21 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 16:19:21 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 16:19:21 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 16:19:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 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 16:19:22 INFO - Downloading docopt-0.6.1.tar.gz 16:19:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:22 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:22 INFO - Running setup.py install for blobuploader 16:19:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:22 INFO - Running setup.py install for requests 16:19:23 INFO - Running setup.py install for docopt 16:19:23 INFO - Successfully installed blobuploader requests docopt 16:19:23 INFO - Cleaning up... 16:19:23 INFO - Return code: 0 16:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:23 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:23 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 16:19:23 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 16:19:23 INFO - Using env: {'DISPLAY': ':0', 16:19:23 INFO - 'HOME': '/home/cltbld', 16:19:23 INFO - 'LANG': 'en_US.UTF-8', 16:19:23 INFO - 'LANGUAGE': 'en_US:en', 16:19:23 INFO - 'LOGNAME': 'cltbld', 16:19:23 INFO - 'MAIL': '/var/mail/cltbld', 16:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:23 INFO - 'MOZ_NO_REMOTE': '1', 16:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:23 INFO - 'NO_EM_RESTART': '1', 16:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:23 INFO - 'PWD': '/builds/slave/test', 16:19:23 INFO - 'SHELL': '/bin/bash', 16:19:23 INFO - 'SHLVL': '1', 16:19:23 INFO - 'TERM': 'linux', 16:19:23 INFO - 'TMOUT': '86400', 16:19:23 INFO - 'USER': 'cltbld', 16:19:23 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:23 INFO - '_': '/tools/buildbot/bin/python'} 16:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:23 INFO - Running setup.py (path:/tmp/pip-zzOZHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:23 INFO - Running setup.py (path:/tmp/pip-Q0suFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:23 INFO - Running setup.py (path:/tmp/pip-uOugU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:23 INFO - Running setup.py (path:/tmp/pip-weAP7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:23 INFO - Running setup.py (path:/tmp/pip-78bJVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:23 INFO - Running setup.py (path:/tmp/pip-tACJhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:23 INFO - Running setup.py (path:/tmp/pip-27goTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:23 INFO - Running setup.py (path:/tmp/pip-UdSdT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:24 INFO - Running setup.py (path:/tmp/pip-oKD2nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:24 INFO - Running setup.py (path:/tmp/pip-rOwhnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:24 INFO - Running setup.py (path:/tmp/pip-c3rGGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:24 INFO - Running setup.py (path:/tmp/pip-Ckgyae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:24 INFO - Running setup.py (path:/tmp/pip-8uKeu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:24 INFO - Running setup.py (path:/tmp/pip-o0fkWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:24 INFO - Running setup.py (path:/tmp/pip-XMt9eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:24 INFO - Running setup.py (path:/tmp/pip-5eocg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:24 INFO - Running setup.py (path:/tmp/pip-VTY_5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:24 INFO - Running setup.py install for manifestparser 16:19:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:24 INFO - Running setup.py install for mozcrash 16:19:24 INFO - Running setup.py install for mozdebug 16:19:24 INFO - Running setup.py install for mozdevice 16:19:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for mozfile 16:19:25 INFO - Running setup.py install for mozhttpd 16:19:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for mozinfo 16:19:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for mozInstall 16:19:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for mozleak 16:19:25 INFO - Running setup.py install for mozlog 16:19:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for moznetwork 16:19:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for mozprocess 16:19:25 INFO - Running setup.py install for mozprofile 16:19:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:25 INFO - Running setup.py install for mozrunner 16:19:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:26 INFO - Running setup.py install for mozscreenshot 16:19:26 INFO - Running setup.py install for moztest 16:19:26 INFO - Running setup.py install for mozversion 16:19:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:26 INFO - Cleaning up... 16:19:26 INFO - Return code: 0 16:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:26 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:26 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 16:19:26 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 16:19:26 INFO - Using env: {'DISPLAY': ':0', 16:19:26 INFO - 'HOME': '/home/cltbld', 16:19:26 INFO - 'LANG': 'en_US.UTF-8', 16:19:26 INFO - 'LANGUAGE': 'en_US:en', 16:19:26 INFO - 'LOGNAME': 'cltbld', 16:19:26 INFO - 'MAIL': '/var/mail/cltbld', 16:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:26 INFO - 'MOZ_NO_REMOTE': '1', 16:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:26 INFO - 'NO_EM_RESTART': '1', 16:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:26 INFO - 'PWD': '/builds/slave/test', 16:19:26 INFO - 'SHELL': '/bin/bash', 16:19:26 INFO - 'SHLVL': '1', 16:19:26 INFO - 'TERM': 'linux', 16:19:26 INFO - 'TMOUT': '86400', 16:19:26 INFO - 'USER': 'cltbld', 16:19:26 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:26 INFO - '_': '/tools/buildbot/bin/python'} 16:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:26 INFO - Running setup.py (path:/tmp/pip-TE50TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:26 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)) 16:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:26 INFO - Running setup.py (path:/tmp/pip-zRCQ7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:26 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)) 16:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:26 INFO - Running setup.py (path:/tmp/pip-_l0obL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:26 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)) 16:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:26 INFO - Running setup.py (path:/tmp/pip-v6aUbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:26 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)) 16:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:26 INFO - Running setup.py (path:/tmp/pip-z4Qq2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:27 INFO - Running setup.py (path:/tmp/pip-1ani3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:27 INFO - Running setup.py (path:/tmp/pip-ZU1J7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:27 INFO - Running setup.py (path:/tmp/pip-cXemfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:27 INFO - Running setup.py (path:/tmp/pip-zLXefs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:27 INFO - Running setup.py (path:/tmp/pip-4AW52x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:27 INFO - Running setup.py (path:/tmp/pip-wn96Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:27 INFO - Running setup.py (path:/tmp/pip-sId0Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:27 INFO - Running setup.py (path:/tmp/pip-iA1Ais-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:27 INFO - Running setup.py (path:/tmp/pip-RXVrrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:27 INFO - Running setup.py (path:/tmp/pip-kkelwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:27 INFO - Running setup.py (path:/tmp/pip-CuzLzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:27 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)) 16:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:27 INFO - Running setup.py (path:/tmp/pip-FknLbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:27 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)) 16:19:27 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)) 16:19:27 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)) 16:19:27 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)) 16:19:27 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)) 16:19:27 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)) 16:19:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:29 INFO - Downloading blessings-1.5.1.tar.gz 16:19:29 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 16:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:29 INFO - Installing collected packages: blessings 16:19:29 INFO - Running setup.py install for blessings 16:19:29 INFO - Successfully installed blessings 16:19:29 INFO - Cleaning up... 16:19:29 INFO - Return code: 0 16:19:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:30 INFO - Reading from file tmpfile_stdout 16:19:30 INFO - Current package versions: 16:19:30 INFO - argparse == 1.2.1 16:19:30 INFO - blessings == 1.5.1 16:19:30 INFO - blobuploader == 1.2.4 16:19:30 INFO - docopt == 0.6.1 16:19:30 INFO - manifestparser == 1.1 16:19:30 INFO - mozInstall == 1.12 16:19:30 INFO - mozcrash == 0.16 16:19:30 INFO - mozdebug == 0.1 16:19:30 INFO - mozdevice == 0.47 16:19:30 INFO - mozfile == 1.2 16:19:30 INFO - mozhttpd == 0.7 16:19:30 INFO - mozinfo == 0.9 16:19:30 INFO - mozleak == 0.1 16:19:30 INFO - mozlog == 3.1 16:19:30 INFO - moznetwork == 0.27 16:19:30 INFO - mozprocess == 0.22 16:19:30 INFO - mozprofile == 0.27 16:19:30 INFO - mozrunner == 6.11 16:19:30 INFO - mozscreenshot == 0.1 16:19:30 INFO - mozsystemmonitor == 0.0 16:19:30 INFO - moztest == 0.7 16:19:30 INFO - mozversion == 1.4 16:19:30 INFO - psutil == 3.1.1 16:19:30 INFO - requests == 1.2.3 16:19:30 INFO - wsgiref == 0.1.2 16:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:30 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')]} 16:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:30 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')]} 16:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:30 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:30 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 16:19:30 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 16:19:30 INFO - Using env: {'DISPLAY': ':0', 16:19:30 INFO - 'HOME': '/home/cltbld', 16:19:30 INFO - 'LANG': 'en_US.UTF-8', 16:19:30 INFO - 'LANGUAGE': 'en_US:en', 16:19:30 INFO - 'LOGNAME': 'cltbld', 16:19:30 INFO - 'MAIL': '/var/mail/cltbld', 16:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:30 INFO - 'MOZ_NO_REMOTE': '1', 16:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:30 INFO - 'NO_EM_RESTART': '1', 16:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:30 INFO - 'PWD': '/builds/slave/test', 16:19:30 INFO - 'SHELL': '/bin/bash', 16:19:30 INFO - 'SHLVL': '1', 16:19:30 INFO - 'TERM': 'linux', 16:19:30 INFO - 'TMOUT': '86400', 16:19:30 INFO - 'USER': 'cltbld', 16:19:30 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:30 INFO - '_': '/tools/buildbot/bin/python'} 16:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 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)) 16:19:30 INFO - Cleaning up... 16:19:30 INFO - Return code: 0 16:19:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:30 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')]} 16:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:30 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')]} 16:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:30 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:30 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 16:19:30 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 16:19:30 INFO - Using env: {'DISPLAY': ':0', 16:19:30 INFO - 'HOME': '/home/cltbld', 16:19:30 INFO - 'LANG': 'en_US.UTF-8', 16:19:30 INFO - 'LANGUAGE': 'en_US:en', 16:19:30 INFO - 'LOGNAME': 'cltbld', 16:19:30 INFO - 'MAIL': '/var/mail/cltbld', 16:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:30 INFO - 'MOZ_NO_REMOTE': '1', 16:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:30 INFO - 'NO_EM_RESTART': '1', 16:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:30 INFO - 'PWD': '/builds/slave/test', 16:19:30 INFO - 'SHELL': '/bin/bash', 16:19:30 INFO - 'SHLVL': '1', 16:19:30 INFO - 'TERM': 'linux', 16:19:30 INFO - 'TMOUT': '86400', 16:19:30 INFO - 'USER': 'cltbld', 16:19:30 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:30 INFO - '_': '/tools/buildbot/bin/python'} 16:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:30 INFO - Downloading/unpacking jsonschema 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:32 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 16:19:32 INFO - Downloading/unpacking functools32 (from jsonschema) 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:32 INFO - warning: no files found matching '*.txt' 16:19:32 INFO - no previously-included directories found matching 'build' 16:19:32 INFO - no previously-included directories found matching 'dist' 16:19:32 INFO - no previously-included directories found matching '.git*' 16:19:32 INFO - Installing collected packages: jsonschema, functools32 16:19:32 INFO - Running setup.py install for functools32 16:19:32 INFO - warning: no files found matching '*.txt' 16:19:32 INFO - no previously-included directories found matching 'build' 16:19:32 INFO - no previously-included directories found matching 'dist' 16:19:32 INFO - no previously-included directories found matching '.git*' 16:19:32 INFO - Successfully installed jsonschema functools32 16:19:32 INFO - Cleaning up... 16:19:32 INFO - Return code: 0 16:19:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:19:32 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')]} 16:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:32 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')]} 16:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:32 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 0x7f6d61c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, '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': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', '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 16:19:32 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 16:19:32 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 16:19:32 INFO - Using env: {'DISPLAY': ':0', 16:19:32 INFO - 'HOME': '/home/cltbld', 16:19:32 INFO - 'LANG': 'en_US.UTF-8', 16:19:32 INFO - 'LANGUAGE': 'en_US:en', 16:19:32 INFO - 'LOGNAME': 'cltbld', 16:19:32 INFO - 'MAIL': '/var/mail/cltbld', 16:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:32 INFO - 'MOZ_NO_REMOTE': '1', 16:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:32 INFO - 'NO_EM_RESTART': '1', 16:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:32 INFO - 'PWD': '/builds/slave/test', 16:19:32 INFO - 'SHELL': '/bin/bash', 16:19:32 INFO - 'SHLVL': '1', 16:19:32 INFO - 'TERM': 'linux', 16:19:32 INFO - 'TMOUT': '86400', 16:19:32 INFO - 'USER': 'cltbld', 16:19:32 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:32 INFO - '_': '/tools/buildbot/bin/python'} 16:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:32 INFO - Downloading/unpacking flake8 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:19:34 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 16:19:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:19:34 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 16:19:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:35 INFO - no previously-included directories found matching 'docs/_build' 16:19:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:19:35 INFO - Running setup.py install for pep8 16:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:35 INFO - no previously-included directories found matching 'docs/_build' 16:19:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:19:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:19:35 INFO - Cleaning up... 16:19:35 INFO - Return code: 0 16:19:35 INFO - Running post-action listener: _resource_record_post_action 16:19:35 INFO - Running post-action listener: _start_resource_monitoring 16:19:35 INFO - Starting resource monitoring. 16:19:35 INFO - ##### 16:19:35 INFO - ##### Running install step. 16:19:35 INFO - ##### 16:19:35 INFO - Running pre-action listener: _resource_record_pre_action 16:19:35 INFO - Running main action method: install 16:19:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:35 INFO - Reading from file tmpfile_stdout 16:19:35 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:35 INFO - Reading from file tmpfile_stdout 16:19:35 INFO - Output received: 16:19:35 INFO - Usage: mozinstall [options] installer 16:19:35 INFO - Options: 16:19:35 INFO - -h, --help show this help message and exit 16:19:35 INFO - -d DEST, --destination=DEST 16:19:35 INFO - Directory to install application into. [default: 16:19:35 INFO - "/builds/slave/test"] 16:19:35 INFO - --app=APP Application being installed. [default: firefox] 16:19:35 INFO - mkdir: /builds/slave/test/build/application 16:19:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:19:50 INFO - Reading from file tmpfile_stdout 16:19:50 INFO - Output received: 16:19:50 INFO - /builds/slave/test/build/application/firefox/firefox 16:19:50 INFO - Running post-action listener: _resource_record_post_action 16:19:50 INFO - ##### 16:19:50 INFO - ##### Running run-tests step. 16:19:50 INFO - ##### 16:19:50 INFO - Running pre-action listener: _resource_record_pre_action 16:19:50 INFO - Running main action method: run_tests 16:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:50 INFO - Python 2.7.3 16:19:50 INFO - Return code: 0 16:19:50 INFO - grabbing minidump binary from tooltool 16:19: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')]} 16:19:50 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 0x1fec0b0>, '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 0x1fecfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:50 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 16:19:50 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 16:19:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:50 INFO - Return code: 0 16:19:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:19:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:19:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:19:51 INFO - Return code: 0 16:19:51 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/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test/build 16:19:51 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/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 16:19:51 INFO - Using env: {'DISPLAY': ':0', 16:19:51 INFO - 'HOME': '/home/cltbld', 16:19:51 INFO - 'LANG': 'en_US.UTF-8', 16:19:51 INFO - 'LANGUAGE': 'en_US:en', 16:19:51 INFO - 'LOGNAME': 'cltbld', 16:19:51 INFO - 'MAIL': '/var/mail/cltbld', 16:19:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:51 INFO - 'MOZ_NO_REMOTE': '1', 16:19:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:51 INFO - 'NO_EM_RESTART': '1', 16:19:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:51 INFO - 'PWD': '/builds/slave/test', 16:19:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:51 INFO - 'SHELL': '/bin/bash', 16:19:51 INFO - 'SHLVL': '1', 16:19:51 INFO - 'TERM': 'linux', 16:19:51 INFO - 'TMOUT': '86400', 16:19:51 INFO - 'USER': 'cltbld', 16:19:51 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499', 16:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:51 INFO - '_': '/tools/buildbot/bin/python'} 16:19:51 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/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 16:19:51 INFO - mozversion INFO | application_buildid: 20151210155738 16:19:51 INFO - mozversion INFO | application_changeset: df507dc13e43a63fd2cf4870e703f31bbde6dde8 16:19:51 INFO - mozversion INFO | application_display_name: Nightly 16:19:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:51 INFO - mozversion INFO | application_name: Firefox 16:19:51 INFO - mozversion INFO | application_remotingname: firefox 16:19:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:19:51 INFO - mozversion INFO | application_vendor: Mozilla 16:19:51 INFO - mozversion INFO | application_version: 45.0a1 16:19:51 INFO - mozversion INFO | platform_buildid: 20151210155738 16:19:51 INFO - mozversion INFO | platform_changeset: df507dc13e43a63fd2cf4870e703f31bbde6dde8 16:19:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:19:51 INFO - mozversion INFO | platform_version: 45.0a1 16:19:51 INFO - 2015-12-10 16:19:51,380 DEBUG : using testdate: 1449793191 16:19:51 INFO - 2015-12-10 16:19:51,380 DEBUG : actual date: 1449793191 16:19:51 INFO - 2015-12-10 16:19:51,388 INFO : starting webserver on 'localhost:43292' 16:19:51 INFO - 2015-12-10 16:19:51,389 INFO : Starting test suite talos-linux64-ix-063.e 16:19:51 INFO - 2015-12-10 16:19:51,389 INFO : Starting test dromaeo_css 16:19:51 INFO - 2015-12-10 16:19:51,389 DEBUG : operating with platform_type : linux_ 16:19:51 INFO - 2015-12-10 16:19:51,390 INFO : Initialising browser for dromaeo_css test... 16:19:51 INFO - 2015-12-10 16:19:51,406 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMbYSs6/profile http://localhost:43292/getInfo.html 16:19:56 INFO - 2015-12-10 16:19:56,080 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:19:56 INFO - 2015-12-10 16:19:56,080 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:19:56 INFO - 2015-12-10 16:19:56,080 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:19:56 INFO - 2015-12-10 16:19:56,080 DEBUG : BROWSER_OUTPUT: __metrics 16:19:56 INFO - 2015-12-10 16:19:56,201 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] 16:19:57 INFO - 2015-12-10 16:19:57,061 INFO : Browser initialized. 16:19:57 INFO - 2015-12-10 16:19:57,061 INFO : Running cycle 1/1 for dromaeo_css test... 16:19:57 INFO - 2015-12-10 16:19:57,061 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMbYSs6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:20:09 INFO - 2015-12-10 16:20:09,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 142753792 16:20:09 INFO - 2015-12-10 16:20:09,143 DEBUG : BROWSER_OUTPUT: 16:20:58 INFO - 2015-12-10 16:20:58,791 DEBUG : BROWSER_OUTPUT: 1449793258789 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] 16:23:10 INFO - 2015-12-10 16:23:10,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43292/tests/dromaeo/cssquery-ext.html) 16:23:11 INFO - 2015-12-10 16:23:11,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 146505728 16:23:11 INFO - 2015-12-10 16:23:11,520 DEBUG : BROWSER_OUTPUT: 16:26:13 INFO - 2015-12-10 16:26:13,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/dromaeo/cssquery-ext.html (next: http://localhost:43292/tests/dromaeo/cssquery-jquery.html) 16:26:14 INFO - 2015-12-10 16:26:14,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 143695872 16:26:14 INFO - 2015-12-10 16:26:14,190 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-10 16:29:16,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43292/tests/dromaeo/cssquery-mootools.html) 16:29:16 INFO - 2015-12-10 16:29:16,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 144859136 16:29:16 INFO - 2015-12-10 16:29:16,614 DEBUG : BROWSER_OUTPUT: 16:32:18 INFO - 2015-12-10 16:32:18,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43292/tests/dromaeo/cssquery-prototype.html) 16:32:18 INFO - 2015-12-10 16:32:18,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 144273408 16:32:18 INFO - 2015-12-10 16:32:18,994 DEBUG : BROWSER_OUTPUT: 16:35:21 INFO - 2015-12-10 16:35:21,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43292/tests/dromaeo/cssquery-yui.html) 16:35:22 INFO - 2015-12-10 16:35:22,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 144158720 16:35:22 INFO - 2015-12-10 16:35:22,198 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/dromaeo/cssquery-yui.html (next: http://localhost:43292/tests/dromaeo/cssquery-dojo.html) 16:38:24 INFO - 2015-12-10 16:38:24,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 146956288 16:38:24 INFO - 2015-12-10 16:38:24,744 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,744 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:38:24 INFO - 2015-12-10 16:38:24,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:38:24 INFO - 2015-12-10 16:38:24,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:38:24 INFO - 2015-12-10 16:38:24,744 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:38:24 INFO - 2015-12-10 16:38:24,745 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2651.72156923523;2660.640813490181;2693.205504376209;2707.769839563637;2719.5240832854247;4579.404677391943;4755.239161734124;4776.570108690217;4785.497522760108;4793.640476964233;4638.8608341749805;4681.789319480623;4685.226937555308;4768.713877167373;4787.257975013869;4352.804123814421;4427.601515863572;4464.6874718769695;4489.2817149256125;4525.660575456837;4277.74333539987;4442.644588432934;4484.41702578666;4494.146112238681;4498.8200471981245;4288.378185163149;4379.321205213197;4380.802863871133;4401.537838526972;4413.867583972486;4399.890002749925;4402.933955990663;4416.624586910117;4420.778961051967;4458.8439404621;4152.397902304149;4226.809793559267;4307.138572285524;4392.956070439287;4437.622802061828;4670.696404733681;4686.461056978423;4704.941388187664;4764.714117152982;4773.284007398918;5092.821751238689;5108.514691104377;5116.130257856174;5116.334876466073;5130.897382052375;4954.653174277802;5065.062963351792;5119.0529751996;5187.766550505236;5245.423003469616;4735.905281894377;4752.120857641347;4757.381540399726;4778.37881075458;4783.545563171493;5228;5240.800246719514;5243.711595862264;5244.659097158673;5257.106291930305;4844.733539655283;4917.950820491821;4969.105560998983;4998.850034498971;5024.62315326352;5079.187330027178;5080.288759573663;5083.339165908408;5099.69401835891;5138.409082955433;4856.198727210041;5027.1705168647495;5055.317532133188;5058.671186372874;5067.87330316745;4994.925076123861;4995.850124496271;5021.372328458942;5110.642255042186;5127.743612819344;4183.288840897055;4185.121124563876;4193.685473589493;4194.643455306333;4230.873073807791;3661.7253705972157;3685.1155722626913;3696.722745794076;3709.740318177756;3726.347889119393;4226.640735537452;4287.97856010718;4323.0705398339505;4376.256036473807;4415.2494076006515;5060.1903695408555;5087.8473645789945;5093.643444958817;5097.260897169964;5127.87180320495;4256.723312984646;4373.2128216921255;4376.431063961728;4379.759113248802;4420.513743488278;4436.911261774746;4445.799939002753;4501.942043619747;4507.098580283956;4533.9319910201375;4807.543283388072;4809.158397280462;4831.202851529459;4836.782344794422;4869.488703686133;4925.482824303396;5036.068327359304;5062.746862656926;5108.642395032461;5147.974260128675;4788.209945358977;4813.518648135158;4850.7574621269505;4854.19905715553;4903.31353610502;5048.899022019613;5066.923996139987;5068.670536415121;5069.898602028013;5082.237664350377;4836.685615434985;4967.180415231591;4991.925121123113;5125.231215317583;5203.427622961395;4944.3572335596145;4944.431390390151;4951.133551628523;4973.254011898244;5021.623378246573;4921.089598424303;4942.406911170682;4946;4949.653524253267;4966.428860680923;4674.205385084611;4703.270992996091;4758.881027974328;4882.609391248762;4906.018796240837;4949.059678661043;4961.1070007397575;4977.054359671651;4987.60099192071;5026.120428924851;4884;4888.926666100083;4889.7799599018845;4898.142825005681;4942.777575009061 16:38:24 INFO - 2015-12-10 16:38:24,745 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.0131104741905;562.218516262395;580.2253990922119;581.1660267516115;592.6740292838938;35230.295394092136;36395.81802090986;36496.27007459856;36497.63502364975;36502.45246321307;40313.59686403135;40599.594004060025;40712;40748;40825.59174408255;7748.457607967444;7973.641186146638;7980.281774640282;7991.320737737299;7999.200079992012;7818.413618978571;7831.804204894895;7922.603869806516;7925.088614809313;7927.5243485391065;7859.724909628164;7936;7938.6427610757655;7945.165757595456;7973.32226760726;7725.343345815584;7740.4968677036095;7763.107242667081;7798.415118866051;7816.49192802466;7743.3805295576785;7782.455228133977;7853.332466740334;7854.057513098408;7862.371010319161;37482.62517374819;37570.812145939366;37750.81124594387;37802.24395512074;37884.43173352402;2967.228520584642;3425.366307233145;3428.6914177724125;3450.913727156816;3519.2081781598936;28445.57331640027;28572.571411428846;28573.28566785826;28708.856455717796;29261.414771704447;3314.280033798906;3436.810975396352;3499.597546282185;3515.1212196950764;3543.929121417583;217029;217471;217485;217693;218582.9999999984;51462;53023.20465193025;53082.46917530775;53166.73416632892;53505.732471338175;65479.345206547325;66135.66932165404;66716.6664166676;66770.66614666895;67218.66390668113;12707.936460317824;12721.300328481837;12791.360431978364;12791.680207994874;12831.486740530274;10732.892671073345;10771.192160587987;10791.082757965662;10792.082672972729;10794.514246858911;18774.53063673419;18956.52608684766;19087.713684294748;19107.23571057142;19142.23431062742;7706.7687969361;8061.153578874251;8078.111407745143;8092.352611791042;8098.635561399751;825.7357645553366;837.6774941647387;847.8897743293332;873.7335112790532;897.2507955856802;26210.213693589223;26261.212163635122;26300;26409.339766505993;26537;913.6071489259549;983.498415807943;983.8573406855966;1065.4566171252718;1072.5602502973743;11951.581694640647;12187.329696866758;12251.081168912368;12252.44863981123;12257.387130643432;262951;267058;267158;267934;270759;45026.77486612546;45641.77179114083;45758.54241457609;45831;46003.079938401046;1203.8675745668145;1206.5113628980278;1213.4782043721284;1230.0528592983533;1231.7167051578188;23724.762752372255;25876.223713288633;27044.45911081807;27956.720432796224;28321.15036548907;41178.1764364717;41278.174436510504;41357;41398.37902431526;41669.58330416657;198117;198604;198644;199267;199857;28691.569626456036;30440.695593043787;31072.68927310698;31245.843770781;31331.686683132877;36226;36620.45069323909;36634.26731465409;37098.44352334663;37226.44160337543;31789.20526986844;31981;32027.6797232034;32813;32859.83570082134;31273.8436307817;31512.842435787676;31804.68195318017;31901.840490797396;32024.199395015312;29275.41449171047;29519.704802952554;29802.70197298086;30063.398732025675;30121.849390752905;28468;29408.26479338034;30630.693693062785;31135;31221.219469513442;21857.125714971222;23868;24016.759832402153;24121.638175427033;25207.86564604634 16:38:24 INFO - 2015-12-10 16:38:24,745 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.17095458036994;343.92777516721486;344.658787800078;345.157814931567;347.54471642148786;15177.468788592401;15286.464973725922;15947.521574352773;16165.353385864551;16884.07137607431;10167.949160254208;10438;13892.652683682913;14877.702445951074;15002.09987400754;4491.887702807423;4609.585137337639;4637.397138372007;5044.117279476095;5056.646034777567;4981.900361992758;4986.202207646777;5011.098002359574;5022.296878437021;5045.293658887758;3595.1551385424405;4259.446271984638;4966;5004.799808007693;5250.6324557281005;5167.534921857051;5179.948200517984;5191.766370513317;5216.24364467152;5233.607479439057;4769.379980602499;4784.473707892129;4812.085703716318;4962.3548938638105;5023.120953833101;18700.158492867853;18840.43478695641;18966.810331896642;19704.507387315287;19765.01174941247;1712.494814029864;1757.411267225481;1811.25738447236;1915.4445210888825;1961.9607607847906;9158.633654653806;9312.487813170274;9505.477198754066;9555.140037396599;12961.805572916413;1715.305301352954;1769.9557511062199;1778.8399044086095;1783.2421220981162;1789.6062866169423;55251.44748552503;55568.44431555673;56161;56428;56716.716416418065;9858.260630452602;10059.144972677404;10137.189024877993;10161.339512931783;10162.39025658448;12779.297138657277;12787.872121278855;12849.48602055926;12854.807177892339;12857.742845143232;7158.391536719333;7163.212046674862;7218.8917166242545;7261.564306141649;7274.345308922222;6835.760748373783;6844.965775171092;6863.210730765926;6898.482613803884;6904.4131248843405;4228.5982831630945;4261.91476170481;4290.334998075304;4290.849820256276;4318.568143185719;1737.5569229846308;1830.1855674225108;1844.8155184481714;1855.35990083421;1882.3317722208692;390.37734812973264;392.6642720474011;408.4078086774189;903.9864402033975;959.4531117263233;9638.277129215337;10117.949410252902;10137.087662110445;10168.135708464715;15515.844841551665;817.513579420244;827.8483405720317;846.0862268749736;848.6393282854762;886.4415418286438;7364.153122390993;8079;8365.163483651586;8812.118788121137;8937.557552076903;485235;491485;492363;501986;512023;72244;73271.26728732752;74327.25672743311;74864.62567687126;75123.62438187884;1020.285799940045;1060.5757696921294;1060.9045185933303;1068.2949253492657;1071.244772435431;15117.848821511645;15121.621959450662;15163.545093647208;15175.392984280505;15416.152111633968;33317.16755578369;33477.16307092342;33480.497792532646;33967.83016084904;34500.30999380049;42729.78635106805;43001.3549796747;43730.56269437392;43822.561774383124;45046.324305136106;8567.614457349559;8792.912070879465;8854.822903541764;8907.910920890708;9234.722958311262;10648.733781655521;10687.198460115367;10715.946420267848;10729.356238625707;15558.144302063496;13542.864571354161;13641.522546710818;13674.794878077037;13796.586102416944;13912.860871391156;12234.75530489403;12461.314627695201;12622.305773182563;12757.617271481871;13104.279264640536;13687;13817.378217980015;14041.368138434;14566.563003109924;14959.92520037393;8888.200061994452;9221.446713197229;9270.304727145356;9517.476538790434;9537.189338906272;9968.800623987334;10077.69766906994;11440.82838757436;14127.364268607731;14551.272436377927 16:38:24 INFO - 2015-12-10 16:38:24,745 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1454.898157129;1621.5216511129217;1701.3704929176206;1713.477389396234;1734.4189696451697;6700.765473208438;6778.152730908637;6785.83035424114;6977.0580971568825;6989.1962424321155;6819.181698196211;6952.756653517128;7012.053372794671;7016.087908571892;7025.051618031564;2067.7518697756254;2095.3609149209483;2096.937091887246;2102;2109.3671898430484;2070.285751415759;2090.4982804126976;2092.686097085442;2107.399391173516;2114.7250857388594;1960.2746983616082;2009.859309848311;2011.5272910865936;2034.1456588232904;2048.3035767838933;2023.1705000949614;2044.6728523436252;2047.0992763184227;2050.917963281467;2053.5071582820015;1985.0868600443814;2034.8982550872397;2036.908339124743;2038.990699603691;2040.9285675001452;6872.450203983669;6922;6955.965220173866;6960.686769095403;6962.338577835098;4087.8364865405347;4088.080181959065;4137.027798467358;4168.937465937983;4178.561251068655;2656.9601455978177;2665.6534650495505;2748.872962085555;2749.8212616179885;2750.8074434789573;844.2992316377392;862.4221771413105;872.4677946452658;907.6641642592283;908.1463424381061;9233.307501937381;9404.717858464257;9433.575489102937;9453.716388508356;9462.716118516455;3815.5039844819994;3857.614238576176;3912.6478616924046;3936.7047471439755;3958.030282580786;8282.17178282167;8286;8318;8344.332453403713;8410.957945210235;4226.640735537514;4239.8092085856215;4262.573742625713;4267.1892340455215;4278.486581610165;3894.2406230784727;3902.3366027774778;3910.2570511602703;3934.744241624285;3954.2289253595272;3308.8676452942095;3358.748093892968;3393.0499460151195;3396.677315655009;3402.285520040819;1047.4762618690654;1066.2323127348297;1072.780080083581;1074.1245884604023;1076.9838452423064;885.9069797671281;887.3078998381272;923.7598224461553;1124.3647339253296;1149.166854030821;6353.555251132377;6361.936380636227;6371.96814015927;6386.137871387396;6397.040443933354;1070.3203465799118;1107.4628805029715;1155.301042869052;1166.1370585766472;1166.2419427372106;5311.814086506954;5336.306280183551;5354.491323324278;5377.489138531833;5380.78476860929;8149.592520373958;8252.793680158044;8366.58167091643;8451.36614753896;8594.484330940164;8398.74803755876;8455.619497122645;8475.745727628058;8502.829943401097;8592.95703521491;6591.670416479157;6626.801195964225;6695.866082678319;6716.932830671631;6770.255271920085;6442.452391546771;6466.06242094903;6471.870562588816;6476.06097115925;6492.935070649233;7191.17301510333;7378.409727221702;7429.479936404616;7604.695812167452;7668.846623067619;7439.442041846992;7442.292982166686;7458.701651933862;7692.153863074946;7771.300582947561;6127.908081378694;6155.2613686356135;6160.44555989963;6185.969070154621;6188.504919606331;6379.3301703320485;6551.672416379067;6572.605643661395;6616.371444712745;6631.801045968628;6220.937790622217;6358.77744278948;6379.298277189599;6419.775307864203;6503.479721622353;6035.275766907999;6061.575689701678;6127.356627554221;6167.938320616737;6204.069389591597;5941.1088336749835;6288.27684816252;6309.90535141964;6325.715342809676;6329.90505142414;5764.827055188351;5776.7400466979925;5781.653100813965;5828;5846.239988801429;5811.128330750421;5856.736446859987;5876.3536011039605;5888.558358123072;5895.115732640138 16:38:24 INFO - 2015-12-10 16:38:24,746 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.33729162820634;314.36184545372885;317.92687681833195;322.57420205328975;324.32702143053166;5450.645708028976;5511.173324001392;5512.338519377675;5600.579956503263;5687.459691329317;5506.504414602685;5546.473085056923;5564.749586268617;5575.358833734122;5580.720963951807;4142;4245.745255284677;4246.108317253365;4294.806733696991;4299.226139294926;4201.684873634475;4212.53662097169;4235.597618226264;4259.616634502894;4261.211675839964;4217.810198541058;4221.472315960505;4224.324108142698;4226.4716910386205;4228.767417792035;4225.070484493406;4226.112516371566;4227.302495088306;4229.6404805591565;4241.87274381769;3620.4026335654585;3693.5752388475403;3693.686036686885;3696.8890933272046;3720.5907350191455;5195.662281951699;5301.363836339626;5328.333958255218;5344.839654810362;5348.51863332298;4828.830990915301;4842.12841688496;4850.320955066293;4852.078105160008;4871.4154301483695;5818.447247511522;5818.709064546756;5826.941730582682;5829.912551311733;5860.941390586082;3894.104355998108;3901.3367727486398;3946.5461471930807;3994.540627827808;4005.6995725320717;6022.187004754346;6097.786577469812;6114.663693496856;6116.174316467264;6139.201903752483;4147.253494370982;4148.585141485888;4149.336106223051;4150.294449943517;4167.874963751093;4204.894877628022;4207;4208.032152604918;4210.5157906841105;4212.578742125763;4682.836100736458;4762.285657151386;4842.685225460334;4850.927236091461;4857.247126695368;5794.88410231793;5797.043487824546;5804.65172089676;5806.593538452352;5806.622569532967;1460.1531111955042;1476.6529865481602;1479.097750372272;1480.3338497676089;1481.0447261516476;999.6501224571488;1008.3294609085023;1016.654337525245;1024.846273059047;1025.266934142092;5045.445001049881;5052.8484145475695;5056.974715126475;5060.924086138711;5063.594912406998;5971.940280597225;6015.0676645120075;6017.097435384728;6019.097135429633;6035.698215089228;4977.601791856643;5027.622928280393;5037.068142393596;5044.9495505045215;5055.7219352935945;3136.153238625604;3205.743540516753;3208.566843476101;3233.7413006959387;3267.787593806395;5675.914861277084;5678.545716342683;5688.175214593944;5690.061139911868;5695.7152142392715;6200.410960958701;6207.937920620736;6210.068489726577;6216.968915155395;6223.96888015557;5502.2296878436255;5630.268065151504;5634.915476267859;5650.830475085754;5669.716514174274;5980.970095149496;5992.340842507234;6019.127226552213;6021.849453763516;6025.246844144482;5872;5884.852878678067;5899.941000589939;5911.083782013795;5915.171875937286;5582.553395728413;5600.831975040755;5656.632318899423;5663.2071509989455;5680.630759000652;4014.73904196238;4137.110521237948;4145.336746120606;4157.0023194433725;4161.812718427738;5907.704614769158;5950.821475355746;5966.820995370146;6016.09758536223;6020.849478763066;5698.715064246854;5755.3381361144;5787.189793429007;5797.681127537857;5811.56413269015;5760.683162425939;5777.39337369587;5782.797602083907;5819.5344372450945;5825.3883342248455;5588.944110558842;5630.8029218977135;5672.659640421588;5682.687452190169;5697.3448053474385;5828.70856457167;5833.504152146946;5867.20792692981;5867.706614669335;5878.706064696663;5688.40271771458;5693.089105743061;5711.3431955324;5719.714014299351;5747.453991870766 16:38:24 INFO - 2015-12-10 16:38:24,747 DEBUG : BROWSER_OUTPUT: |5;yui.html;787.7006737439774;799.7400844725465;800.635710751608;801.8356236971422;804.4650307545483;11893.583724569642;12118.394080295982;12170.148089633729;12198.390080495985;12223.083268754834;11039.944800275987;11868.643940681772;11909.702257443569;11943;12019.699507512294;805.8428606421735;821.0270829067574;821.1214001018913;821.2157389692829;825;803.2088392932957;811.2455416462687;811.4360519438992;811.7240138352959;811.8457493076326;853.7737499562621;859.8323326951247;860.0711231869566;860.9053004169567;862.5859587398021;849.5157760076759;850.8000619854361;851.7572491839796;851.8764779107025;855.3713020929612;631.3875540725535;631.9115323854664;632.2381530256031;634.4797266241684;634.8412896775806;11145.609903653332;11212.663620091329;11235.10119190471;11247.718807029807;11290.20968532203;11033.724156896062;11532.135089868294;12063.21589096706;12089.939550302191;12140.878591214063;9555.665551705657;9584.616615335379;9602.519874006271;9671.516424178762;9778.755531111708;3217.8230197339135;3261.5433839262523;3266.0854960610827;3302.290007648343;3310.0897253255307;35054.12364690903;35298;35365.29269414623;38141;41643.58356416428;7015.473839462061;8352.874706879402;8537.914620853837;8601.483910965362;8863;14903;14997.550073497594;15074.321655525308;15137.470188543348;15148.318325675371;6151.6001459904965;6394.680265986775;6405.423511883952;6518.739250430024;6601.70292336846;3503.789772613651;3636.1818590817384;3672.320620685182;3725.720570957189;3763.7553559018575;2771.362586605052;2799.972000280012;2800.6919238883706;2808.705085965985;2811.887524499038;477.73246981690363;481.2372389762196;483.92257238841614;485.4514398729413;493.87899964508205;445.7214241099313;446.77214620543106;501.0330062978414;501.8870754080303;536.1903525676179;6847.349501797321;7107.8933815992805;7137.507863440734;7163.89254161188;7282.854342913112;417.2364572831711;477.70065422051965;565.547561950438;568.0258356917823;594.191899017336;3159.131238909318;3307.305465852198;3348.3972884880955;3360.12636714456;3401.3707464119216;49345.50654493481;50335.24497132546;54315.45684543183;54329.72835135799;54673.45326546763;43565.56434435678;43647.34528982068;44063.33904991428;44943.32585011162;45312.3203151953;41260.79369603193;41843.372349414785;43867;44283.33574996378;45349.31976020296;7352.5220860643885;7401.222871598405;7445.10658720957;7490.250974902466;7778;30406.84796576003;30778.38443231078;30818.53772193374;31200.375992480476;32082;38816.2236755269;39868.40197397099;40023;40049.39925901172;42081.15837683168;9414.858777118212;9515.76210594713;9603.807923841623;9612.66355677548;10399.324043937422;10914.617988370368;10982.890171098186;11280.661580152608;11382.487788049722;11571.19001669875;9913;10231.437270949871;10281.897181028095;10555.736106597089;10935.890641093487;10870.61952831647;10877.728056798644;10919.617813376493;10990;11089.112870970464;9826.901730982885;9877.30858839903;9955.402675839472;10112.140468060297;10971.670849874517;8561.871571926302;8565.229129378386;8782.121787821166;8942.552872356486;8944.642214311354;8668.479891206547;8743.562821859008;8868.600912958804;8900.356333656104;8916.73249802507 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: __startTimestamp1449794304737__endTimestamp 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4689.24 Median:4831.20 stddev:496.63 (10.3%) stddev-sans-first:471.73 16:38:24 INFO - 2015-12-10 16:38:24,748 DEBUG : BROWSER_OUTPUT: Values: 2651.7 2660.6 2693.2 2707.8 2719.5 4579.4 4755.2 4776.6 4785.5 4793.6 4638.9 4681.8 4685.2 4768.7 4787.3 4352.8 4427.6 4464.7 4489.3 4525.7 4277.7 4442.6 4484.4 4494.1 4498.8 4288.4 4379.3 4380.8 4401.5 4413.9 4399.9 4402.9 4416.6 4420.8 4458.8 4152.4 4226.8 4307.1 4393.0 4437.6 4670.7 4686.5 4704.9 4764.7 4773.3 5092.8 5108.5 5116.1 5116.3 5130.9 4954.7 5065.1 5119.1 5187.8 5245.4 4735.9 4752.1 4757.4 4778.4 4783.5 5228.0 5240.8 5243.7 5244.7 5257.1 4844.7 4918.0 4969.1 4998.9 5024.6 5079.2 5080.3 5083.3 5099.7 5138.4 4856.2 5027.2 5055.3 5058.7 5067.9 4994.9 4995.9 5021.4 5110.6 5127.7 4183.3 4185.1 4193.7 4194.6 4230.9 3661.7 3685.1 3696.7 3709.7 3726.3 4226.6 4288.0 4323.1 4376.3 4415.2 5060.2 5087.8 5093.6 5097.3 5127.9 4256.7 4373.2 4376.4 4379.8 4420.5 4436.9 4445.8 4501.9 4507.1 4533.9 4807.5 4809.2 4831.2 4836.8 4869.5 4925.5 5036.1 5062.7 5108.6 5148.0 4788.2 4813.5 4850.8 4854.2 4903.3 5048.9 5066.9 5068.7 5069.9 5082.2 4836.7 4967.2 4991.9 5125.2 5203.4 4944.4 4944.4 4951.1 4973.3 5021.6 4921.1 4942.4 4946.0 4949.7 4966.4 4674.2 4703.3 4758.9 4882.6 4906.0 4949.1 4961.1 4977.1 4987.6 5026.1 4884.0 4888.9 4889.8 4898.1 4942.8 16:38:24 INFO - 2015-12-10 16:38:24,749 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,749 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39274.50 Median:3432.75 stddev:59865.16 (1743.9%) stddev-sans-first:59962.46 16:38:24 INFO - 2015-12-10 16:38:24,749 DEBUG : BROWSER_OUTPUT: Values: 542.0 562.2 580.2 581.2 592.7 35230.3 36395.8 36496.3 36497.6 36502.5 40313.6 40599.6 40712.0 40748.0 40825.6 7748.5 7973.6 7980.3 7991.3 7999.2 7818.4 7831.8 7922.6 7925.1 7927.5 7859.7 7936.0 7938.6 7945.2 7973.3 7725.3 7740.5 7763.1 7798.4 7816.5 7743.4 7782.5 7853.3 7854.1 7862.4 37482.6 37570.8 37750.8 37802.2 37884.4 2967.2 3425.4 3428.7 3450.9 3519.2 28445.6 28572.6 28573.3 28708.9 29261.4 3314.3 3436.8 3499.6 3515.1 3543.9 217029.0 217471.0 217485.0 217693.0 218583.0 51462.0 53023.2 53082.5 53166.7 53505.7 65479.3 66135.7 66716.7 66770.7 67218.7 12707.9 12721.3 12791.4 12791.7 12831.5 10732.9 10771.2 10791.1 10792.1 10794.5 18774.5 18956.5 19087.7 19107.2 19142.2 7706.8 8061.2 8078.1 8092.4 8098.6 825.7 837.7 847.9 873.7 897.3 26210.2 26261.2 26300.0 26409.3 26537.0 913.6 983.5 983.9 1065.5 1072.6 11951.6 12187.3 12251.1 12252.4 12257.4 262951.0 267058.0 267158.0 267934.0 270759.0 45026.8 45641.8 45758.5 45831.0 46003.1 1203.9 1206.5 1213.5 1230.1 1231.7 23724.8 25876.2 27044.5 27956.7 28321.2 41178.2 41278.2 41357.0 41398.4 41669.6 198117.0 198604.0 198644.0 199267.0 199857.0 28691.6 30440.7 31072.7 31245.8 31331.7 36226.0 36620.5 36634.3 37098.4 37226.4 31789.2 31981.0 32027.7 32813.0 32859.8 31273.8 31512.8 31804.7 31901.8 32024.2 29275.4 29519.7 29802.7 30063.4 30121.8 28468.0 29408.3 30630.7 31135.0 31221.2 21857.1 23868.0 24016.8 24121.6 25207.9 16:38:24 INFO - 2015-12-10 16:38:24,749 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,749 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26476.31 Median:400.54 stddev:81189.58 (20270.2%) stddev-sans-first:81393.62 16:38:24 INFO - 2015-12-10 16:38:24,750 DEBUG : BROWSER_OUTPUT: Values: 341.2 343.9 344.7 345.2 347.5 15177.5 15286.5 15947.5 16165.4 16884.1 10167.9 10438.0 13892.7 14877.7 15002.1 4491.9 4609.6 4637.4 5044.1 5056.6 4981.9 4986.2 5011.1 5022.3 5045.3 3595.2 4259.4 4966.0 5004.8 5250.6 5167.5 5179.9 5191.8 5216.2 5233.6 4769.4 4784.5 4812.1 4962.4 5023.1 18700.2 18840.4 18966.8 19704.5 19765.0 1712.5 1757.4 1811.3 1915.4 1962.0 9158.6 9312.5 9505.5 9555.1 12961.8 1715.3 1770.0 1778.8 1783.2 1789.6 55251.4 55568.4 56161.0 56428.0 56716.7 9858.3 10059.1 10137.2 10161.3 10162.4 12779.3 12787.9 12849.5 12854.8 12857.7 7158.4 7163.2 7218.9 7261.6 7274.3 6835.8 6845.0 6863.2 6898.5 6904.4 4228.6 4261.9 4290.3 4290.8 4318.6 1737.6 1830.2 1844.8 1855.4 1882.3 390.4 392.7 408.4 904.0 959.5 9638.3 10117.9 10137.1 10168.1 15515.8 817.5 827.8 846.1 848.6 886.4 7364.2 8079.0 8365.2 8812.1 8937.6 485235.0 491485.0 492363.0 501986.0 512023.0 72244.0 73271.3 74327.3 74864.6 75123.6 1020.3 1060.6 1060.9 1068.3 1071.2 15117.8 15121.6 15163.5 15175.4 15416.2 33317.2 33477.2 33480.5 33967.8 34500.3 42729.8 43001.4 43730.6 43822.6 45046.3 8567.6 8792.9 8854.8 8907.9 9234.7 10648.7 10687.2 10715.9 10729.4 15558.1 13542.9 13641.5 13674.8 13796.6 13912.9 12234.8 12461.3 12622.3 12757.6 13104.3 13687.0 13817.4 14041.4 14566.6 14959.9 8888.2 9221.4 9270.3 9517.5 9537.2 9968.8 10077.7 11440.8 14127.4 14551.3 16:38:24 INFO - 2015-12-10 16:38:24,750 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,750 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4905.73 Median:6127.63 stddev:2500.38 (40.8%) stddev-sans-first:2493.95 16:38:24 INFO - 2015-12-10 16:38:24,750 DEBUG : BROWSER_OUTPUT: Values: 1454.9 1621.5 1701.4 1713.5 1734.4 6700.8 6778.2 6785.8 6977.1 6989.2 6819.2 6952.8 7012.1 7016.1 7025.1 2067.8 2095.4 2096.9 2102.0 2109.4 2070.3 2090.5 2092.7 2107.4 2114.7 1960.3 2009.9 2011.5 2034.1 2048.3 2023.2 2044.7 2047.1 2050.9 2053.5 1985.1 2034.9 2036.9 2039.0 2040.9 6872.5 6922.0 6956.0 6960.7 6962.3 4087.8 4088.1 4137.0 4168.9 4178.6 2657.0 2665.7 2748.9 2749.8 2750.8 844.3 862.4 872.5 907.7 908.1 9233.3 9404.7 9433.6 9453.7 9462.7 3815.5 3857.6 3912.6 3936.7 3958.0 8282.2 8286.0 8318.0 8344.3 8411.0 4226.6 4239.8 4262.6 4267.2 4278.5 3894.2 3902.3 3910.3 3934.7 3954.2 3308.9 3358.7 3393.0 3396.7 3402.3 1047.5 1066.2 1072.8 1074.1 1077.0 885.9 887.3 923.8 1124.4 1149.2 6353.6 6361.9 6372.0 6386.1 6397.0 1070.3 1107.5 1155.3 1166.1 1166.2 5311.8 5336.3 5354.5 5377.5 5380.8 8149.6 8252.8 8366.6 8451.4 8594.5 8398.7 8455.6 8475.7 8502.8 8593.0 6591.7 6626.8 6695.9 6716.9 6770.3 6442.5 6466.1 6471.9 6476.1 6492.9 7191.2 7378.4 7429.5 7604.7 7668.8 7439.4 7442.3 7458.7 7692.2 7771.3 6127.9 6155.3 6160.4 6186.0 6188.5 6379.3 6551.7 6572.6 6616.4 6631.8 6220.9 6358.8 6379.3 6419.8 6503.5 6035.3 6061.6 6127.4 6167.9 6204.1 5941.1 6288.3 6309.9 6325.7 6329.9 5764.8 5776.7 5781.7 5828.0 5846.2 5811.1 5856.7 5876.4 5888.6 5895.1 16:38:24 INFO - 2015-12-10 16:38:24,750 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,750 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4799.19 Median:5504.37 stddev:1418.43 (25.8%) stddev-sans-first:1381.87 16:38:24 INFO - 2015-12-10 16:38:24,751 DEBUG : BROWSER_OUTPUT: Values: 313.3 314.4 317.9 322.6 324.3 5450.6 5511.2 5512.3 5600.6 5687.5 5506.5 5546.5 5564.7 5575.4 5580.7 4142.0 4245.7 4246.1 4294.8 4299.2 4201.7 4212.5 4235.6 4259.6 4261.2 4217.8 4221.5 4224.3 4226.5 4228.8 4225.1 4226.1 4227.3 4229.6 4241.9 3620.4 3693.6 3693.7 3696.9 3720.6 5195.7 5301.4 5328.3 5344.8 5348.5 4828.8 4842.1 4850.3 4852.1 4871.4 5818.4 5818.7 5826.9 5829.9 5860.9 3894.1 3901.3 3946.5 3994.5 4005.7 6022.2 6097.8 6114.7 6116.2 6139.2 4147.3 4148.6 4149.3 4150.3 4167.9 4204.9 4207.0 4208.0 4210.5 4212.6 4682.8 4762.3 4842.7 4850.9 4857.2 5794.9 5797.0 5804.7 5806.6 5806.6 1460.2 1476.7 1479.1 1480.3 1481.0 999.7 1008.3 1016.7 1024.8 1025.3 5045.4 5052.8 5057.0 5060.9 5063.6 5971.9 6015.1 6017.1 6019.1 6035.7 4977.6 5027.6 5037.1 5044.9 5055.7 3136.2 3205.7 3208.6 3233.7 3267.8 5675.9 5678.5 5688.2 5690.1 5695.7 6200.4 6207.9 6210.1 6217.0 6224.0 5502.2 5630.3 5634.9 5650.8 5669.7 5981.0 5992.3 6019.1 6021.8 6025.2 5872.0 5884.9 5899.9 5911.1 5915.2 5582.6 5600.8 5656.6 5663.2 5680.6 4014.7 4137.1 4145.3 4157.0 4161.8 5907.7 5950.8 5966.8 6016.1 6020.8 5698.7 5755.3 5787.2 5797.7 5811.6 5760.7 5777.4 5782.8 5819.5 5825.4 5588.9 5630.8 5672.7 5682.7 5697.3 5828.7 5833.5 5867.2 5867.7 5878.7 5688.4 5693.1 5711.3 5719.7 5747.5 16:38:24 INFO - 2015-12-10 16:38:24,751 DEBUG : BROWSER_OUTPUT: 16:38:24 INFO - 2015-12-10 16:38:24,751 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12186.59 Median:477.72 stddev:14053.22 (2941.7%) stddev-sans-first:14066.57 16:38:24 INFO - 2015-12-10 16:38:24,752 DEBUG : BROWSER_OUTPUT: Values: 787.7 799.7 800.6 801.8 804.5 11893.6 12118.4 12170.1 12198.4 12223.1 11039.9 11868.6 11909.7 11943.0 12019.7 805.8 821.0 821.1 821.2 825.0 803.2 811.2 811.4 811.7 811.8 853.8 859.8 860.1 860.9 862.6 849.5 850.8 851.8 851.9 855.4 631.4 631.9 632.2 634.5 634.8 11145.6 11212.7 11235.1 11247.7 11290.2 11033.7 11532.1 12063.2 12089.9 12140.9 9555.7 9584.6 9602.5 9671.5 9778.8 3217.8 3261.5 3266.1 3302.3 3310.1 35054.1 35298.0 35365.3 38141.0 41643.6 7015.5 8352.9 8537.9 8601.5 8863.0 14903.0 14997.6 15074.3 15137.5 15148.3 6151.6 6394.7 6405.4 6518.7 6601.7 3503.8 3636.2 3672.3 3725.7 3763.8 2771.4 2800.0 2800.7 2808.7 2811.9 477.7 481.2 483.9 485.5 493.9 445.7 446.8 501.0 501.9 536.2 6847.3 7107.9 7137.5 7163.9 7282.9 417.2 477.7 565.5 568.0 594.2 3159.1 3307.3 3348.4 3360.1 3401.4 49345.5 50335.2 54315.5 54329.7 54673.5 43565.6 43647.3 44063.3 44943.3 45312.3 41260.8 41843.4 43867.0 44283.3 45349.3 7352.5 7401.2 7445.1 7490.3 7778.0 30406.8 30778.4 30818.5 31200.4 32082.0 38816.2 39868.4 40023.0 40049.4 42081.2 9414.9 9515.8 9603.8 9612.7 10399.3 10914.6 10982.9 11280.7 11382.5 11571.2 9913.0 10231.4 10281.9 10555.7 10935.9 10870.6 10877.7 10919.6 10990.0 11089.1 9826.9 9877.3 9955.4 10112.1 10971.7 8561.9 8565.2 8782.1 8942.6 8944.6 8668.5 8743.6 8868.6 8900.4 8916.7 16:38:24 INFO - 2015-12-10 16:38:24,752 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:38:24 INFO - 2015-12-10 16:38:24,752 DEBUG : BROWSER_OUTPUT: 16:38:25 INFO - 2015-12-10 16:38:25,461 INFO : Browser exited with error code: 0 16:38:25 INFO - 2015-12-10 16:38:25,484 INFO : Completed test dromaeo_css (00:18:34) 16:38:25 INFO - 2015-12-10 16:38:25,484 INFO : Starting test kraken 16:38:25 INFO - 2015-12-10 16:38:25,484 DEBUG : operating with platform_type : linux_ 16:38:25 INFO - 2015-12-10 16:38:25,485 INFO : Initialising browser for kraken test... 16:38:25 INFO - 2015-12-10 16:38:25,491 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPeMG3O/profile http://localhost:43292/getInfo.html 16:38:30 INFO - 2015-12-10 16:38:30,097 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:38:30 INFO - 2015-12-10 16:38:30,097 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:38:30 INFO - 2015-12-10 16:38:30,097 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:38:30 INFO - 2015-12-10 16:38:30,098 DEBUG : BROWSER_OUTPUT: __metrics 16:38:30 INFO - 2015-12-10 16:38:30,226 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] 16:38:31 INFO - 2015-12-10 16:38:31,133 INFO : Browser initialized. 16:38:31 INFO - 2015-12-10 16:38:31,133 INFO : Running cycle 1/1 for kraken test... 16:38:31 INFO - 2015-12-10 16:38:31,134 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPeMG3O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:38:43 INFO - 2015-12-10 16:38:43,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 142639104 16:38:43 INFO - 2015-12-10 16:38:43,137 DEBUG : BROWSER_OUTPUT: 16:38:45 INFO - 2015-12-10 16:38:45,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43292/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:46 INFO - 2015-12-10 16:38:46,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 144056320 16:38:46 INFO - 2015-12-10 16:38:46,333 DEBUG : BROWSER_OUTPUT: 16:38:49 INFO - 2015-12-10 16:38:49,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43292/tests/kraken/driver.html?testName=audio-dft) 16:38:49 INFO - 2015-12-10 16:38:49,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 143568896 16:38:49 INFO - 2015-12-10 16:38:49,683 DEBUG : BROWSER_OUTPUT: 16:38:52 INFO - 2015-12-10 16:38:52,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43292/tests/kraken/driver.html?testName=audio-fft) 16:38:53 INFO - 2015-12-10 16:38:53,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 16:38:53 INFO - 2015-12-10 16:38:53,192 DEBUG : BROWSER_OUTPUT: 16:38:55 INFO - 2015-12-10 16:38:55,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43292/tests/kraken/driver.html?testName=audio-oscillator) 16:38:55 INFO - 2015-12-10 16:38:55,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 137457664 16:38:55 INFO - 2015-12-10 16:38:55,879 DEBUG : BROWSER_OUTPUT: 16:38:58 INFO - 2015-12-10 16:38:58,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:58 INFO - 2015-12-10 16:38:58,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 16:38:58 INFO - 2015-12-10 16:38:58,727 DEBUG : BROWSER_OUTPUT: 16:39:01 INFO - 2015-12-10 16:39:01,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43292/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:02 INFO - 2015-12-10 16:39:02,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 140439552 16:39:02 INFO - 2015-12-10 16:39:02,367 DEBUG : BROWSER_OUTPUT: 16:39:05 INFO - 2015-12-10 16:39:05,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43292/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:06 INFO - 2015-12-10 16:39:06,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 138641408 16:39:06 INFO - 2015-12-10 16:39:06,463 DEBUG : BROWSER_OUTPUT: 16:39:09 INFO - 2015-12-10 16:39:09,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43292/tests/kraken/driver.html?testName=json-parse-financial) 16:39:09 INFO - 2015-12-10 16:39:09,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 139190272 16:39:09 INFO - 2015-12-10 16:39:09,956 DEBUG : BROWSER_OUTPUT: 16:39:11 INFO - 2015-12-10 16:39:11,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:12 INFO - 2015-12-10 16:39:12,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 140972032 16:39:12 INFO - 2015-12-10 16:39:12,347 DEBUG : BROWSER_OUTPUT: 16:39:14 INFO - 2015-12-10 16:39:14,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:14 INFO - 2015-12-10 16:39:14,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 140169216 16:39:14 INFO - 2015-12-10 16:39:14,873 DEBUG : BROWSER_OUTPUT: 16:39:17 INFO - 2015-12-10 16:39:17,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:17 INFO - 2015-12-10 16:39:17,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 140414976 16:39:17 INFO - 2015-12-10 16:39:17,633 DEBUG : BROWSER_OUTPUT: 16:39:20 INFO - 2015-12-10 16:39:20,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:20 INFO - 2015-12-10 16:39:20,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 16:39:20 INFO - 2015-12-10 16:39:20,802 DEBUG : BROWSER_OUTPUT: 16:39:23 INFO - 2015-12-10 16:39:23,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:24 INFO - 2015-12-10 16:39:24,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 140890112 16:39:24 INFO - 2015-12-10 16:39:24,025 DEBUG : BROWSER_OUTPUT: 16:39:25 INFO - 2015-12-10 16:39:25,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43292/tests/kraken/driver.html?testName=ai-astar) 16:39:26 INFO - 2015-12-10 16:39:26,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 140185600 16:39:26 INFO - 2015-12-10 16:39:26,076 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,080 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:39:26 INFO - 2015-12-10 16:39:26,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:39:26 INFO - 2015-12-10 16:39:26,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:39:26 INFO - 2015-12-10 16:39:26,080 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:39:26 INFO - 2015-12-10 16:39:26,080 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;108;115;111;113;124;113;112;112;112 16:39:26 INFO - 2015-12-10 16:39:26,080 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;172;137;156;172;132;152;157;132;163;133 16:39:26 INFO - 2015-12-10 16:39:26,081 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;166;161;160;164;173;165;164;162 16:39:26 INFO - 2015-12-10 16:39:26,081 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;74;155;73;79;74;73;148 16:39:26 INFO - 2015-12-10 16:39:26,081 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;96;134;95;99;96;132;97;95;137 16:39:26 INFO - 2015-12-10 16:39:26,081 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;110;110;111;112;110;110 16:39:26 INFO - 2015-12-10 16:39:26,081 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;148;148;148;147;147;148;147 16:39:26 INFO - 2015-12-10 16:39:26,082 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;101;96;96;96;96;96;96;96 16:39:26 INFO - 2015-12-10 16:39:26,082 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;76;74;76;76;76;83;73;73 16:39:26 INFO - 2015-12-10 16:39:26,082 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;67;67;68;67;68;68;69 16:39:26 INFO - 2015-12-10 16:39:26,082 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;83;83;84;86;84;86;92;84;82 16:39:26 INFO - 2015-12-10 16:39:26,082 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;121;125;128;133;139;123;123;124;127 16:39:26 INFO - 2015-12-10 16:39:26,082 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;157;148;147;149;149;138;147;148;146;152 16:39:26 INFO - 2015-12-10 16:39:26,083 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;74;71;73;71;69;72;72;73 16:39:26 INFO - 2015-12-10 16:39:26,083 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:39:26 INFO - 2015-12-10 16:39:26,083 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:39:26 INFO - 2015-12-10 16:39:26,083 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 16:39:26 INFO - 2015-12-10 16:39:26,083 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:39:26 INFO - 2015-12-10 16:39:26,084 DEBUG : BROWSER_OUTPUT: __startTimestamp1449794366078__endTimestamp 16:39:26 INFO - 2015-12-10 16:39:26,084 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,087 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.20 (3.7%) stddev-sans-first:4.42 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: Values: 115.0 108.0 115.0 111.0 113.0 124.0 113.0 112.0 112.0 112.0 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.60 Median:156.50 stddev:16.08 (10.3%) stddev-sans-first:15.08 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: Values: 172.0 137.0 156.0 172.0 132.0 152.0 157.0 132.0 163.0 133.0 16:39:26 INFO - 2015-12-10 16:39:26,088 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:3.57 (2.2%) stddev-sans-first:3.78 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 166.0 161.0 160.0 164.0 173.0 165.0 164.0 162.0 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.30 Median:73.00 stddev:32.88 (45.0%) stddev-sans-first:34.28 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 74.0 155.0 73.0 79.0 74.0 73.0 148.0 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.80 Median:96.00 stddev:18.38 (19.1%) stddev-sans-first:19.08 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 134.0 95.0 99.0 96.0 132.0 97.0 95.0 137.0 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,090 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 110.0 110.0 111.0 112.0 110.0 110.0 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 148.0 147.0 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:1.67 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 101.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.70 Median:76.00 stddev:2.83 (3.7%) stddev-sans-first:2.99 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 76.0 74.0 76.0 76.0 76.0 83.0 73.0 73.0 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:39:26 INFO - 2015-12-10 16:39:26,091 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 67.0 67.0 68.0 67.0 68.0 68.0 69.0 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:3.41 (4.0%) stddev-sans-first:2.98 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: Values: 91.0 83.0 83.0 84.0 86.0 84.0 86.0 92.0 84.0 82.0 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:126.00 stddev:5.54 (4.4%) stddev-sans-first:5.72 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 125.0 128.0 133.0 139.0 123.0 123.0 124.0 127.0 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:148.50 stddev:4.77 (3.2%) stddev-sans-first:3.82 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: Values: 157.0 148.0 147.0 149.0 149.0 138.0 147.0 148.0 146.0 152.0 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,092 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 16:39:26 INFO - 2015-12-10 16:39:26,093 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 74.0 71.0 73.0 71.0 69.0 72.0 72.0 73.0 16:39:26 INFO - 2015-12-10 16:39:26,093 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:39:26 INFO - 2015-12-10 16:39:26,093 DEBUG : BROWSER_OUTPUT: 16:39:26 INFO - 2015-12-10 16:39:26,969 INFO : Browser exited with error code: 0 16:39:27 INFO - 2015-12-10 16:39:27,024 INFO : Completed test kraken (00:01:01) 16:39:27 INFO - 2015-12-10 16:39:27,024 INFO : Starting test v8_7 16:39:27 INFO - 2015-12-10 16:39:27,024 DEBUG : operating with platform_type : linux_ 16:39:27 INFO - 2015-12-10 16:39:27,025 INFO : Initialising browser for v8_7 test... 16:39:27 INFO - 2015-12-10 16:39:27,031 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwnKXJ/profile http://localhost:43292/getInfo.html 16:39:31 INFO - 2015-12-10 16:39:31,671 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:39:31 INFO - 2015-12-10 16:39:31,671 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:39:31 INFO - 2015-12-10 16:39:31,671 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:39:31 INFO - 2015-12-10 16:39:31,671 DEBUG : BROWSER_OUTPUT: __metrics 16:39:31 INFO - 2015-12-10 16:39:31,780 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] 16:39:32 INFO - 2015-12-10 16:39:32,721 INFO : Browser initialized. 16:39:32 INFO - 2015-12-10 16:39:32,721 INFO : Running cycle 1/1 for v8_7 test... 16:39:32 INFO - 2015-12-10 16:39:32,721 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwnKXJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:39:44 INFO - 2015-12-10 16:39:44,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 142925824 16:39:44 INFO - 2015-12-10 16:39:44,736 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43292/tests/v8_7/run.html (next: http://localhost:43292/tests/v8_7/run.html) 16:40:06 INFO - 2015-12-10 16:40:06,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 137768960 16:40:06 INFO - 2015-12-10 16:40:06,370 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,370 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.01387604070305 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 16:40:06 INFO - 2015-12-10 16:40:06,371 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1077.5862068965516 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: |5;Earley;700.2801120448179 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: |8;Splay;599.5203836930456 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: __startTimestamp1449794406367__endTimestamp 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,372 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: Values: 165.8 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.01 Median:185.01 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: Values: 185.0 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: Values: 278.5 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: Values: 5229.2 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,373 DEBUG : BROWSER_OUTPUT: Values: 1077.6 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: Values: 700.3 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: Values: 12243.9 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: Values: 26368.4 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.52 Median:599.52 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: Values: 599.5 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:40:06 INFO - 2015-12-10 16:40:06,374 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:40:06 INFO - 2015-12-10 16:40:06,375 DEBUG : BROWSER_OUTPUT: 16:40:07 INFO - 2015-12-10 16:40:07,261 INFO : Browser exited with error code: 0 16:40:07 INFO - 2015-12-10 16:40:07,275 INFO : Completed test v8_7 (00:00:40) 16:40:07 INFO - 2015-12-10 16:40:07,401 INFO : Completed test suite (00:20:16) 16:40:07 INFO - 2015-12-10 16:40:07,401 DEBUG : Working with test: dromaeo_css 16:40:07 INFO - 2015-12-10 16:40:07,401 DEBUG : Generating results file: dromaeo_css 16:40:07 INFO - 2015-12-10 16:40:07,403 DEBUG : Working with test: kraken 16:40:07 INFO - 2015-12-10 16:40:07,403 DEBUG : Generating results file: kraken 16:40:07 INFO - 2015-12-10 16:40:07,403 INFO : javascript benchmark 16:40:07 INFO - 2015-12-10 16:40:07,403 DEBUG : Working with test: v8_7 16:40:07 INFO - 2015-12-10 16:40:07,403 DEBUG : Generating results file: v8_7 16:40:07 INFO - 2015-12-10 16:40:07,404 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:40:08 INFO - 2015-12-10 16:40:08,039 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 16:40:08 INFO - 2015-12-10 16:40:08,040 DEBUG : process_Request line: dromaeo_css 6301.05 graph.html#tests=[[72,132,43]] 16:40:08 INFO - 2015-12-10 16:40:08,040 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:40:08 INFO - 2015-12-10 16:40:08,073 DEBUG : process_Request line: kraken 1555.50 graph.html#tests=[[232,132,43]] 16:40:08 INFO - 2015-12-10 16:40:08,073 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:40:08 INFO - 2015-12-10 16:40:08,203 DEBUG : process_Request line: v8_7 21360.57 graph.html#tests=[[230,132,43]] 16:40:08 INFO - 2015-12-10 16:40:08,205 INFO : javascript benchmark 16:40:08 INFO - 2015-12-10 16:40:08,208 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.72156923523, 2660.640813490181, 2693.205504376209, 2707.769839563637, 2719.5240832854247, 4579.404677391943, 4755.239161734124, 4776.570108690217, 4785.497522760108, 4793.640476964233, 4638.8608341749805, 4681.789319480623, 4685.226937555308, 4768.713877167373, 4787.257975013869, 4352.804123814421, 4427.601515863572, 4464.6874718769695, 4489.2817149256125, 4525.660575456837, 4277.74333539987, 4442.644588432934, 4484.41702578666, 4494.146112238681, 4498.8200471981245, 4288.378185163149, 4379.321205213197, 4380.802863871133, 4401.537838526972, 4413.867583972486, 4399.890002749925, 4402.933955990663, 4416.624586910117, 4420.778961051967, 4458.8439404621, 4152.397902304149, 4226.809793559267, 4307.138572285524, 4392.956070439287, 4437.622802061828, 4670.696404733681, 4686.461056978423, 4704.941388187664, 4764.714117152982, 4773.284007398918, 5092.821751238689, 5108.514691104377, 5116.130257856174, 5116.334876466073, 5130.897382052375, 4954.653174277802, 5065.062963351792, 5119.0529751996, 5187.766550505236, 5245.423003469616, 4735.905281894377, 4752.120857641347, 4757.381540399726, 4778.37881075458, 4783.545563171493, 5228.0, 5240.800246719514, 5243.711595862264, 5244.659097158673, 5257.106291930305, 4844.733539655283, 4917.950820491821, 4969.105560998983, 4998.850034498971, 5024.62315326352, 5079.187330027178, 5080.288759573663, 5083.339165908408, 5099.69401835891, 5138.409082955433, 4856.198727210041, 5027.1705168647495, 5055.317532133188, 5058.671186372874, 5067.87330316745, 4994.925076123861, 4995.850124496271, 5021.372328458942, 5110.642255042186, 5127.743612819344, 4183.288840897055, 4185.121124563876, 4193.685473589493, 4194.643455306333, 4230.873073807791, 3661.7253705972157, 3685.1155722626913, 3696.722745794076, 3709.740318177756, 3726.347889119393, 4226.640735537452, 4287.97856010718, 4323.0705398339505, 4376.256036473807, 4415.2494076006515, 5060.1903695408555, 5087.8473645789945, 5093.643444958817, 5097.260897169964, 5127.87180320495, 4256.723312984646, 4373.2128216921255, 4376.431063961728, 4379.759113248802, 4420.513743488278, 4436.911261774746, 4445.799939002753, 4501.942043619747, 4507.098580283956, 4533.9319910201375, 4807.543283388072, 4809.158397280462, 4831.202851529459, 4836.782344794422, 4869.488703686133, 4925.482824303396, 5036.068327359304, 5062.746862656926, 5108.642395032461, 5147.974260128675, 4788.209945358977, 4813.518648135158, 4850.7574621269505, 4854.19905715553, 4903.31353610502, 5048.899022019613, 5066.923996139987, 5068.670536415121, 5069.898602028013, 5082.237664350377, 4836.685615434985, 4967.180415231591, 4991.925121123113, 5125.231215317583, 5203.427622961395, 4944.3572335596145, 4944.431390390151, 4951.133551628523, 4973.254011898244, 5021.623378246573, 4921.089598424303, 4942.406911170682, 4946.0, 4949.653524253267, 4966.428860680923, 4674.205385084611, 4703.270992996091, 4758.881027974328, 4882.609391248762, 4906.018796240837, 4949.059678661043, 4961.1070007397575, 4977.054359671651, 4987.60099192071, 5026.120428924851, 4884.0, 4888.926666100083, 4889.7799599018845, 4898.142825005681, 4942.777575009061], "unit": "ms", "name": "dojo.html", "value": 4657.684169921321}, {"lowerIsBetter": false, "replicates": [542.0131104741905, 562.218516262395, 580.2253990922119, 581.1660267516115, 592.6740292838938, 35230.295394092136, 36395.81802090986, 36496.27007459856, 36497.63502364975, 36502.45246321307, 40313.59686403135, 40599.594004060025, 40712.0, 40748.0, 40825.59174408255, 7748.457607967444, 7973.641186146638, 7980.281774640282, 7991.320737737299, 7999.200079992012, 7818.413618978571, 7831.804204894895, 7922.603869806516, 7925.088614809313, 7927.5243485391065, 7859.724909628164, 7936.0, 7938.6427610757655, 7945.165757595456, 7973.32226760726, 7725.343345815584, 7740.4968677036095, 7763.107242667081, 7798.415118866051, 7816.49192802466, 7743.3805295576785, 7782.455228133977, 7853.332466740334, 7854.057513098408, 7862.371010319161, 37482.62517374819, 37570.812145939366, 37750.81124594387, 37802.24395512074, 37884.43173352402, 2967.228520584642, 3425.366307233145, 3428.6914177724125, 3450.913727156816, 3519.2081781598936, 28445.57331640027, 28572.571411428846, 28573.28566785826, 28708.856455717796, 29261.414771704447, 3314.280033798906, 3436.810975396352, 3499.597546282185, 3515.1212196950764, 3543.929121417583, 217029.0, 217471.0, 217485.0, 217693.0, 218582.9999999984, 51462.0, 53023.20465193025, 53082.46917530775, 53166.73416632892, 53505.732471338175, 65479.345206547325, 66135.66932165404, 66716.6664166676, 66770.66614666895, 67218.66390668113, 12707.936460317824, 12721.300328481837, 12791.360431978364, 12791.680207994874, 12831.486740530274, 10732.892671073345, 10771.192160587987, 10791.082757965662, 10792.082672972729, 10794.514246858911, 18774.53063673419, 18956.52608684766, 19087.713684294748, 19107.23571057142, 19142.23431062742, 7706.7687969361, 8061.153578874251, 8078.111407745143, 8092.352611791042, 8098.635561399751, 825.7357645553366, 837.6774941647387, 847.8897743293332, 873.7335112790532, 897.2507955856802, 26210.213693589223, 26261.212163635122, 26300.0, 26409.339766505993, 26537.0, 913.6071489259549, 983.498415807943, 983.8573406855966, 1065.4566171252718, 1072.5602502973743, 11951.581694640647, 12187.329696866758, 12251.081168912368, 12252.44863981123, 12257.387130643432, 262951.0, 267058.0, 267158.0, 267934.0, 270759.0, 45026.77486612546, 45641.77179114083, 45758.54241457609, 45831.0, 46003.079938401046, 1203.8675745668145, 1206.5113628980278, 1213.4782043721284, 1230.0528592983533, 1231.7167051578188, 23724.762752372255, 25876.223713288633, 27044.45911081807, 27956.720432796224, 28321.15036548907, 41178.1764364717, 41278.174436510504, 41357.0, 41398.37902431526, 41669.58330416657, 198117.0, 198604.0, 198644.0, 199267.0, 199857.0, 28691.569626456036, 30440.695593043787, 31072.68927310698, 31245.843770781, 31331.686683132877, 36226.0, 36620.45069323909, 36634.26731465409, 37098.44352334663, 37226.44160337543, 31789.20526986844, 31981.0, 32027.6797232034, 32813.0, 32859.83570082134, 31273.8436307817, 31512.842435787676, 31804.68195318017, 31901.840490797396, 32024.199395015312, 29275.41449171047, 29519.704802952554, 29802.70197298086, 30063.398732025675, 30121.849390752905, 28468.0, 29408.26479338034, 30630.693693062785, 31135.0, 31221.219469513442, 21857.125714971222, 23868.0, 24016.759832402153, 24121.638175427033, 25207.86564604634], "unit": "ms", "name": "ext.html", "value": 16738.64405486026}, {"lowerIsBetter": false, "replicates": [341.17095458036994, 343.92777516721486, 344.658787800078, 345.157814931567, 347.54471642148786, 15177.468788592401, 15286.464973725922, 15947.521574352773, 16165.353385864551, 16884.07137607431, 10167.949160254208, 10438.0, 13892.652683682913, 14877.702445951074, 15002.09987400754, 4491.887702807423, 4609.585137337639, 4637.397138372007, 5044.117279476095, 5056.646034777567, 4981.900361992758, 4986.202207646777, 5011.098002359574, 5022.296878437021, 5045.293658887758, 3595.1551385424405, 4259.446271984638, 4966.0, 5004.799808007693, 5250.6324557281005, 5167.534921857051, 5179.948200517984, 5191.766370513317, 5216.24364467152, 5233.607479439057, 4769.379980602499, 4784.473707892129, 4812.085703716318, 4962.3548938638105, 5023.120953833101, 18700.158492867853, 18840.43478695641, 18966.810331896642, 19704.507387315287, 19765.01174941247, 1712.494814029864, 1757.411267225481, 1811.25738447236, 1915.4445210888825, 1961.9607607847906, 9158.633654653806, 9312.487813170274, 9505.477198754066, 9555.140037396599, 12961.805572916413, 1715.305301352954, 1769.9557511062199, 1778.8399044086095, 1783.2421220981162, 1789.6062866169423, 55251.44748552503, 55568.44431555673, 56161.0, 56428.0, 56716.716416418065, 9858.260630452602, 10059.144972677404, 10137.189024877993, 10161.339512931783, 10162.39025658448, 12779.297138657277, 12787.872121278855, 12849.48602055926, 12854.807177892339, 12857.742845143232, 7158.391536719333, 7163.212046674862, 7218.8917166242545, 7261.564306141649, 7274.345308922222, 6835.760748373783, 6844.965775171092, 6863.210730765926, 6898.482613803884, 6904.4131248843405, 4228.5982831630945, 4261.91476170481, 4290.334998075304, 4290.849820256276, 4318.568143185719, 1737.5569229846308, 1830.1855674225108, 1844.8155184481714, 1855.35990083421, 1882.3317722208692, 390.37734812973264, 392.6642720474011, 408.4078086774189, 903.9864402033975, 959.4531117263233, 9638.277129215337, 10117.949410252902, 10137.087662110445, 10168.135708464715, 15515.844841551665, 817.513579420244, 827.8483405720317, 846.0862268749736, 848.6393282854762, 886.4415418286438, 7364.153122390993, 8079.0, 8365.163483651586, 8812.118788121137, 8937.557552076903, 485235.0, 491485.0, 492363.0, 501986.0, 512023.0, 72244.0, 73271.26728732752, 74327.25672743311, 74864.62567687126, 75123.62438187884, 1020.285799940045, 1060.5757696921294, 1060.9045185933303, 1068.2949253492657, 1071.244772435431, 15117.848821511645, 15121.621959450662, 15163.545093647208, 15175.392984280505, 15416.152111633968, 33317.16755578369, 33477.16307092342, 33480.497792532646, 33967.83016084904, 34500.30999380049, 42729.78635106805, 43001.3549796747, 43730.56269437392, 43822.561774383124, 45046.324305136106, 8567.614457349559, 8792.912070879465, 8854.822903541764, 8907.910920890708, 9234.722958311262, 10648.733781655521, 10687.198460115367, 10715.946420267848, 10729.356238625707, 15558.144302063496, 13542.864571354161, 13641.522546710818, 13674.794878077037, 13796.586102416944, 13912.860871391156, 12234.75530489403, 12461.314627695201, 12622.305773182563, 12757.617271481871, 13104.279264640536, 13687.0, 13817.378217980015, 14041.368138434, 14566.563003109924, 14959.92520037393, 8888.200061994452, 9221.446713197229, 9270.304727145356, 9517.476538790434, 9537.189338906272, 9968.800623987334, 10077.69766906994, 11440.82838757436, 14127.364268607731, 14551.272436377927], "unit": "ms", "name": "jquery.html", "value": 8053.52049095315}, {"lowerIsBetter": false, "replicates": [1454.898157129, 1621.5216511129217, 1701.3704929176206, 1713.477389396234, 1734.4189696451697, 6700.765473208438, 6778.152730908637, 6785.83035424114, 6977.0580971568825, 6989.1962424321155, 6819.181698196211, 6952.756653517128, 7012.053372794671, 7016.087908571892, 7025.051618031564, 2067.7518697756254, 2095.3609149209483, 2096.937091887246, 2102.0, 2109.3671898430484, 2070.285751415759, 2090.4982804126976, 2092.686097085442, 2107.399391173516, 2114.7250857388594, 1960.2746983616082, 2009.859309848311, 2011.5272910865936, 2034.1456588232904, 2048.3035767838933, 2023.1705000949614, 2044.6728523436252, 2047.0992763184227, 2050.917963281467, 2053.5071582820015, 1985.0868600443814, 2034.8982550872397, 2036.908339124743, 2038.990699603691, 2040.9285675001452, 6872.450203983669, 6922.0, 6955.965220173866, 6960.686769095403, 6962.338577835098, 4087.8364865405347, 4088.080181959065, 4137.027798467358, 4168.937465937983, 4178.561251068655, 2656.9601455978177, 2665.6534650495505, 2748.872962085555, 2749.8212616179885, 2750.8074434789573, 844.2992316377392, 862.4221771413105, 872.4677946452658, 907.6641642592283, 908.1463424381061, 9233.307501937381, 9404.717858464257, 9433.575489102937, 9453.716388508356, 9462.716118516455, 3815.5039844819994, 3857.614238576176, 3912.6478616924046, 3936.7047471439755, 3958.030282580786, 8282.17178282167, 8286.0, 8318.0, 8344.332453403713, 8410.957945210235, 4226.640735537514, 4239.8092085856215, 4262.573742625713, 4267.1892340455215, 4278.486581610165, 3894.2406230784727, 3902.3366027774778, 3910.2570511602703, 3934.744241624285, 3954.2289253595272, 3308.8676452942095, 3358.748093892968, 3393.0499460151195, 3396.677315655009, 3402.285520040819, 1047.4762618690654, 1066.2323127348297, 1072.780080083581, 1074.1245884604023, 1076.9838452423064, 885.9069797671281, 887.3078998381272, 923.7598224461553, 1124.3647339253296, 1149.166854030821, 6353.555251132377, 6361.936380636227, 6371.96814015927, 6386.137871387396, 6397.040443933354, 1070.3203465799118, 1107.4628805029715, 1155.301042869052, 1166.1370585766472, 1166.2419427372106, 5311.814086506954, 5336.306280183551, 5354.491323324278, 5377.489138531833, 5380.78476860929, 8149.592520373958, 8252.793680158044, 8366.58167091643, 8451.36614753896, 8594.484330940164, 8398.74803755876, 8455.619497122645, 8475.745727628058, 8502.829943401097, 8592.95703521491, 6591.670416479157, 6626.801195964225, 6695.866082678319, 6716.932830671631, 6770.255271920085, 6442.452391546771, 6466.06242094903, 6471.870562588816, 6476.06097115925, 6492.935070649233, 7191.17301510333, 7378.409727221702, 7429.479936404616, 7604.695812167452, 7668.846623067619, 7439.442041846992, 7442.292982166686, 7458.701651933862, 7692.153863074946, 7771.300582947561, 6127.908081378694, 6155.2613686356135, 6160.44555989963, 6185.969070154621, 6188.504919606331, 6379.3301703320485, 6551.672416379067, 6572.605643661395, 6616.371444712745, 6631.801045968628, 6220.937790622217, 6358.77744278948, 6379.298277189599, 6419.775307864203, 6503.479721622353, 6035.275766907999, 6061.575689701678, 6127.356627554221, 6167.938320616737, 6204.069389591597, 5941.1088336749835, 6288.27684816252, 6309.90535141964, 6325.715342809676, 6329.90505142414, 5764.827055188351, 5776.7400466979925, 5781.653100813965, 5828.0, 5846.239988801429, 5811.128330750421, 5856.736446859987, 5876.3536011039605, 5888.558358123072, 5895.115732640138], "unit": "ms", "name": "mootools.html", "value": 4059.0151996190284}, {"lowerIsBetter": false, "replicates": [313.33729162820634, 314.36184545372885, 317.92687681833195, 322.57420205328975, 324.32702143053166, 5450.645708028976, 5511.173324001392, 5512.338519377675, 5600.579956503263, 5687.459691329317, 5506.504414602685, 5546.473085056923, 5564.749586268617, 5575.358833734122, 5580.720963951807, 4142.0, 4245.745255284677, 4246.108317253365, 4294.806733696991, 4299.226139294926, 4201.684873634475, 4212.53662097169, 4235.597618226264, 4259.616634502894, 4261.211675839964, 4217.810198541058, 4221.472315960505, 4224.324108142698, 4226.4716910386205, 4228.767417792035, 4225.070484493406, 4226.112516371566, 4227.302495088306, 4229.6404805591565, 4241.87274381769, 3620.4026335654585, 3693.5752388475403, 3693.686036686885, 3696.8890933272046, 3720.5907350191455, 5195.662281951699, 5301.363836339626, 5328.333958255218, 5344.839654810362, 5348.51863332298, 4828.830990915301, 4842.12841688496, 4850.320955066293, 4852.078105160008, 4871.4154301483695, 5818.447247511522, 5818.709064546756, 5826.941730582682, 5829.912551311733, 5860.941390586082, 3894.104355998108, 3901.3367727486398, 3946.5461471930807, 3994.540627827808, 4005.6995725320717, 6022.187004754346, 6097.786577469812, 6114.663693496856, 6116.174316467264, 6139.201903752483, 4147.253494370982, 4148.585141485888, 4149.336106223051, 4150.294449943517, 4167.874963751093, 4204.894877628022, 4207.0, 4208.032152604918, 4210.5157906841105, 4212.578742125763, 4682.836100736458, 4762.285657151386, 4842.685225460334, 4850.927236091461, 4857.247126695368, 5794.88410231793, 5797.043487824546, 5804.65172089676, 5806.593538452352, 5806.622569532967, 1460.1531111955042, 1476.6529865481602, 1479.097750372272, 1480.3338497676089, 1481.0447261516476, 999.6501224571488, 1008.3294609085023, 1016.654337525245, 1024.846273059047, 1025.266934142092, 5045.445001049881, 5052.8484145475695, 5056.974715126475, 5060.924086138711, 5063.594912406998, 5971.940280597225, 6015.0676645120075, 6017.097435384728, 6019.097135429633, 6035.698215089228, 4977.601791856643, 5027.622928280393, 5037.068142393596, 5044.9495505045215, 5055.7219352935945, 3136.153238625604, 3205.743540516753, 3208.566843476101, 3233.7413006959387, 3267.787593806395, 5675.914861277084, 5678.545716342683, 5688.175214593944, 5690.061139911868, 5695.7152142392715, 6200.410960958701, 6207.937920620736, 6210.068489726577, 6216.968915155395, 6223.96888015557, 5502.2296878436255, 5630.268065151504, 5634.915476267859, 5650.830475085754, 5669.716514174274, 5980.970095149496, 5992.340842507234, 6019.127226552213, 6021.849453763516, 6025.246844144482, 5872.0, 5884.852878678067, 5899.941000589939, 5911.083782013795, 5915.171875937286, 5582.553395728413, 5600.831975040755, 5656.632318899423, 5663.2071509989455, 5680.630759000652, 4014.73904196238, 4137.110521237948, 4145.336746120606, 4157.0023194433725, 4161.812718427738, 5907.704614769158, 5950.821475355746, 5966.820995370146, 6016.09758536223, 6020.849478763066, 5698.715064246854, 5755.3381361144, 5787.189793429007, 5797.681127537857, 5811.56413269015, 5760.683162425939, 5777.39337369587, 5782.797602083907, 5819.5344372450945, 5825.3883342248455, 5588.944110558842, 5630.8029218977135, 5672.659640421588, 5682.687452190169, 5697.3448053474385, 5828.70856457167, 5833.504152146946, 5867.20792692981, 5867.706614669335, 5878.706064696663, 5688.40271771458, 5693.089105743061, 5711.3431955324, 5719.714014299351, 5747.453991870766], "unit": "ms", "name": "prototype.html", "value": 4345.073449958685}, {"lowerIsBetter": false, "replicates": [787.7006737439774, 799.7400844725465, 800.635710751608, 801.8356236971422, 804.4650307545483, 11893.583724569642, 12118.394080295982, 12170.148089633729, 12198.390080495985, 12223.083268754834, 11039.944800275987, 11868.643940681772, 11909.702257443569, 11943.0, 12019.699507512294, 805.8428606421735, 821.0270829067574, 821.1214001018913, 821.2157389692829, 825.0, 803.2088392932957, 811.2455416462687, 811.4360519438992, 811.7240138352959, 811.8457493076326, 853.7737499562621, 859.8323326951247, 860.0711231869566, 860.9053004169567, 862.5859587398021, 849.5157760076759, 850.8000619854361, 851.7572491839796, 851.8764779107025, 855.3713020929612, 631.3875540725535, 631.9115323854664, 632.2381530256031, 634.4797266241684, 634.8412896775806, 11145.609903653332, 11212.663620091329, 11235.10119190471, 11247.718807029807, 11290.20968532203, 11033.724156896062, 11532.135089868294, 12063.21589096706, 12089.939550302191, 12140.878591214063, 9555.665551705657, 9584.616615335379, 9602.519874006271, 9671.516424178762, 9778.755531111708, 3217.8230197339135, 3261.5433839262523, 3266.0854960610827, 3302.290007648343, 3310.0897253255307, 35054.12364690903, 35298.0, 35365.29269414623, 38141.0, 41643.58356416428, 7015.473839462061, 8352.874706879402, 8537.914620853837, 8601.483910965362, 8863.0, 14903.0, 14997.550073497594, 15074.321655525308, 15137.470188543348, 15148.318325675371, 6151.6001459904965, 6394.680265986775, 6405.423511883952, 6518.739250430024, 6601.70292336846, 3503.789772613651, 3636.1818590817384, 3672.320620685182, 3725.720570957189, 3763.7553559018575, 2771.362586605052, 2799.972000280012, 2800.6919238883706, 2808.705085965985, 2811.887524499038, 477.73246981690363, 481.2372389762196, 483.92257238841614, 485.4514398729413, 493.87899964508205, 445.7214241099313, 446.77214620543106, 501.0330062978414, 501.8870754080303, 536.1903525676179, 6847.349501797321, 7107.8933815992805, 7137.507863440734, 7163.89254161188, 7282.854342913112, 417.2364572831711, 477.70065422051965, 565.547561950438, 568.0258356917823, 594.191899017336, 3159.131238909318, 3307.305465852198, 3348.3972884880955, 3360.12636714456, 3401.3707464119216, 49345.50654493481, 50335.24497132546, 54315.45684543183, 54329.72835135799, 54673.45326546763, 43565.56434435678, 43647.34528982068, 44063.33904991428, 44943.32585011162, 45312.3203151953, 41260.79369603193, 41843.372349414785, 43867.0, 44283.33574996378, 45349.31976020296, 7352.5220860643885, 7401.222871598405, 7445.10658720957, 7490.250974902466, 7778.0, 30406.84796576003, 30778.38443231078, 30818.53772193374, 31200.375992480476, 32082.0, 38816.2236755269, 39868.40197397099, 40023.0, 40049.39925901172, 42081.15837683168, 9414.858777118212, 9515.76210594713, 9603.807923841623, 9612.66355677548, 10399.324043937422, 10914.617988370368, 10982.890171098186, 11280.661580152608, 11382.487788049722, 11571.19001669875, 9913.0, 10231.437270949871, 10281.897181028095, 10555.736106597089, 10935.890641093487, 10870.61952831647, 10877.728056798644, 10919.617813376493, 10990.0, 11089.112870970464, 9826.901730982885, 9877.30858839903, 9955.402675839472, 10112.140468060297, 10971.670849874517, 8561.871571926302, 8565.229129378386, 8782.121787821166, 8942.552872356486, 8944.642214311354, 8668.479891206547, 8743.562821859008, 8868.600912958804, 8900.356333656104, 8916.73249802507], "unit": "ms", "name": "yui.html", "value": 5651.221073761511}], "name": "dromaeo_css", "value": 6301.05477134635}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 115.0, 111.0, 113.0, 124.0, 113.0, 112.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [172.0, 137.0, 156.0, 172.0, 132.0, 152.0, 157.0, 132.0, 163.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 166.0, 161.0, 160.0, 164.0, 173.0, 165.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 74.0, 155.0, 73.0, 79.0, 74.0, 73.0, 148.0], "unit": "ms", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 134.0, 95.0, 99.0, 96.0, 132.0, 97.0, 95.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 112.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 101.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 76.0, 74.0, 76.0, 76.0, 76.0, 83.0, 73.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 75.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 83.0, 84.0, 86.0, 84.0, 86.0, 92.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [123.0, 121.0, 125.0, 128.0, 133.0, 139.0, 123.0, 123.0, 124.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [157.0, 148.0, 147.0, 149.0, 149.0, 138.0, 147.0, 148.0, 146.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 71.0, 73.0, 71.0, 69.0, 72.0, 72.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1555.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [185.01387604070305], "unit": "score", "name": "DeltaBlue", "value": 357.36779000000007}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [599.5203836930456], "unit": "score", "name": "Splay", "value": 135.92698800000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21360.56828251148}]} 16:40:08 INFO - RETURN: dromaeo_css: 6301.05 16:40:08 INFO - RETURN: kraken: 1555.50 16:40:08 INFO - RETURN: v8_7: 21360.57 16:40:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21360.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1555.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6301.05"}}} 16:40:08 INFO - Return code: 0 16:40:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:40:08 INFO - # TBPL SUCCESS # 16:40:08 INFO - Running post-action listener: _resource_record_post_action 16:40:08 INFO - Running post-run listener: _resource_record_post_run 16:40:09 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 278409216; Read time: 180; Write time: 146192 16:40:09 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4661248; Read time: 0; Write time: 276 16:40:09 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 272887808; Read time: 180; Write time: 145872 16:40:09 INFO - Running post-run listener: _upload_blobber_files 16:40:09 INFO - Blob upload gear active. 16:40:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:40:09 INFO - Copying logs to upload dir... 16:40:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.954819 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 16:40:09.369506) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 16:40:09.372784) ========= 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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010022 build_url: 'https://queue.taskcluster.net/v1/task/YYFsrVPRRwGEwE_UE4zYeA/artifacts/public/build/firefox-45.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-10 16:40:09.424523) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:40:09.424849) ========= 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=edca6ca23558fe0608d91a4e00000196-1449792846.288573-2010850499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004809 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 16:40:09.474223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 16:40:09.474543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 16:40:09.474879) ========= ========= Total master_lag: 0.31 =========