builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1449658435.99 results: success (0) buildid: 20151209015042 builduid: f6f0446e4eeb4d4091fd6bdc33e67cd4 revision: 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:55.986357) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:55.986728) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:55.987022) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006489 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.023396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.023680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.110644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.110895) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.179084) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.179397) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.179753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.180026) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 02:53:56-- 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% 211M=0s 2015-12-09 02:53:56 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.391674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.392009) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:56.441121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 02:53:56.441512) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb --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 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb --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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 02:53:56,957 truncating revision to first 12 chars 2015-12-09 02:53:56,957 Setting DEBUG logging. 2015-12-09 02:53:56,957 attempt 1/10 2015-12-09 02:53:56,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/965cfbe44aa5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 02:53:57,988 unpacking tar archive at: fx-team-965cfbe44aa5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.295853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 02:53:57.750221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.753589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.763657) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.764367) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 02:53:57.765015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-09 02:53:57.768504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:53:58 INFO - MultiFileLogger online at 20151209 02:53:58 in /builds/slave/test 02:53:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 02:53:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:53:58 INFO - {'append_to_log': False, 02:53:58 INFO - 'base_work_dir': '/builds/slave/test', 02:53:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:53:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:53:58 INFO - 'branch': 'Fx-Team-Non-PGO', 02:53:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:53:58 INFO - 'config_files': ('talos/linux_config.py',), 02:53:58 INFO - 'default_actions': ('clobber', 02:53:58 INFO - 'read-buildbot-config', 02:53:58 INFO - 'download-and-extract', 02:53:58 INFO - 'populate-webroot', 02:53:58 INFO - 'create-virtualenv', 02:53:58 INFO - 'install', 02:53:58 INFO - 'run-tests'), 02:53:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:53:58 INFO - 'download_minidump_stackwalk': True, 02:53:58 INFO - 'download_symbols': 'ondemand', 02:53:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:53:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:53:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:53:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:53:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:53:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:53:58 INFO - 'installer_path': 'installer.exe', 02:53:58 INFO - 'log_level': 'info', 02:53:58 INFO - 'log_name': 'talos', 02:53:58 INFO - 'log_to_console': True, 02:53:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:53:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:53:58 INFO - 'opt_config_files': (), 02:53:58 INFO - 'pip_index': False, 02:53:58 INFO - 'sps_profile': False, 02:53:58 INFO - 'sps_profile_interval': 0, 02:53:58 INFO - 'suite': 'dromaeojs', 02:53:58 INFO - 'system_bits': '64', 02:53:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:53:58 INFO - 'title': 'talos-linux64-ix-019', 02:53:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:53:58 INFO - 'use_talos_json': True, 02:53:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:53:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:53:58 INFO - 'work_dir': 'build'} 02:53:58 INFO - ##### 02:53:58 INFO - ##### Running clobber step. 02:53:58 INFO - ##### 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: clobber 02:53:58 INFO - rmtree: /builds/slave/test/build 02:53:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:53:58 INFO - Running post-action listener: _resource_record_post_action 02:53:58 INFO - ##### 02:53:58 INFO - ##### Running read-buildbot-config step. 02:53:58 INFO - ##### 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: read_buildbot_config 02:53:58 INFO - Using buildbot properties: 02:53:58 INFO - { 02:53:58 INFO - "properties": { 02:53:58 INFO - "buildnumber": 995, 02:53:58 INFO - "product": "firefox", 02:53:58 INFO - "script_repo_revision": "production", 02:53:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:53:58 INFO - "repository": "", 02:53:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:53:58 INFO - "buildid": "20151209015042", 02:53:58 INFO - "slavename": "talos-linux64-ix-019", 02:53:58 INFO - "pgo_build": "False", 02:53:58 INFO - "basedir": "/builds/slave/test", 02:53:58 INFO - "project": "", 02:53:58 INFO - "platform": "ubuntu64_hw", 02:53:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:53:58 INFO - "slavebuilddir": "test", 02:53:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:53:58 INFO - "branch": "fx-team", 02:53:58 INFO - "repo_path": "integration/fx-team", 02:53:58 INFO - "stage_platform": "linux64", 02:53:58 INFO - "builduid": "f6f0446e4eeb4d4091fd6bdc33e67cd4", 02:53:58 INFO - "revision": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb" 02:53:58 INFO - }, 02:53:58 INFO - "sourcestamp": { 02:53:58 INFO - "repository": "", 02:53:58 INFO - "hasPatch": false, 02:53:58 INFO - "project": "", 02:53:58 INFO - "branch": "fx-team-linux64-talos", 02:53:58 INFO - "changes": [ 02:53:58 INFO - { 02:53:58 INFO - "category": null, 02:53:58 INFO - "files": [ 02:53:58 INFO - { 02:53:58 INFO - "url": null, 02:53:58 INFO - "name": "https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:53:58 INFO - } 02:53:58 INFO - ], 02:53:58 INFO - "repository": "", 02:53:58 INFO - "rev": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb", 02:53:58 INFO - "who": "cbook@mozilla.com", 02:53:58 INFO - "when": 1449658378, 02:53:58 INFO - "number": 7140206, 02:53:58 INFO - "comments": "Bug 1225236 - Removed the 360 value limit for the hue-rotate field in the CSS filter popup. r=pbro", 02:53:58 INFO - "project": "", 02:53:58 INFO - "at": "Wed 09 Dec 2015 02:52:58", 02:53:58 INFO - "branch": "fx-team-linux64-talos", 02:53:58 INFO - "revlink": "", 02:53:58 INFO - "properties": [ 02:53:58 INFO - [ 02:53:58 INFO - "buildid", 02:53:58 INFO - "20151209015042", 02:53:58 INFO - "Change" 02:53:58 INFO - ], 02:53:58 INFO - [ 02:53:58 INFO - "builduid", 02:53:58 INFO - "f6f0446e4eeb4d4091fd6bdc33e67cd4", 02:53:58 INFO - "Change" 02:53:58 INFO - ], 02:53:58 INFO - [ 02:53:58 INFO - "pgo_build", 02:53:58 INFO - "False", 02:53:58 INFO - "Change" 02:53:58 INFO - ] 02:53:58 INFO - ], 02:53:58 INFO - "revision": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb" 02:53:58 INFO - } 02:53:58 INFO - ], 02:53:58 INFO - "revision": "965cfbe44aa5394498843bb8f6136ccc3dd1e0fb" 02:53:58 INFO - } 02:53:58 INFO - } 02:53:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:53:58 INFO - Running post-action listener: _resource_record_post_action 02:53:58 INFO - ##### 02:53:58 INFO - ##### Running download-and-extract step. 02:53:58 INFO - ##### 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: download_and_extract 02:53:58 INFO - mkdir: /builds/slave/test/build/tests 02:53:58 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')]} 02:53:58 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json 02:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json 02:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:54:03 INFO - Downloaded 1302 bytes. 02:54:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:54:03 INFO - Using the following test package requirements: 02:54:03 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:03 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:54:03 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'jsshell-linux-x86_64.zip'], 02:54:03 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:54:03 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:03 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:54:03 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:54:03 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:54:03 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:54:03 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:54:03 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:54:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:54:03 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')]} 02:54:03 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:54:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:04 INFO - Downloaded 21859668 bytes. 02:54:04 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 02:54:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:04 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 02:54:05 INFO - Return code: 0 02:54:05 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 02:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:05 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:07 INFO - Downloaded 21859668 bytes. 02:54:07 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 02:54:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:54:07 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 02:54:08 INFO - Return code: 0 02:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:08 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:54:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:09 INFO - Downloaded 11132038 bytes. 02:54:09 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 02:54:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:54:09 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 02:54:09 INFO - Return code: 0 02:54: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')]} 02:54:09 INFO - https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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 02:54:10 INFO - Downloaded 57729465 bytes. 02:54:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:10 INFO - mkdir: /builds/slave/test/properties 02:54:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:10 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:10 INFO - Contents: 02:54:10 INFO - build_url:https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:54:10 INFO - Running post-action listener: _resource_record_post_action 02:54:10 INFO - Running post-action listener: set_extra_try_arguments 02:54:10 INFO - ##### 02:54:10 INFO - ##### Running populate-webroot step. 02:54:10 INFO - ##### 02:54:10 INFO - Running pre-action listener: _resource_record_pre_action 02:54:10 INFO - Running main action method: populate_webroot 02:54:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:10 INFO - '--tppagecycles', 02:54:10 INFO - '7'], 02:54:10 INFO - 'tests': ['tsvgm']}}, 02:54:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:54:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:54:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:54:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:54:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'tests': ['damp', 'tps']}, 02:54:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['damp', 'tps']}, 02:54:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:54:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:10 INFO - 'other': {'tests': ['a11yr', 02:54:10 INFO - 'ts_paint', 02:54:10 INFO - 'tpaint', 02:54:10 INFO - 'sessionrestore', 02:54:10 INFO - 'sessionrestore_no_auto_restore']}, 02:54:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['a11yr', 02:54:10 INFO - 'ts_paint', 02:54:10 INFO - 'tpaint', 02:54:10 INFO - 'sessionrestore', 02:54:10 INFO - 'sessionrestore_no_auto_restore']}, 02:54:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['a11yr', 02:54:10 INFO - 'ts_paint', 02:54:10 INFO - 'tpaint', 02:54:10 INFO - 'sessionrestore', 02:54:10 INFO - 'sessionrestore_no_auto_restore']}, 02:54:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['a11yr', 02:54:10 INFO - 'ts_paint', 02:54:10 INFO - 'tpaint', 02:54:10 INFO - 'sessionrestore', 02:54:10 INFO - 'sessionrestore_no_auto_restore']}, 02:54:10 INFO - 'other_l64': {'tests': ['a11yr', 02:54:10 INFO - 'ts_paint', 02:54:10 INFO - 'tpaint', 02:54:10 INFO - 'sessionrestore', 02:54:10 INFO - 'sessionrestore_no_auto_restore']}, 02:54:10 INFO - 'other_nol64': {'tests': ['a11yr', 02:54:10 INFO - 'ts_paint', 02:54:10 INFO - 'tpaint', 02:54:10 INFO - 'sessionrestore', 02:54:10 INFO - 'sessionrestore_no_auto_restore']}, 02:54:10 INFO - 'svgr': {'tests': ['tsvgx', 02:54:10 INFO - 'tsvgr_opacity', 02:54:10 INFO - 'tart', 02:54:10 INFO - 'tscrollx', 02:54:10 INFO - 'cart']}, 02:54:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['tsvgx', 02:54:10 INFO - 'tsvgr_opacity', 02:54:10 INFO - 'tart', 02:54:10 INFO - 'tscrollx', 02:54:10 INFO - 'cart']}, 02:54:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'tests': ['tp5o']}, 02:54:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'talos_options': ['--e10s'], 02:54:10 INFO - 'tests': ['tp5o']}, 02:54:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'talos_options': ['--xperf_path', 02:54:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:10 INFO - 'tests': ['tp5n']}, 02:54:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:10 INFO - 'talos_options': ['--e10s', 02:54:10 INFO - '--xperf_path', 02:54:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:10 INFO - 'tests': ['tp5n']}}, 02:54:10 INFO - 'talos.zip': {'path': '', 02:54:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:10 INFO - Running post-action listener: _resource_record_post_action 02:54:10 INFO - ##### 02:54:10 INFO - ##### Running create-virtualenv step. 02:54:10 INFO - ##### 02:54:10 INFO - Running pre-action listener: _resource_record_pre_action 02:54:10 INFO - Running main action method: create_virtualenv 02:54:10 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:10 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 02:54:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:11 INFO - Using real prefix '/usr' 02:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:13 INFO - Installing pip.................done. 02:54:13 INFO - Return code: 0 02:54:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54:13 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')]} 02:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:13 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')]} 02:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:13 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:13 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 02:54:13 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 02:54:13 INFO - Using env: {'DISPLAY': ':0', 02:54:13 INFO - 'HOME': '/home/cltbld', 02:54:13 INFO - 'LANG': 'en_US.UTF-8', 02:54:13 INFO - 'LANGUAGE': 'en_US:en', 02:54:13 INFO - 'LOGNAME': 'cltbld', 02:54:13 INFO - 'MAIL': '/var/mail/cltbld', 02:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:13 INFO - 'MOZ_NO_REMOTE': '1', 02:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:13 INFO - 'NO_EM_RESTART': '1', 02:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:13 INFO - 'PWD': '/builds/slave/test', 02:54:13 INFO - 'SHELL': '/bin/bash', 02:54:13 INFO - 'SHLVL': '1', 02:54:13 INFO - 'TERM': 'linux', 02:54:13 INFO - 'TMOUT': '86400', 02:54:13 INFO - 'USER': 'cltbld', 02:54:13 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:13 INFO - '_': '/tools/buildbot/bin/python'} 02:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:13 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 02:54:13 INFO - Cleaning up... 02:54:13 INFO - Return code: 0 02:54:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:54:13 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')]} 02:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:13 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')]} 02:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:13 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:13 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 02:54:13 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 02:54:13 INFO - Using env: {'DISPLAY': ':0', 02:54:13 INFO - 'HOME': '/home/cltbld', 02:54:13 INFO - 'LANG': 'en_US.UTF-8', 02:54:13 INFO - 'LANGUAGE': 'en_US:en', 02:54:13 INFO - 'LOGNAME': 'cltbld', 02:54:13 INFO - 'MAIL': '/var/mail/cltbld', 02:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:13 INFO - 'MOZ_NO_REMOTE': '1', 02:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:13 INFO - 'NO_EM_RESTART': '1', 02:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:13 INFO - 'PWD': '/builds/slave/test', 02:54:13 INFO - 'SHELL': '/bin/bash', 02:54:13 INFO - 'SHLVL': '1', 02:54:13 INFO - 'TERM': 'linux', 02:54:13 INFO - 'TMOUT': '86400', 02:54:13 INFO - 'USER': 'cltbld', 02:54:13 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:13 INFO - '_': '/tools/buildbot/bin/python'} 02:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:13 INFO - Downloading/unpacking psutil>=0.7.1 02:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:15 INFO - Installing collected packages: psutil 02:54:15 INFO - Running setup.py install for psutil 02:54:15 INFO - building 'psutil._psutil_linux' extension 02:54:15 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 02:54:15 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 02:54:16 INFO - building 'psutil._psutil_posix' extension 02:54: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 02:54: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:16 INFO - Successfully installed psutil 02:54:16 INFO - Cleaning up... 02:54:16 INFO - Return code: 0 02:54:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:16 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:16 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 02:54:16 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 02:54:16 INFO - Using env: {'DISPLAY': ':0', 02:54:16 INFO - 'HOME': '/home/cltbld', 02:54:16 INFO - 'LANG': 'en_US.UTF-8', 02:54:16 INFO - 'LANGUAGE': 'en_US:en', 02:54:16 INFO - 'LOGNAME': 'cltbld', 02:54:16 INFO - 'MAIL': '/var/mail/cltbld', 02:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:16 INFO - 'MOZ_NO_REMOTE': '1', 02:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:16 INFO - 'NO_EM_RESTART': '1', 02:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:16 INFO - 'PWD': '/builds/slave/test', 02:54:16 INFO - 'SHELL': '/bin/bash', 02:54:16 INFO - 'SHLVL': '1', 02:54:16 INFO - 'TERM': 'linux', 02:54:16 INFO - 'TMOUT': '86400', 02:54:16 INFO - 'USER': 'cltbld', 02:54:16 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:16 INFO - '_': '/tools/buildbot/bin/python'} 02:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:54:18 INFO - Installing collected packages: mozsystemmonitor 02:54:18 INFO - Running setup.py install for mozsystemmonitor 02:54:18 INFO - Successfully installed mozsystemmonitor 02:54:18 INFO - Cleaning up... 02:54:18 INFO - Return code: 0 02:54:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:54:18 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')]} 02:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:18 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')]} 02:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:18 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:18 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 02:54:18 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 02:54:18 INFO - Using env: {'DISPLAY': ':0', 02:54:18 INFO - 'HOME': '/home/cltbld', 02:54:18 INFO - 'LANG': 'en_US.UTF-8', 02:54:18 INFO - 'LANGUAGE': 'en_US:en', 02:54:18 INFO - 'LOGNAME': 'cltbld', 02:54:18 INFO - 'MAIL': '/var/mail/cltbld', 02:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:18 INFO - 'MOZ_NO_REMOTE': '1', 02:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:18 INFO - 'NO_EM_RESTART': '1', 02:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:18 INFO - 'PWD': '/builds/slave/test', 02:54:18 INFO - 'SHELL': '/bin/bash', 02:54:18 INFO - 'SHLVL': '1', 02:54:18 INFO - 'TERM': 'linux', 02:54:18 INFO - 'TMOUT': '86400', 02:54:18 INFO - 'USER': 'cltbld', 02:54:18 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:18 INFO - '_': '/tools/buildbot/bin/python'} 02:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:20 INFO - Downloading blobuploader-1.2.4.tar.gz 02:54:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:54:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:54:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54:20 INFO - Downloading docopt-0.6.1.tar.gz 02:54:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:54:20 INFO - Installing collected packages: blobuploader, requests, docopt 02:54:20 INFO - Running setup.py install for blobuploader 02:54:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:54:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:54:21 INFO - Running setup.py install for requests 02:54:21 INFO - Running setup.py install for docopt 02:54:21 INFO - Successfully installed blobuploader requests docopt 02:54:21 INFO - Cleaning up... 02:54:21 INFO - Return code: 0 02:54:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:21 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:21 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 02:54:21 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 02:54:21 INFO - Using env: {'DISPLAY': ':0', 02:54:21 INFO - 'HOME': '/home/cltbld', 02:54:21 INFO - 'LANG': 'en_US.UTF-8', 02:54:21 INFO - 'LANGUAGE': 'en_US:en', 02:54:21 INFO - 'LOGNAME': 'cltbld', 02:54:21 INFO - 'MAIL': '/var/mail/cltbld', 02:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:21 INFO - 'MOZ_NO_REMOTE': '1', 02:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:21 INFO - 'NO_EM_RESTART': '1', 02:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:21 INFO - 'PWD': '/builds/slave/test', 02:54:21 INFO - 'SHELL': '/bin/bash', 02:54:21 INFO - 'SHLVL': '1', 02:54:21 INFO - 'TERM': 'linux', 02:54:21 INFO - 'TMOUT': '86400', 02:54:21 INFO - 'USER': 'cltbld', 02:54:21 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:21 INFO - '_': '/tools/buildbot/bin/python'} 02:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:21 INFO - Running setup.py (path:/tmp/pip-7KhL4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:21 INFO - Running setup.py (path:/tmp/pip-goskEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:21 INFO - Running setup.py (path:/tmp/pip-RyUGf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:22 INFO - Running setup.py (path:/tmp/pip-47r7Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:22 INFO - Running setup.py (path:/tmp/pip-t3FFsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:22 INFO - Running setup.py (path:/tmp/pip-cK3jS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:22 INFO - Running setup.py (path:/tmp/pip-c8GQJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:22 INFO - Running setup.py (path:/tmp/pip-sUdOnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:22 INFO - Running setup.py (path:/tmp/pip-b5EWMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:22 INFO - Running setup.py (path:/tmp/pip-SI9tLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:22 INFO - Running setup.py (path:/tmp/pip-mEUWwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:22 INFO - Running setup.py (path:/tmp/pip-PIPl0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:22 INFO - Running setup.py (path:/tmp/pip-9RSDAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:22 INFO - Running setup.py (path:/tmp/pip-AdA5LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:22 INFO - Running setup.py (path:/tmp/pip-FeVR8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:22 INFO - Running setup.py (path:/tmp/pip-HYtXeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:22 INFO - Running setup.py (path:/tmp/pip-RclaXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:54:23 INFO - Running setup.py install for manifestparser 02:54:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Running setup.py install for mozcrash 02:54:23 INFO - Running setup.py install for mozdebug 02:54:23 INFO - Running setup.py install for mozdevice 02:54:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Running setup.py install for mozfile 02:54:23 INFO - Running setup.py install for mozhttpd 02:54:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Running setup.py install for mozinfo 02:54:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Running setup.py install for mozInstall 02:54:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:54:23 INFO - Running setup.py install for mozleak 02:54:23 INFO - Running setup.py install for mozlog 02:54:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Running setup.py install for moznetwork 02:54:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Running setup.py install for mozprocess 02:54:24 INFO - Running setup.py install for mozprofile 02:54:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Running setup.py install for mozrunner 02:54:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Running setup.py install for mozscreenshot 02:54:24 INFO - Running setup.py install for moztest 02:54:24 INFO - Running setup.py install for mozversion 02:54:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:54:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:54:24 INFO - Cleaning up... 02:54:24 INFO - Return code: 0 02:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:24 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')]} 02:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:24 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')]} 02:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:24 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:24 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 02:54:24 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 02:54:24 INFO - Using env: {'DISPLAY': ':0', 02:54:24 INFO - 'HOME': '/home/cltbld', 02:54:24 INFO - 'LANG': 'en_US.UTF-8', 02:54:24 INFO - 'LANGUAGE': 'en_US:en', 02:54:24 INFO - 'LOGNAME': 'cltbld', 02:54:24 INFO - 'MAIL': '/var/mail/cltbld', 02:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:24 INFO - 'MOZ_NO_REMOTE': '1', 02:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:24 INFO - 'NO_EM_RESTART': '1', 02:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:24 INFO - 'PWD': '/builds/slave/test', 02:54:24 INFO - 'SHELL': '/bin/bash', 02:54:24 INFO - 'SHLVL': '1', 02:54:24 INFO - 'TERM': 'linux', 02:54:24 INFO - 'TMOUT': '86400', 02:54:24 INFO - 'USER': 'cltbld', 02:54:24 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:24 INFO - '_': '/tools/buildbot/bin/python'} 02:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:25 INFO - Running setup.py (path:/tmp/pip-E79Dfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:25 INFO - Running setup.py (path:/tmp/pip-c8Ym_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:25 INFO - Running setup.py (path:/tmp/pip-0ZDNC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:25 INFO - Running setup.py (path:/tmp/pip-6u9LZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:25 INFO - Running setup.py (path:/tmp/pip-pZbW6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:25 INFO - Running setup.py (path:/tmp/pip-xm1Mnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:25 INFO - Running setup.py (path:/tmp/pip-pp56fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:25 INFO - Running setup.py (path:/tmp/pip-4SUkKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:25 INFO - Running setup.py (path:/tmp/pip-RvFDUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:25 INFO - Running setup.py (path:/tmp/pip-DMFxrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:25 INFO - Running setup.py (path:/tmp/pip-wpWIZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:25 INFO - Running setup.py (path:/tmp/pip-4ukdWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:25 INFO - Running setup.py (path:/tmp/pip-xCGXFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:25 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)) 02:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:25 INFO - Running setup.py (path:/tmp/pip-bCPeek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:26 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)) 02:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:26 INFO - Running setup.py (path:/tmp/pip-6Hfqo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:26 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)) 02:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:26 INFO - Running setup.py (path:/tmp/pip-Jhe7cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:26 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)) 02:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:26 INFO - Running setup.py (path:/tmp/pip-ru_c2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:26 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)) 02:54:26 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)) 02:54:26 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)) 02:54:26 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)) 02:54:26 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)) 02:54:26 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)) 02:54:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:54:26 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 02:54:26 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 02:54:26 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 02:54:26 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 02:54:26 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 02:54:26 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 02:54:27 INFO - Downloading blessings-1.5.1.tar.gz 02:54:27 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 02:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:54:28 INFO - Installing collected packages: blessings 02:54:28 INFO - Running setup.py install for blessings 02:54:28 INFO - Successfully installed blessings 02:54:28 INFO - Cleaning up... 02:54:28 INFO - Return code: 0 02:54:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:28 INFO - Reading from file tmpfile_stdout 02:54:28 INFO - Current package versions: 02:54:28 INFO - argparse == 1.2.1 02:54:28 INFO - blessings == 1.5.1 02:54:28 INFO - blobuploader == 1.2.4 02:54:28 INFO - docopt == 0.6.1 02:54:28 INFO - manifestparser == 1.1 02:54:28 INFO - mozInstall == 1.12 02:54:28 INFO - mozcrash == 0.16 02:54:28 INFO - mozdebug == 0.1 02:54:28 INFO - mozdevice == 0.47 02:54:28 INFO - mozfile == 1.2 02:54:28 INFO - mozhttpd == 0.7 02:54:28 INFO - mozinfo == 0.9 02:54:28 INFO - mozleak == 0.1 02:54:28 INFO - mozlog == 3.1 02:54:28 INFO - moznetwork == 0.27 02:54:28 INFO - mozprocess == 0.22 02:54:28 INFO - mozprofile == 0.27 02:54:28 INFO - mozrunner == 6.11 02:54:28 INFO - mozscreenshot == 0.1 02:54:28 INFO - mozsystemmonitor == 0.0 02:54:28 INFO - moztest == 0.7 02:54:28 INFO - mozversion == 1.4 02:54:28 INFO - psutil == 3.1.1 02:54:28 INFO - requests == 1.2.3 02:54:28 INFO - wsgiref == 0.1.2 02:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:28 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:28 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 02:54:28 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 02:54:28 INFO - Using env: {'DISPLAY': ':0', 02:54:28 INFO - 'HOME': '/home/cltbld', 02:54:28 INFO - 'LANG': 'en_US.UTF-8', 02:54:28 INFO - 'LANGUAGE': 'en_US:en', 02:54:28 INFO - 'LOGNAME': 'cltbld', 02:54:28 INFO - 'MAIL': '/var/mail/cltbld', 02:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:28 INFO - 'MOZ_NO_REMOTE': '1', 02:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:28 INFO - 'NO_EM_RESTART': '1', 02:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:28 INFO - 'PWD': '/builds/slave/test', 02:54:28 INFO - 'SHELL': '/bin/bash', 02:54:28 INFO - 'SHLVL': '1', 02:54:28 INFO - 'TERM': 'linux', 02:54:28 INFO - 'TMOUT': '86400', 02:54:28 INFO - 'USER': 'cltbld', 02:54:28 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:28 INFO - '_': '/tools/buildbot/bin/python'} 02:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 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)) 02:54:28 INFO - Cleaning up... 02:54:28 INFO - Return code: 0 02:54:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:28 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 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54:28 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 02:54:28 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 02:54:28 INFO - Using env: {'DISPLAY': ':0', 02:54:28 INFO - 'HOME': '/home/cltbld', 02:54:28 INFO - 'LANG': 'en_US.UTF-8', 02:54:28 INFO - 'LANGUAGE': 'en_US:en', 02:54:28 INFO - 'LOGNAME': 'cltbld', 02:54:28 INFO - 'MAIL': '/var/mail/cltbld', 02:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:28 INFO - 'MOZ_NO_REMOTE': '1', 02:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:28 INFO - 'NO_EM_RESTART': '1', 02:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:28 INFO - 'PWD': '/builds/slave/test', 02:54:28 INFO - 'SHELL': '/bin/bash', 02:54:28 INFO - 'SHLVL': '1', 02:54:28 INFO - 'TERM': 'linux', 02:54:28 INFO - 'TMOUT': '86400', 02:54:28 INFO - 'USER': 'cltbld', 02:54:28 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:28 INFO - '_': '/tools/buildbot/bin/python'} 02:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:28 INFO - Downloading/unpacking jsonschema 02:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:54:30 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 02:54:30 INFO - Downloading/unpacking functools32 (from jsonschema) 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:54:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:54:30 INFO - warning: no files found matching '*.txt' 02:54:30 INFO - no previously-included directories found matching 'build' 02:54:30 INFO - no previously-included directories found matching 'dist' 02:54:30 INFO - no previously-included directories found matching '.git*' 02:54:30 INFO - Installing collected packages: jsonschema, functools32 02:54:30 INFO - Running setup.py install for functools32 02:54:30 INFO - warning: no files found matching '*.txt' 02:54:30 INFO - no previously-included directories found matching 'build' 02:54:30 INFO - no previously-included directories found matching 'dist' 02:54:30 INFO - no previously-included directories found matching '.git*' 02:54:30 INFO - Successfully installed jsonschema functools32 02:54:30 INFO - Cleaning up... 02:54:30 INFO - Return code: 0 02:54:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54: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')]} 02:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75ab671f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', '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 02:54: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', 'flake8'] in /builds/slave/test/build 02:54: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 flake8 02:54:30 INFO - Using env: {'DISPLAY': ':0', 02:54:30 INFO - 'HOME': '/home/cltbld', 02:54:30 INFO - 'LANG': 'en_US.UTF-8', 02:54:30 INFO - 'LANGUAGE': 'en_US:en', 02:54:30 INFO - 'LOGNAME': 'cltbld', 02:54:30 INFO - 'MAIL': '/var/mail/cltbld', 02:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:30 INFO - 'MOZ_NO_REMOTE': '1', 02:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:30 INFO - 'NO_EM_RESTART': '1', 02:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:30 INFO - 'PWD': '/builds/slave/test', 02:54:30 INFO - 'SHELL': '/bin/bash', 02:54:30 INFO - 'SHLVL': '1', 02:54:30 INFO - 'TERM': 'linux', 02:54:30 INFO - 'TMOUT': '86400', 02:54:30 INFO - 'USER': 'cltbld', 02:54:30 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:30 INFO - '_': '/tools/buildbot/bin/python'} 02:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:31 INFO - Downloading/unpacking flake8 02:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:54:32 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 02:54:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:54:33 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 02:54:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:33 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 02:54:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:54:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:54:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:54:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:54:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:54:33 INFO - no previously-included directories found matching 'docs/_build' 02:54:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:54:33 INFO - Running setup.py install for pep8 02:54:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:54:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:54:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:54:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:54:33 INFO - no previously-included directories found matching 'docs/_build' 02:54:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:54:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:54:33 INFO - Cleaning up... 02:54:33 INFO - Return code: 0 02:54:33 INFO - Running post-action listener: _resource_record_post_action 02:54:33 INFO - Running post-action listener: _start_resource_monitoring 02:54:33 INFO - Starting resource monitoring. 02:54:33 INFO - ##### 02:54:33 INFO - ##### Running install step. 02:54:33 INFO - ##### 02:54:33 INFO - Running pre-action listener: _resource_record_pre_action 02:54:33 INFO - Running main action method: install 02:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:33 INFO - Reading from file tmpfile_stdout 02:54:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:54:34 INFO - Reading from file tmpfile_stdout 02:54:34 INFO - Output received: 02:54:34 INFO - Usage: mozinstall [options] installer 02:54:34 INFO - Options: 02:54:34 INFO - -h, --help show this help message and exit 02:54:34 INFO - -d DEST, --destination=DEST 02:54:34 INFO - Directory to install application into. [default: 02:54:34 INFO - "/builds/slave/test"] 02:54:34 INFO - --app=APP Application being installed. [default: firefox] 02:54:34 INFO - mkdir: /builds/slave/test/build/application 02:54:34 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'] 02:54:34 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 02:54:48 INFO - Reading from file tmpfile_stdout 02:54:48 INFO - Output received: 02:54:48 INFO - /builds/slave/test/build/application/firefox/firefox 02:54:48 INFO - Running post-action listener: _resource_record_post_action 02:54:48 INFO - ##### 02:54:48 INFO - ##### Running run-tests step. 02:54:48 INFO - ##### 02:54:48 INFO - Running pre-action listener: _resource_record_pre_action 02:54:48 INFO - Running main action method: run_tests 02:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:48 INFO - Python 2.7.3 02:54:48 INFO - Return code: 0 02:54:48 INFO - grabbing minidump binary from tooltool 02:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:48 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 0x284f0b0>, '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 0x284ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2850440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:48 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 02:54:48 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 02:54:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:48 INFO - Return code: 0 02:54:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:54:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:54:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:54:49 INFO - Return code: 0 02:54:49 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 02:54:49 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 02:54:49 INFO - Using env: {'DISPLAY': ':0', 02:54:49 INFO - 'HOME': '/home/cltbld', 02:54:49 INFO - 'LANG': 'en_US.UTF-8', 02:54:49 INFO - 'LANGUAGE': 'en_US:en', 02:54:49 INFO - 'LOGNAME': 'cltbld', 02:54:49 INFO - 'MAIL': '/var/mail/cltbld', 02:54:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:49 INFO - 'MOZ_NO_REMOTE': '1', 02:54:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:49 INFO - 'NO_EM_RESTART': '1', 02:54:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:49 INFO - 'PWD': '/builds/slave/test', 02:54:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:49 INFO - 'SHELL': '/bin/bash', 02:54:49 INFO - 'SHLVL': '1', 02:54:49 INFO - 'TERM': 'linux', 02:54:49 INFO - 'TMOUT': '86400', 02:54:49 INFO - 'USER': 'cltbld', 02:54:49 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637', 02:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:49 INFO - '_': '/tools/buildbot/bin/python'} 02:54:49 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 02:54:49 INFO - mozversion INFO | application_buildid: 20151209015042 02:54:49 INFO - mozversion INFO | application_changeset: 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb 02:54:49 INFO - mozversion INFO | application_display_name: Nightly 02:54:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:49 INFO - mozversion INFO | application_name: Firefox 02:54:49 INFO - mozversion INFO | application_remotingname: firefox 02:54:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:54:49 INFO - mozversion INFO | application_vendor: Mozilla 02:54:49 INFO - mozversion INFO | application_version: 45.0a1 02:54:49 INFO - mozversion INFO | platform_buildid: 20151209015042 02:54:49 INFO - mozversion INFO | platform_changeset: 965cfbe44aa5394498843bb8f6136ccc3dd1e0fb 02:54:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:54:49 INFO - mozversion INFO | platform_version: 45.0a1 02:54:49 INFO - 2015-12-09 02:54:49,793 DEBUG : using testdate: 1449658489 02:54:49 INFO - 2015-12-09 02:54:49,794 DEBUG : actual date: 1449658489 02:54:49 INFO - 2015-12-09 02:54:49,803 INFO : starting webserver on 'localhost:32769' 02:54:49 INFO - 2015-12-09 02:54:49,804 INFO : Starting test suite talos-linux64-ix-019 02:54:49 INFO - 2015-12-09 02:54:49,804 INFO : Starting test dromaeo_css 02:54:49 INFO - 2015-12-09 02:54:49,804 DEBUG : operating with platform_type : linux_ 02:54:49 INFO - 2015-12-09 02:54:49,805 INFO : Initialising browser for dromaeo_css test... 02:54:49 INFO - 2015-12-09 02:54:49,819 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxkEXw4/profile http://localhost:32769/getInfo.html 02:54:54 INFO - 2015-12-09 02:54:54,151 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:54:54 INFO - 2015-12-09 02:54:54,151 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:54:54 INFO - 2015-12-09 02:54:54,151 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:54:54 INFO - 2015-12-09 02:54:54,151 DEBUG : BROWSER_OUTPUT: __metrics 02:54:54 INFO - 2015-12-09 02:54:54,235 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] 02:54:54 INFO - 2015-12-09 02:54:54,303 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:55 INFO - 2015-12-09 02:54:55,489 INFO : Browser initialized. 02:54:55 INFO - 2015-12-09 02:54:55,490 INFO : Running cycle 1/1 for dromaeo_css test... 02:54:55 INFO - 2015-12-09 02:54:55,490 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxkEXw4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:55:07 INFO - 2015-12-09 02:55:07,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 143585280 02:55:07 INFO - 2015-12-09 02:55:07,499 DEBUG : BROWSER_OUTPUT: 02:55:58 INFO - 2015-12-09 02:55:58,283 DEBUG : BROWSER_OUTPUT: 1449658558278 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] 02:58:11 INFO - 2015-12-09 02:58:11,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32769/tests/dromaeo/cssquery-ext.html) 02:58:12 INFO - 2015-12-09 02:58:12,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 238243840 02:58:12 INFO - 2015-12-09 02:58:12,703 DEBUG : BROWSER_OUTPUT: 03:01:15 INFO - 2015-12-09 03:01:15,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/dromaeo/cssquery-ext.html (next: http://localhost:32769/tests/dromaeo/cssquery-jquery.html) 03:01:15 INFO - 2015-12-09 03:01:15,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 218460160 03:01:15 INFO - 2015-12-09 03:01:15,766 DEBUG : BROWSER_OUTPUT: 03:04:17 INFO - 2015-12-09 03:04:17,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32769/tests/dromaeo/cssquery-mootools.html) 03:04:18 INFO - 2015-12-09 03:04:18,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 215863296 03:04:18 INFO - 2015-12-09 03:04:18,344 DEBUG : BROWSER_OUTPUT: 03:07:20 INFO - 2015-12-09 03:07:20,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32769/tests/dromaeo/cssquery-prototype.html) 03:07:20 INFO - 2015-12-09 03:07:20,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 200331264 03:07:20 INFO - 2015-12-09 03:07:20,825 DEBUG : BROWSER_OUTPUT: 03:10:23 INFO - 2015-12-09 03:10:23,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32769/tests/dromaeo/cssquery-yui.html) 03:10:24 INFO - 2015-12-09 03:10:24,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 204963840 03:10:24 INFO - 2015-12-09 03:10:24,107 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/dromaeo/cssquery-yui.html (next: http://localhost:32769/tests/dromaeo/cssquery-dojo.html) 03:13:26 INFO - 2015-12-09 03:13:26,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 332886016 03:13:26 INFO - 2015-12-09 03:13:26,779 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,780 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:13:26 INFO - 2015-12-09 03:13:26,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:13:26 INFO - 2015-12-09 03:13:26,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:13:26 INFO - 2015-12-09 03:13:26,780 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:13:26 INFO - 2015-12-09 03:13:26,781 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.2624065261725;2731.6175735397037;2734.220747087081;2739.821911575746;2761.6271803306554;4381.101874115807;4523.4797998230215;4666.78999445025;4717.056588682264;4738.526147385264;4579.610733087691;4621.838235661752;4624.445066592005;4727.810887564493;4760.714357138574;4280.443542339492;4307.160103779756;4328.696991210617;4337.219300525904;4353.62994145498;4396.1427521633295;4420.31485119807;4453.755043472608;4454.599086082252;4477.641788656916;4081.1837632473625;4204.26425375558;4306.892327691801;4394.8242070317465;4406.537313582092;4348.956510434887;4350.934735978963;4353.151135528573;4391.429114215131;4393.670474714378;4076.9388459173138;4331.826726930919;4336.479622445295;4343.109662519208;4381.671374646882;4538.88652783683;4552.483762508583;4574.748388838612;4677.74272415017;4681.976590117028;5025.748712564357;5055.064813009568;5069.239614057884;5092.465291144451;5111.718855462948;5085.669431486978;5089;5090.058339207221;5092.3125378073855;5141.126008578551;4532.388127602798;4650.674452788272;4659.767011649404;4675.929861052087;4784.593309568726;5193.428722840485;5211.843644690665;5239.476052394806;5250.894982100413;5254.159334506537;4961.355023846877;4968.8757781055765;4974.328465657162;4975.477574854661;4985.227289770091;4782.880427989328;4915.606751459874;5050.84847454577;5059.645824792303;5104.259882317043;4847;4880.463149053601;5001.224810154432;5016.749162541858;5020.799168033311;4967.205247160509;4980.402351717817;5007.098722229961;5008.824691135793;5071.644984851025;4224.260754367973;4259.38238955356;4266.87199384019;4267.850625228102;4301.763403012802;3493.8078405687424;3588.0312315674623;3619.2580520993133;3637.654422829827;3688.2623475305045;4322.113966636832;4342.044750154961;4345.847895323648;4348.630366418826;4387.583179597933;5077.26379674945;5079.517445842639;5088.898222035538;5089.05852417304;5131.974340128276;4072.75563466193;4178;4185.183889141649;4232.534421213664;4351.782410879443;4522.5929666330185;4535.070310586322;4537.977310113494;4553.863384098482;4591.816327346869;4843.346148270009;4847.079054979543;4851.80592776285;4856.538628830255;4894.119058569349;4815.061063092803;4912.459629440687;4949.950500494949;4966.751662416792;5121.334226550524;4807.759612019315;4829.782659780389;4832.226843704991;4835.298881662069;4878.365812444359;5024.346834911438;5026;5027.271045698426;5030.8239211627415;5043.747812609428;4771.904561908673;4910.656254062182;4913.729744864067;4972.825951091694;5134.820281290137;4891.486393928586;4901.411830580353;4903.509649035211;4904.032049110119;4907.116718990616;4879.512048795092;4879.975600121977;4887.902241955212;4925.064237794808;4931.950680493293;4509.481409637933;4670.64970127235;4688.156131896291;4688.3436318916065;4815.398075240595;4942.629302802232;4947.282644016669;4982.352294201875;4991.026749783758;5021.598272138147;4834.371531700856;4835.782389792397;4840.201366774443;4840.661153719347;4881.974785294986 03:13:26 INFO - 2015-12-09 03:13:26,782 DEBUG : BROWSER_OUTPUT: |1;ext.html;524.8322482476489;537.1942086869697;540.3515781062725;568.6531215958265;573.2576313673794;26252.212433627;34390.14024649385;35169;35200.82399588005;35243.11892202696;38656.806715966384;39272.60727392725;39280.80359598198;39308.60691393085;39352.803235983854;6944.305569443066;7052.04797352356;7060.223375428699;7910.999999999985;8062.475939063971;10126.696199114038;10332.173426125892;10367.222458315618;10392.376457412542;10404.063634272914;10129.645462408816;10164.796704065915;10254.692359229235;10259.127974122208;10288.074073333399;7231.204567497571;7436.73971410998;10096.949515252414;10188;10475.79048419035;9997.300188986774;10151.390916545031;10153.89846101537;10157.847632285522;10163;35853.82073089644;36481.81759091214;36482.63517364819;36509.26981460356;36571.08572285688;2671.4389978104623;2712.9321766955786;2933.3839893622367;3225.5000474926187;3558.057114864563;27606.585901211496;27836.582451263246;27871.34310663466;28169.29576760577;28633;3463.9826800866085;3482.233908540117;3504.737144714157;3583.7849729016343;3589.300086483137;209463;211110;212099;212748;213438;51262.48737512652;52523;54877.72561137169;55174.17238741422;55290;58607;59946.70026649839;60086;60196.097058544154;60239;13351.198928064347;13719.176849389069;13731.382087806072;13732.382042808098;13734.65663358404;8946.86579701305;8955.05971872957;8988.191062804379;8996.100389961082;9049.954750226338;18967;18971.905140474486;19215;19216.61566768657;19321.51696207606;6907.689153988083;7114.359707626339;7159.3914517265575;7176.354128128493;7195.856082878313;829.2868133405267;907.8592818113203;908.8909330880336;911.2618778789202;921.1939552891221;24150;24962.875185623954;25034.499310013696;25038;25069.4986100277;879.8900137482815;924.2051835421532;932.8507438809894;938.9295802814817;1002.2082554781641;13008.54470093561;13018.804717929239;13073.477060917457;13173.27546984925;13198.340082995812;253028;256531;256751;256764;258021;45319.32021019687;45333.54666453359;45494.77252613782;45602;45686.314705279445;1132.371533798733;1171.0280467212194;1172.8299396587618;1181.509673485511;1186.0985650905202;23516.412089697893;26844.194674159808;28822.567661485515;29228.70771292345;29284.267893302836;40284.59715402926;40425.39361909515;40707;40809;40912.386314205905;195275;195988;196524.05213921517;196638;197361;24391.756082439657;25169.748302516742;28240.152795416172;28558.714412856436;29163.41673166567;33092.669073309924;33321;33350.49974250437;33492.49761253534;33880.15299617529;28666.85666571654;29089.41821163607;29194.41611167807;29439;29521;24386;29235.85382073076;29312.41375172527;29504.409911801213;33251.50122748112;29279.268018299714;29523;29566.113016609535;29609.25976850596;32560;25014.11321546529;25576.23271301864;28870.278243044093;28928.276793080342;28996.565051523823;21223.151073957488;21397.46506337354;21408;21496.140154393648;21531.892340538197 03:13:26 INFO - 2015-12-09 03:13:26,786 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.2375966093244;278.77280016786307;279.594587847621;280.67441767549644;287.46244522742467;11079.446027698603;15606.517380848816;16197.02817830931;16201.83798162018;16252.593685157877;9427.434353938768;9710.12608865202;9742.659006934759;15654.921725391385;16069.91965040176;4477.059817438342;4584.633229341644;4585.312203169535;4585.403897493321;4589;4529.275315949449;4543;4546.499885012646;4554.977225113887;4562.589366956973;3367.377035248475;3475.704565111956;4535.954640453603;4536.364908912755;5112.616553758465;5193.169092945111;5230.476952304777;5233.136532472156;5242.501962313593;5245.711485868275;4874.926876096862;4960.107180707471;4965.428975667808;5044.949550504484;5047.192449208109;10883.401412922287;10961.397123158224;11000.614978475794;11058.11535077192;17955.3715619954;1770.3803668715975;1791.8208179182109;1800.639872025587;1801.5766294920684;1817.37300631282;8573.828523429496;8574.399792014561;11169.715482719428;12906.419211135428;13346.19922804635;1715.7389318850635;1799.5473714644647;1807.7830660320715;1842.6683197024531;1879.432799869149;49335.50664493345;51880.99999999962;56719.71640141773;64380.356196437904;65970.34029659738;15610.29753661088;15614.843851561565;15693.21533923322;15705;15708.450204243025;23092.884535577214;23236;23253.60478371303;23254.883725581603;23287.883560582428;7995.880061799077;8516.489010659381;8648.308135349156;8661.22049015579;8694.956525217334;7205.531640443354;7252.891206631904;7291.598962057032;7292.0520332356455;7299.781006569811;7740.6129693515095;7748.380129589619;7776.572288524072;7807.80480487981;7825.882611760828;1704.880658353928;1722.3196837249468;2185.2570126157184;2941.2205765472168;3058.342456371891;769.4229328003997;774.4733581164862;834.4200780457523;845.678642115992;962.4417837654144;14171.149731015967;15168.696626067638;15292.311845966959;16598.336066557444;16599.50201493957;790.5651891459675;797.9162187970296;805.9758207253792;819.5451524404014;849.3544905871582;9212.815743685089;9273.953630231941;9344.626214951326;9523;9566.091221333962;300159;305630;430015;434536;456404;70695;74140;75104.24895750973;75945.62027189828;76175.61912190403;1002.4686915934566;1010.9848352274722;1011.4740335025892;1032.9896701032894;1033.56073668692;14067;14763;14900.701985960004;14923.925380373028;14941.925290373478;31726.841365793025;31838;33804.83097584496;34863.65136348604;36595.81702091579;42058.78970605128;43523.78238108789;43767.78116109399;44112.11775764531;45012.77493612642;8179.67281308741;8644;8668.176523230282;8697.782555436164;8701.738947831574;15336.923315383352;15478.303476343366;15580.376784928929;16175.352985880432;16704.832951670327;13663;13672.179669219879;13714.65713357174;13771.380287886868;13932.164070155823;12925.030622703523;13287.933560332136;13300.733985320432;13717.382717777924;14346.49787257441;13673.17960922308;13742.725145497234;13777.793333100211;14134.858651413766;14170.787438188228;8843.823123537364;8901.154390332907;8901.33240007015;8924.509151996703;8938.776530586787;9906.702798916043;13355.332233388486;13617.25105119228;13913.165210087021;14363.56909292723 03:13:26 INFO - 2015-12-09 03:13:26,786 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1373.4712135827715;1594.0913679202854;1666.2252052795448;1699.7025520533907;1702.1234064456798;5823.980803359411;6128.908066379008;6605.966970165143;6786.321367863211;6803.455723542117;6643.933560664392;6663.133792606966;6721.3278672132765;6723.294054124308;6726.125603671528;2029.2593203480733;2071.420002399323;2074.087401543316;2075.7094006839056;2077.927272545461;2087.269455690511;2098.192196004534;2104.9052792624293;2125.7449106107288;2137.6152292587326;1994.411648563677;2036.0023588441704;2060.6084843879617;2063.4222417722985;2063.8555301128927;2079.313826437272;2117.385958072165;2118.671605901088;2122.3632910127053;2123.532822778986;2037.663785475395;2071.979280207194;2074.346580827035;2078.9480262993393;2079.054030416157;6902.137232845895;6943.583384996866;6956.060931774196;6960.965195173992;6979.581225126509;4082.7346222495444;4117.07365842686;4122.969257685579;4128.525219599755;4143.81352839123;2593;2598.3244356467267;2613.9869300653563;2724.1146627345993;2727.4954133485367;771.6758961236294;777.9066512018537;819.7540737778643;821.7781199076276;1678.4628918746007;8950.597223124974;9087.954560227223;9092.727218183465;9107.590158442887;9111.27109831212;3688.0964163780045;3728.440733889938;3787.772733635991;3788.8295026723863;3802.5627052888717;8190.140035296208;8191.221833925768;8200.958995204986;8202.630881610341;8206.712765053195;4204.936925946114;4210.726302790309;4223.450951376301;4226.957730422657;4230.365445183247;3176.4917613182242;3259.5762550868235;3266.8856590019236;3816.3512202925567;3820;3152.5271209318785;3333.583302087239;3355.0773537276955;3360;3389.983050084734;1035.4253389368973;1076.8438576406377;1084.7938891610568;1085.4301491716913;1090.334895713614;816.0452270843009;826.3678286111129;827.6813426830594;906.5739102621757;1076.7900259449332;6470.514711396664;6551.574147680385;6566.474682025427;6567.934320656828;6567.9671601641685;524.5357858295436;533.4691981478454;535.3789604059273;539.2235181338859;698.2319448606493;5073.923891141562;5178.456262092502;5205.27126202332;5217.243499692523;5235.1623740201385;7774.455788094892;7891.644875980594;8057.113717491071;8190.959045204736;8206.425550211547;8400.033996090406;8411.663533458594;8508.489490630582;8564.52895090776;8566.100559441293;6569.277379488252;6614.305497922649;6736.427403670645;6743.763968261087;6761.256261811197;6616.470682345497;6651.567648102858;6671.066050752802;6671.366220209073;6676.265610782712;7021.262767409553;7288.854222915618;7420.851582968418;7431.739889104072;7695.2304769524835;7444.776656700307;7477.401807855467;7819.609019548886;7829.647665855164;7944.721934732257;4920.507949205051;5802.419758024333;5913.231279933581;5978.671173085522;5988.461038506555;5937.406259374028;6325.525585581192;6348.301686814354;6354.332795056453;6357.332480089524;6127.632342059491;6135.478484328882;6197.81406557804;6201.968990155201;6280.591761535486;6176.413240742122;6205.937940620536;6244.781432650017;6247.156633854372;6341.080543321101;6211.09939058843;6304.65324407162;6313.337099604475;6322.873542529215;6342;5831.504322132497;5912.408759124053;5916.970415147896;5938.910916336172;5944.286685597756;5506.339239291311;5682.801101961411;5717.514011309086;5763.366029736641;5772.884542309214 03:13:26 INFO - 2015-12-09 03:13:26,787 DEBUG : BROWSER_OUTPUT: |4;prototype.html;257.18087890070126;258.62112005911337;261.5684121200021;262.82128152856063;263.58748558505937;5160.432352441228;5227.424983251844;5229.947700522994;5235.8691032724155;5255.395629502608;4965.106280869442;5114.462981386957;5122.61580381472;5153.793848246066;5241.161414173733;4015.855481187862;4020.8793736187963;4028.476298081245;4030.052937559671;4043.8584649537274;3819.4461803038544;4030.6170913763144;4031.2340655275552;4034.919301613966;4044.5753195914444;3898.66861316787;3905.6680182184405;4015.799210039501;4018.7387819791766;4020.2361551305157;3999.5000624921886;4004.559498455182;4007.939880901789;4014.136960553495;4015.2371049500503;3472.149323415754;3472.8958131256104;3474.409350410436;3476.5132881396626;3477.165480284739;5069.518395752434;5071.746412679351;5073.492650734934;5075.162598171298;5082.161443361841;4505.932411013838;4587.885302867422;4591.517890621503;4591.9081618367445;4615.2384856498975;5517.503424691757;5522.392536820947;5526.115821468546;5530.059889818741;5535.972320138373;3756.7370284080125;3757.774533527997;3760.492333534965;3761.247750449921;3771.208046310278;5815.767369305223;5821.446962538552;5823;5823.301203855522;5825.79609713658;3776.055986003499;3861.015441062511;3866.38137897935;3870.7677539347164;3874.651281384689;3921.2941670499013;3922.725409221327;3924.17592305619;3924.3328634132267;3927.4108883667677;4556.794944227518;4559.247724125548;4563.041761230113;4563.06457176278;4564.7717614119165;5534.1145416733125;5535.640183388147;5537.307836520435;5537.640053396516;5547.417521160301;1353.810466534686;1359.3543067043076;1387.0429403711407;1388.271157642246;1390.360434200259;910.349100393222;918.3755046568398;918.93108016899;921.8110287391069;923.9353245272766;4856.660033797601;4857.9028419431415;4863.70817750929;4865.7323847188745;4871.14754917888;5737.799177028867;5743.741531631086;5751.712414379348;5754.0505816540635;5755;4680.438347398266;4763.833265835679;4783.115123702126;4850.80596776125;4861.708297502161;3062.617172853393;3089.351236240415;3098.9535156972665;3099.9535006974916;3104.1463597510415;5492.368377636543;5506.311711036121;5514.310711161105;5516.972415137899;5517.834464966058;5980.820575382745;5981.551383646157;5985.16207730918;5988.161657367972;5989.131575921467;5350.143976963667;5517.2275881377445;5519.613627046068;5523.6685798852195;5527.44725527444;5776.884462310814;5816.302043754777;5822.650640961556;5823.097419899922;5832.737526811219;5677.1768093627015;5686.71566421669;5689.089745640677;5694.117411801178;5701.030824759718;5303.204519322133;5497.5601951842955;5501.284832971688;5514.80698175562;5516.724163791875;3739.046543131593;3745.2322273934324;3762.9811850941664;3771.4908487354955;3779.7165212608616;5776.191333213437;5794.188813566188;5824.242848429677;5827.24245848037;5829.59192856513;5574.386817450159;5593.272874526286;5596.972015140062;5605.271314729059;5614.101743720985;5423.972880135574;5580.079286917613;5584.664920104807;5584.692841893735;5587.664740115606;5464.28964234647;5481.780728770805;5484.848181881849;5486.835394938158;5486.957478079312;5627.718614069362;5634.126710359901;5635.549156067586;5638.520725738194;5641.069223578063;5365.839024829105;5466.453354664502;5490.121580547093;5490.560755139659;5498.367687715964 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: |5;yui.html;762.7482930632893;767.4666107055596;781.5193655901619;797.8364435290763;826.8677011678133;13807.102538335013;14029.36867840947;14040.29798510073;14060.437582496701;14090.859091409084;13199.472021119143;13253.204807711543;13278.535251266208;13291.069625126245;13297.93351033246;622.1259130921063;629.072118625029;790.3084800799286;799.1209669363711;799.4963173200875;787.2403130978604;794.7417089445925;804.903411590607;805.8952336196315;805.9194080591923;823.27551754456;827.7061643116697;834.090840983328;834.7245409015011;835.1481488881337;644.1625886347753;649.8505343770936;818.893543839303;821.4701517521195;832.704389941568;612.231649280155;612.7334609444861;614.5145335185198;614.6588643302965;614.695725615823;12353.382330883509;12359.876401236052;12401.317927513983;12425.937870310681;12430.316332601704;10143.442110683909;11083.667489975314;11181.273217240934;11440.885591144066;11611.941940290244;8648.351373647001;9203.217726493256;9220.538973051387;9276.72169834906;9412.341136120474;3158.242021914747;3164.4620414529354;3181.18879685681;3206.2625596112794;3230.709236168756;38032.42951355732;38400.807995960124;38447.99999999972;38469;39155;8561.357898157663;8738.344624153087;9018.278537716968;9146.451212927113;9208.861867071999;15851.286692098884;15935.282912268976;15995.200239987955;16024.75962860558;16090.597735056717;6285.717142728588;6472.741090356427;6474.935250647527;6560.639164845979;6639.3692599203;3563.893083207508;3597.8021208833243;3630.2013557017412;3654.798986055739;3672.981635091807;2629.81591288608;2664;2673.492036513095;2675.6922953860167;2677.8928842846067;465.67868170962606;470.3767508051845;472.56287933661224;473.6258355898801;478.5692876411188;486.8807142250101;571.6227289988587;583.1107560969556;585.9209006784115;603.7283222549783;6845;6875.106236189264;6982.197047339621;7047.859042819115;7153.3919616833155;440.4208465867374;463.3952691737248;500.2546206152806;504.5761560289375;555.416812347034;3491.4762785581856;3609.7653652512504;3627.183883626163;3687.7602955808325;3708.9072773180346;45331.77334113374;45768.77115614401;46020.539794601624;46060.3090953636;46161.76919115383;40559.39160912589;41374.37938430926;41754.582454175674;42217.36673949893;42376.15247695029;34578.51635362537;37289.62710372916;38247.661331853255;38286.42570361447;38472.8076359622;7289.234630363735;7416.184219735716;7417.8887316689215;7443.627818608939;7738.845223095619;28852.567211492264;29054.418911621226;29223.415531689672;29395.265118372212;29832.10503684806;34037.48943765796;34432.82783586166;34854.78008269698;37477.2504549902;37794;8983.505907175168;9467.573959171992;9577;9601.615935362786;9786;10838.837417438903;10883.782324353628;10922.180836437457;10979.451027448755;10998.175136864927;9883.752906177404;10062;10107.848382274418;10283.537240824031;10294.742631434274;9582.952085239807;9783.119519243302;9905.653302134391;9941.900580994097;9956.502174891371;7855.198433544972;9466.668666596635;9783.706488805346;9829.950850245703;9973.850392243978;8508.91491085106;8746.125387461458;8824.955875220583;8861.64553417856;8911.2425443838;7163.212046674966;8009.959950200212;8315.402235024718;8487.490750554987;8752.387332886638 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,940 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: __startTimestamp1449659606778__endTimestamp 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,789 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:13:26 INFO - 2015-12-09 03:13:26,790 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:13:26 INFO - 2015-12-09 03:13:26,790 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,790 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4644.17 Median:4815.06 stddev:491.34 (10.2%) stddev-sans-first:466.86 03:13:26 INFO - 2015-12-09 03:13:26,790 DEBUG : BROWSER_OUTPUT: Values: 2634.3 2731.6 2734.2 2739.8 2761.6 4381.1 4523.5 4666.8 4717.1 4738.5 4579.6 4621.8 4624.4 4727.8 4760.7 4280.4 4307.2 4328.7 4337.2 4353.6 4396.1 4420.3 4453.8 4454.6 4477.6 4081.2 4204.3 4306.9 4394.8 4406.5 4349.0 4350.9 4353.2 4391.4 4393.7 4076.9 4331.8 4336.5 4343.1 4381.7 4538.9 4552.5 4574.7 4677.7 4682.0 5025.7 5055.1 5069.2 5092.5 5111.7 5085.7 5089.0 5090.1 5092.3 5141.1 4532.4 4650.7 4659.8 4675.9 4784.6 5193.4 5211.8 5239.5 5250.9 5254.2 4961.4 4968.9 4974.3 4975.5 4985.2 4782.9 4915.6 5050.8 5059.6 5104.3 4847.0 4880.5 5001.2 5016.7 5020.8 4967.2 4980.4 5007.1 5008.8 5071.6 4224.3 4259.4 4266.9 4267.9 4301.8 3493.8 3588.0 3619.3 3637.7 3688.3 4322.1 4342.0 4345.8 4348.6 4387.6 5077.3 5079.5 5088.9 5089.1 5132.0 4072.8 4178.0 4185.2 4232.5 4351.8 4522.6 4535.1 4538.0 4553.9 4591.8 4843.3 4847.1 4851.8 4856.5 4894.1 4815.1 4912.5 4950.0 4966.8 5121.3 4807.8 4829.8 4832.2 4835.3 4878.4 5024.3 5026.0 5027.3 5030.8 5043.7 4771.9 4910.7 4913.7 4972.8 5134.8 4891.5 4901.4 4903.5 4904.0 4907.1 4879.5 4880.0 4887.9 4925.1 4932.0 4509.5 4670.6 4688.2 4688.3 4815.4 4942.6 4947.3 4982.4 4991.0 5021.6 4834.4 4835.8 4840.2 4840.7 4882.0 03:13:26 INFO - 2015-12-09 03:13:26,790 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,791 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38066.91 Median:29281.77 stddev:57957.06 (197.9%) stddev-sans-first:58051.09 03:13:26 INFO - 2015-12-09 03:13:26,791 DEBUG : BROWSER_OUTPUT: Values: 524.8 537.2 540.4 568.7 573.3 26252.2 34390.1 35169.0 35200.8 35243.1 38656.8 39272.6 39280.8 39308.6 39352.8 6944.3 7052.0 7060.2 7911.0 8062.5 10126.7 10332.2 10367.2 10392.4 10404.1 10129.6 10164.8 10254.7 10259.1 10288.1 7231.2 7436.7 10096.9 10188.0 10475.8 9997.3 10151.4 10153.9 10157.8 10163.0 35853.8 36481.8 36482.6 36509.3 36571.1 2671.4 2712.9 2933.4 3225.5 3558.1 27606.6 27836.6 27871.3 28169.3 28633.0 3464.0 3482.2 3504.7 3583.8 3589.3 209463.0 211110.0 212099.0 212748.0 213438.0 51262.5 52523.0 54877.7 55174.2 55290.0 58607.0 59946.7 60086.0 60196.1 60239.0 13351.2 13719.2 13731.4 13732.4 13734.7 8946.9 8955.1 8988.2 8996.1 9050.0 18967.0 18971.9 19215.0 19216.6 19321.5 6907.7 7114.4 7159.4 7176.4 7195.9 829.3 907.9 908.9 911.3 921.2 24150.0 24962.9 25034.5 25038.0 25069.5 879.9 924.2 932.9 938.9 1002.2 13008.5 13018.8 13073.5 13173.3 13198.3 253028.0 256531.0 256751.0 256764.0 258021.0 45319.3 45333.5 45494.8 45602.0 45686.3 1132.4 1171.0 1172.8 1181.5 1186.1 23516.4 26844.2 28822.6 29228.7 29284.3 40284.6 40425.4 40707.0 40809.0 40912.4 195275.0 195988.0 196524.1 196638.0 197361.0 24391.8 25169.7 28240.2 28558.7 29163.4 33092.7 33321.0 33350.5 33492.5 33880.2 28666.9 29089.4 29194.4 29439.0 29521.0 24386.0 29235.9 29312.4 29504.4 33251.5 29279.3 29523.0 29566.1 29609.3 32560.0 25014.1 25576.2 28870.3 28928.3 28996.6 21223.2 21397.5 21408.0 21496.1 21531.9 03:13:26 INFO - 2015-12-09 03:13:26,791 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,791 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24094.45 Median:19169.68 stddev:64216.56 (335.0%) stddev-sans-first:64371.80 03:13:26 INFO - 2015-12-09 03:13:26,792 DEBUG : BROWSER_OUTPUT: Values: 277.2 278.8 279.6 280.7 287.5 11079.4 15606.5 16197.0 16201.8 16252.6 9427.4 9710.1 9742.7 15654.9 16069.9 4477.1 4584.6 4585.3 4585.4 4589.0 4529.3 4543.0 4546.5 4555.0 4562.6 3367.4 3475.7 4536.0 4536.4 5112.6 5193.2 5230.5 5233.1 5242.5 5245.7 4874.9 4960.1 4965.4 5044.9 5047.2 10883.4 10961.4 11000.6 11058.1 17955.4 1770.4 1791.8 1800.6 1801.6 1817.4 8573.8 8574.4 11169.7 12906.4 13346.2 1715.7 1799.5 1807.8 1842.7 1879.4 49335.5 51881.0 56719.7 64380.4 65970.3 15610.3 15614.8 15693.2 15705.0 15708.5 23092.9 23236.0 23253.6 23254.9 23287.9 7995.9 8516.5 8648.3 8661.2 8695.0 7205.5 7252.9 7291.6 7292.1 7299.8 7740.6 7748.4 7776.6 7807.8 7825.9 1704.9 1722.3 2185.3 2941.2 3058.3 769.4 774.5 834.4 845.7 962.4 14171.1 15168.7 15292.3 16598.3 16599.5 790.6 797.9 806.0 819.5 849.4 9212.8 9274.0 9344.6 9523.0 9566.1 300159.0 305630.0 430015.0 434536.0 456404.0 70695.0 74140.0 75104.2 75945.6 76175.6 1002.5 1011.0 1011.5 1033.0 1033.6 14067.0 14763.0 14900.7 14923.9 14941.9 31726.8 31838.0 33804.8 34863.7 36595.8 42058.8 43523.8 43767.8 44112.1 45012.8 8179.7 8644.0 8668.2 8697.8 8701.7 15336.9 15478.3 15580.4 16175.4 16704.8 13663.0 13672.2 13714.7 13771.4 13932.2 12925.0 13287.9 13300.7 13717.4 14346.5 13673.2 13742.7 13777.8 14134.9 14170.8 8843.8 8901.2 8901.3 8924.5 8938.8 9906.7 13355.3 13617.3 13913.2 14363.6 03:13:26 INFO - 2015-12-09 03:13:26,792 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,792 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4815.61 Median:5961.48 stddev:2486.23 (41.7%) stddev-sans-first:2479.74 03:13:26 INFO - 2015-12-09 03:13:26,793 DEBUG : BROWSER_OUTPUT: Values: 1373.5 1594.1 1666.2 1699.7 1702.1 5824.0 6128.9 6606.0 6786.3 6803.5 6643.9 6663.1 6721.3 6723.3 6726.1 2029.3 2071.4 2074.1 2075.7 2077.9 2087.3 2098.2 2104.9 2125.7 2137.6 1994.4 2036.0 2060.6 2063.4 2063.9 2079.3 2117.4 2118.7 2122.4 2123.5 2037.7 2072.0 2074.3 2078.9 2079.1 6902.1 6943.6 6956.1 6961.0 6979.6 4082.7 4117.1 4123.0 4128.5 4143.8 2593.0 2598.3 2614.0 2724.1 2727.5 771.7 777.9 819.8 821.8 1678.5 8950.6 9088.0 9092.7 9107.6 9111.3 3688.1 3728.4 3787.8 3788.8 3802.6 8190.1 8191.2 8201.0 8202.6 8206.7 4204.9 4210.7 4223.5 4227.0 4230.4 3176.5 3259.6 3266.9 3816.4 3820.0 3152.5 3333.6 3355.1 3360.0 3390.0 1035.4 1076.8 1084.8 1085.4 1090.3 816.0 826.4 827.7 906.6 1076.8 6470.5 6551.6 6566.5 6567.9 6568.0 524.5 533.5 535.4 539.2 698.2 5073.9 5178.5 5205.3 5217.2 5235.2 7774.5 7891.6 8057.1 8191.0 8206.4 8400.0 8411.7 8508.5 8564.5 8566.1 6569.3 6614.3 6736.4 6743.8 6761.3 6616.5 6651.6 6671.1 6671.4 6676.3 7021.3 7288.9 7420.9 7431.7 7695.2 7444.8 7477.4 7819.6 7829.6 7944.7 4920.5 5802.4 5913.2 5978.7 5988.5 5937.4 6325.5 6348.3 6354.3 6357.3 6127.6 6135.5 6197.8 6202.0 6280.6 6176.4 6205.9 6244.8 6247.2 6341.1 6211.1 6304.7 6313.3 6322.9 6342.0 5831.5 5912.4 5917.0 5938.9 5944.3 5506.3 5682.8 5717.5 5763.4 5772.9 03:13:26 INFO - 2015-12-09 03:13:26,793 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,793 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4576.34 Median:5228.69 stddev:1384.87 (26.5%) stddev-sans-first:1350.28 03:13:26 INFO - 2015-12-09 03:13:26,793 DEBUG : BROWSER_OUTPUT: Values: 257.2 258.6 261.6 262.8 263.6 5160.4 5227.4 5229.9 5235.9 5255.4 4965.1 5114.5 5122.6 5153.8 5241.2 4015.9 4020.9 4028.5 4030.1 4043.9 3819.4 4030.6 4031.2 4034.9 4044.6 3898.7 3905.7 4015.8 4018.7 4020.2 3999.5 4004.6 4007.9 4014.1 4015.2 3472.1 3472.9 3474.4 3476.5 3477.2 5069.5 5071.7 5073.5 5075.2 5082.2 4505.9 4587.9 4591.5 4591.9 4615.2 5517.5 5522.4 5526.1 5530.1 5536.0 3756.7 3757.8 3760.5 3761.2 3771.2 5815.8 5821.4 5823.0 5823.3 5825.8 3776.1 3861.0 3866.4 3870.8 3874.7 3921.3 3922.7 3924.2 3924.3 3927.4 4556.8 4559.2 4563.0 4563.1 4564.8 5534.1 5535.6 5537.3 5537.6 5547.4 1353.8 1359.4 1387.0 1388.3 1390.4 910.3 918.4 918.9 921.8 923.9 4856.7 4857.9 4863.7 4865.7 4871.1 5737.8 5743.7 5751.7 5754.1 5755.0 4680.4 4763.8 4783.1 4850.8 4861.7 3062.6 3089.4 3099.0 3100.0 3104.1 5492.4 5506.3 5514.3 5517.0 5517.8 5980.8 5981.6 5985.2 5988.2 5989.1 5350.1 5517.2 5519.6 5523.7 5527.4 5776.9 5816.3 5822.7 5823.1 5832.7 5677.2 5686.7 5689.1 5694.1 5701.0 5303.2 5497.6 5501.3 5514.8 5516.7 3739.0 3745.2 3763.0 3771.5 3779.7 5776.2 5794.2 5824.2 5827.2 5829.6 5574.4 5593.3 5597.0 5605.3 5614.1 5424.0 5580.1 5584.7 5584.7 5587.7 5464.3 5481.8 5484.8 5486.8 5487.0 5627.7 5634.1 5635.5 5638.5 5641.1 5365.8 5466.5 5490.1 5490.6 5498.4 03:13:26 INFO - 2015-12-09 03:13:26,793 DEBUG : BROWSER_OUTPUT: 03:13:26 INFO - 2015-12-09 03:13:26,793 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11665.41 Median:482.73 stddev:12794.92 (2650.6%) stddev-sans-first:12804.61 03:13:26 INFO - 2015-12-09 03:13:26,794 DEBUG : BROWSER_OUTPUT: Values: 762.7 767.5 781.5 797.8 826.9 13807.1 14029.4 14040.3 14060.4 14090.9 13199.5 13253.2 13278.5 13291.1 13297.9 622.1 629.1 790.3 799.1 799.5 787.2 794.7 804.9 805.9 805.9 823.3 827.7 834.1 834.7 835.1 644.2 649.9 818.9 821.5 832.7 612.2 612.7 614.5 614.7 614.7 12353.4 12359.9 12401.3 12425.9 12430.3 10143.4 11083.7 11181.3 11440.9 11611.9 8648.4 9203.2 9220.5 9276.7 9412.3 3158.2 3164.5 3181.2 3206.3 3230.7 38032.4 38400.8 38448.0 38469.0 39155.0 8561.4 8738.3 9018.3 9146.5 9208.9 15851.3 15935.3 15995.2 16024.8 16090.6 6285.7 6472.7 6474.9 6560.6 6639.4 3563.9 3597.8 3630.2 3654.8 3673.0 2629.8 2664.0 2673.5 2675.7 2677.9 465.7 470.4 472.6 473.6 478.6 486.9 571.6 583.1 585.9 603.7 6845.0 6875.1 6982.2 7047.9 7153.4 440.4 463.4 500.3 504.6 555.4 3491.5 3609.8 3627.2 3687.8 3708.9 45331.8 45768.8 46020.5 46060.3 46161.8 40559.4 41374.4 41754.6 42217.4 42376.2 34578.5 37289.6 38247.7 38286.4 38472.8 7289.2 7416.2 7417.9 7443.6 7738.8 28852.6 29054.4 29223.4 29395.3 29832.1 34037.5 34432.8 34854.8 37477.3 37794.0 8983.5 9467.6 9577.0 9601.6 9786.0 10838.8 10883.8 10922.2 10979.5 10998.2 9883.8 10062.0 10107.8 10283.5 10294.7 9583.0 9783.1 9905.7 9941.9 9956.5 7855.2 9466.7 9783.7 9830.0 9973.9 8508.9 8746.1 8825.0 8861.6 8911.2 7163.2 8010.0 8315.4 8487.5 8752.4 03:13:26 INFO - 2015-12-09 03:13:26,794 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:13:26 INFO - 2015-12-09 03:13:26,794 DEBUG : BROWSER_OUTPUT: 03:13:27 INFO - 2015-12-09 03:13:27,597 INFO : Browser exited with error code: 0 03:13:27 INFO - 2015-12-09 03:13:27,614 INFO : Completed test dromaeo_css (00:18:37) 03:13:27 INFO - 2015-12-09 03:13:27,614 INFO : Starting test kraken 03:13:27 INFO - 2015-12-09 03:13:27,614 DEBUG : operating with platform_type : linux_ 03:13:27 INFO - 2015-12-09 03:13:27,614 INFO : Initialising browser for kraken test... 03:13:27 INFO - 2015-12-09 03:13:27,620 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTBK9lf/profile http://localhost:32769/getInfo.html 03:13:32 INFO - 2015-12-09 03:13:32,180 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:13:32 INFO - 2015-12-09 03:13:32,180 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:13:32 INFO - 2015-12-09 03:13:32,180 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:13:32 INFO - 2015-12-09 03:13:32,180 DEBUG : BROWSER_OUTPUT: __metrics 03:13:32 INFO - 2015-12-09 03:13:32,265 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] 03:13:32 INFO - 2015-12-09 03:13:32,341 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:13:33 INFO - 2015-12-09 03:13:33,140 INFO : Browser initialized. 03:13:33 INFO - 2015-12-09 03:13:33,140 INFO : Running cycle 1/1 for kraken test... 03:13:33 INFO - 2015-12-09 03:13:33,140 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTBK9lf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:13:45 INFO - 2015-12-09 03:13:45,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 142757888 03:13:45 INFO - 2015-12-09 03:13:45,150 DEBUG : BROWSER_OUTPUT: 03:13:47 INFO - 2015-12-09 03:13:47,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32769/tests/kraken/driver.html?testName=audio-beat-detection) 03:13:48 INFO - 2015-12-09 03:13:48,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 178733056 03:13:48 INFO - 2015-12-09 03:13:48,354 DEBUG : BROWSER_OUTPUT: 03:13:51 INFO - 2015-12-09 03:13:51,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32769/tests/kraken/driver.html?testName=audio-dft) 03:13:51 INFO - 2015-12-09 03:13:51,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 167374848 03:13:51 INFO - 2015-12-09 03:13:51,679 DEBUG : BROWSER_OUTPUT: 03:13:54 INFO - 2015-12-09 03:13:54,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32769/tests/kraken/driver.html?testName=audio-fft) 03:13:55 INFO - 2015-12-09 03:13:55,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 154308608 03:13:55 INFO - 2015-12-09 03:13:55,257 DEBUG : BROWSER_OUTPUT: 03:13:57 INFO - 2015-12-09 03:13:57,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32769/tests/kraken/driver.html?testName=audio-oscillator) 03:13:57 INFO - 2015-12-09 03:13:57,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 156323840 03:13:57 INFO - 2015-12-09 03:13:57,884 DEBUG : BROWSER_OUTPUT: 03:14:00 INFO - 2015-12-09 03:14:00,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:14:00 INFO - 2015-12-09 03:14:00,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 156884992 03:14:00 INFO - 2015-12-09 03:14:00,707 DEBUG : BROWSER_OUTPUT: 03:14:03 INFO - 2015-12-09 03:14:03,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32769/tests/kraken/driver.html?testName=imaging-darkroom) 03:14:04 INFO - 2015-12-09 03:14:04,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 157503488 03:14:04 INFO - 2015-12-09 03:14:04,253 DEBUG : BROWSER_OUTPUT: 03:14:07 INFO - 2015-12-09 03:14:07,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32769/tests/kraken/driver.html?testName=imaging-desaturate) 03:14:08 INFO - 2015-12-09 03:14:08,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 159182848 03:14:08 INFO - 2015-12-09 03:14:08,297 DEBUG : BROWSER_OUTPUT: 03:14:11 INFO - 2015-12-09 03:14:11,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32769/tests/kraken/driver.html?testName=json-parse-financial) 03:14:11 INFO - 2015-12-09 03:14:11,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 157769728 03:14:11 INFO - 2015-12-09 03:14:11,699 DEBUG : BROWSER_OUTPUT: 03:14:13 INFO - 2015-12-09 03:14:13,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:14:14 INFO - 2015-12-09 03:14:14,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 167182336 03:14:14 INFO - 2015-12-09 03:14:14,042 DEBUG : BROWSER_OUTPUT: 03:14:15 INFO - 2015-12-09 03:14:15,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:14:16 INFO - 2015-12-09 03:14:16,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 167964672 03:14:16 INFO - 2015-12-09 03:14:16,511 DEBUG : BROWSER_OUTPUT: 03:14:18 INFO - 2015-12-09 03:14:18,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:14:19 INFO - 2015-12-09 03:14:19,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 178126848 03:14:19 INFO - 2015-12-09 03:14:19,238 DEBUG : BROWSER_OUTPUT: 03:14:21 INFO - 2015-12-09 03:14:21,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:14:22 INFO - 2015-12-09 03:14:22,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 184172544 03:14:22 INFO - 2015-12-09 03:14:22,333 DEBUG : BROWSER_OUTPUT: 03:14:24 INFO - 2015-12-09 03:14:24,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:14:25 INFO - 2015-12-09 03:14:25,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 180674560 03:14:25 INFO - 2015-12-09 03:14:25,510 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32769/tests/kraken/driver.html?testName=ai-astar) 03:14:27 INFO - 2015-12-09 03:14:27,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 239075328 03:14:27 INFO - 2015-12-09 03:14:27,526 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,530 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:14:27 INFO - 2015-12-09 03:14:27,530 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:14:27 INFO - 2015-12-09 03:14:27,530 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:14:27 INFO - 2015-12-09 03:14:27,530 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:14:27 INFO - 2015-12-09 03:14:27,530 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;106;111;114;114;104;113;111;119 03:14:27 INFO - 2015-12-09 03:14:27,530 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;129;152;169;130;159;162;137;174;128 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;161;162;161;162;163;162;162 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;86;89;76;72;72;106;92;72 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;127;95;96;94;128;101;95;130 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;111;109;109;109 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;147;146;147;147;147;147 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;96;95;95;95 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;71;73;72;71;71;79;69;69 03:14:27 INFO - 2015-12-09 03:14:27,531 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;68;69;68;69;68 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;93;85;84;83;84;87;84;84 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;126;126;127;126;123;119;121;128;125 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;148;145;147;148;148;148;146;149;135 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;68;69;69;68;69;69;68 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:14:27 INFO - 2015-12-09 03:14:27,532 DEBUG : BROWSER_OUTPUT: __startTimestamp1449659667528__endTimestamp 03:14:27 INFO - 2015-12-09 03:14:27,533 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:4.22 (3.8%) stddev-sans-first:4.45 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 106.0 111.0 114.0 114.0 104.0 113.0 111.0 119.0 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,536 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.50 Median:157.00 stddev:17.26 (11.0%) stddev-sans-first:18.20 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: Values: 155.0 129.0 152.0 169.0 130.0 159.0 162.0 137.0 174.0 128.0 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.67 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 161.0 162.0 161.0 162.0 163.0 162.0 162.0 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:11.70 (15.6%) stddev-sans-first:11.94 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 86.0 89.0 76.0 72.0 72.0 106.0 92.0 72.0 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:94.50 stddev:15.90 (16.8%) stddev-sans-first:16.40 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 127.0 95.0 96.0 94.0 128.0 101.0 95.0 130.0 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:14:27 INFO - 2015-12-09 03:14:27,537 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 111.0 109.0 109.0 109.0 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.50 stddev:2.87 (4.0%) stddev-sans-first:3.04 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 71.0 73.0 72.0 71.0 71.0 79.0 69.0 69.0 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 68.0 69.0 68.0 69.0 68.0 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:3.26 (3.9%) stddev-sans-first:3.15 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 93.0 85.0 84.0 83.0 84.0 87.0 84.0 84.0 03:14:27 INFO - 2015-12-09 03:14:27,538 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:126.00 stddev:3.30 (2.6%) stddev-sans-first:2.96 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: Values: 119.0 126.0 126.0 127.0 126.0 123.0 119.0 121.0 128.0 125.0 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:148.00 stddev:4.78 (3.2%) stddev-sans-first:4.30 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: Values: 138.0 148.0 145.0 147.0 148.0 148.0 148.0 146.0 149.0 135.0 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 68.0 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:14:27 INFO - 2015-12-09 03:14:27,539 DEBUG : BROWSER_OUTPUT: 03:14:28 INFO - 2015-12-09 03:14:28,469 INFO : Browser exited with error code: 0 03:14:28 INFO - 2015-12-09 03:14:28,522 INFO : Completed test kraken (00:01:00) 03:14:28 INFO - 2015-12-09 03:14:28,522 INFO : Starting test v8_7 03:14:28 INFO - 2015-12-09 03:14:28,523 DEBUG : operating with platform_type : linux_ 03:14:28 INFO - 2015-12-09 03:14:28,523 INFO : Initialising browser for v8_7 test... 03:14:28 INFO - 2015-12-09 03:14:28,529 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCEf2Jm/profile http://localhost:32769/getInfo.html 03:14:32 INFO - 2015-12-09 03:14:32,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:14:32 INFO - 2015-12-09 03:14:32,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:14:32 INFO - 2015-12-09 03:14:32,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:14:32 INFO - 2015-12-09 03:14:32,970 DEBUG : BROWSER_OUTPUT: __metrics 03:14:33 INFO - 2015-12-09 03:14:33,078 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] 03:14:33 INFO - 2015-12-09 03:14:33,126 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:14:33 ERROR - 2015-12-09 03:14:33,142 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 03:14:34 INFO - 2015-12-09 03:14:34,049 INFO : Browser initialized. 03:14:34 INFO - 2015-12-09 03:14:34,049 INFO : Running cycle 1/1 for v8_7 test... 03:14:34 INFO - 2015-12-09 03:14:34,049 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCEf2Jm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:14:46 INFO - 2015-12-09 03:14:46,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 142548992 03:14:46 INFO - 2015-12-09 03:14:46,097 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32769/tests/v8_7/run.html (next: http://localhost:32769/tests/v8_7/run.html) 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 468901888 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:15:07 INFO - 2015-12-09 03:15:07,779 DEBUG : BROWSER_OUTPUT: |0;Richards;166.333998669328 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.6368047779022 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2000 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |6;Boyer;11928.57142857143 03:15:07 INFO - 2015-12-09 03:15:07,780 DEBUG : BROWSER_OUTPUT: |7;RegExp;26842.105263157893 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: |8;Splay;680.7351940095303 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: __startTimestamp1449659707771__endTimestamp 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:15:07 INFO - 2015-12-09 03:15:07,781 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: Values: 166.3 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.64 Median:186.64 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: Values: 186.6 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: Values: 278.6 03:15:07 INFO - 2015-12-09 03:15:07,782 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: Values: 5122.4 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: Values: 2000.0 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: Values: 788.0 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11928.57 Median:11928.57 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: Values: 11928.6 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: Values: 26842.1 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,783 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:680.74 Median:680.74 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,784 DEBUG : BROWSER_OUTPUT: Values: 680.7 03:15:07 INFO - 2015-12-09 03:15:07,784 DEBUG : BROWSER_OUTPUT: 03:15:07 INFO - 2015-12-09 03:15:07,784 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 03:15:07 INFO - 2015-12-09 03:15:07,784 DEBUG : BROWSER_OUTPUT: Values: 4854.4 03:15:07 INFO - 2015-12-09 03:15:07,784 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:15:07 INFO - 2015-12-09 03:15:07,784 DEBUG : BROWSER_OUTPUT: 03:15:08 INFO - 2015-12-09 03:15:08,653 INFO : Browser exited with error code: 0 03:15:08 INFO - 2015-12-09 03:15:08,670 INFO : Completed test v8_7 (00:00:40) 03:15:08 INFO - 2015-12-09 03:15:08,782 INFO : Completed test suite (00:20:18) 03:15:08 INFO - 2015-12-09 03:15:08,783 DEBUG : Working with test: dromaeo_css 03:15:08 INFO - 2015-12-09 03:15:08,783 DEBUG : Generating results file: dromaeo_css 03:15:08 INFO - 2015-12-09 03:15:08,784 DEBUG : Working with test: kraken 03:15:08 INFO - 2015-12-09 03:15:08,784 DEBUG : Generating results file: kraken 03:15:08 INFO - 2015-12-09 03:15:08,784 INFO : javascript benchmark 03:15:08 INFO - 2015-12-09 03:15:08,784 DEBUG : Working with test: v8_7 03:15:08 INFO - 2015-12-09 03:15:08,785 DEBUG : Generating results file: v8_7 03:15:08 INFO - 2015-12-09 03:15:08,785 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:15:08 INFO - 2015-12-09 03:15:08,949 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:15:08 INFO - 2015-12-09 03:15:08,950 DEBUG : process_Request line: dromaeo_css 6225.10 graph.html#tests=[[72,132,35]] 03:15:08 INFO - 2015-12-09 03:15:08,950 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:15:09 INFO - 2015-12-09 03:15:09,107 DEBUG : process_Request line: kraken 1523.10 graph.html#tests=[[232,132,35]] 03:15:09 INFO - 2015-12-09 03:15:09,107 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:15:09 INFO - 2015-12-09 03:15:09,258 DEBUG : process_Request line: v8_7 19614.10 graph.html#tests=[[230,132,35]] 03:15:09 INFO - 2015-12-09 03:15:09,259 INFO : javascript benchmark 03:15:09 INFO - 2015-12-09 03:15:09,263 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.2624065261725, 2731.6175735397037, 2734.220747087081, 2739.821911575746, 2761.6271803306554, 4381.101874115807, 4523.4797998230215, 4666.78999445025, 4717.056588682264, 4738.526147385264, 4579.610733087691, 4621.838235661752, 4624.445066592005, 4727.810887564493, 4760.714357138574, 4280.443542339492, 4307.160103779756, 4328.696991210617, 4337.219300525904, 4353.62994145498, 4396.1427521633295, 4420.31485119807, 4453.755043472608, 4454.599086082252, 4477.641788656916, 4081.1837632473625, 4204.26425375558, 4306.892327691801, 4394.8242070317465, 4406.537313582092, 4348.956510434887, 4350.934735978963, 4353.151135528573, 4391.429114215131, 4393.670474714378, 4076.9388459173138, 4331.826726930919, 4336.479622445295, 4343.109662519208, 4381.671374646882, 4538.88652783683, 4552.483762508583, 4574.748388838612, 4677.74272415017, 4681.976590117028, 5025.748712564357, 5055.064813009568, 5069.239614057884, 5092.465291144451, 5111.718855462948, 5085.669431486978, 5089.0, 5090.058339207221, 5092.3125378073855, 5141.126008578551, 4532.388127602798, 4650.674452788272, 4659.767011649404, 4675.929861052087, 4784.593309568726, 5193.428722840485, 5211.843644690665, 5239.476052394806, 5250.894982100413, 5254.159334506537, 4961.355023846877, 4968.8757781055765, 4974.328465657162, 4975.477574854661, 4985.227289770091, 4782.880427989328, 4915.606751459874, 5050.84847454577, 5059.645824792303, 5104.259882317043, 4847.0, 4880.463149053601, 5001.224810154432, 5016.749162541858, 5020.799168033311, 4967.205247160509, 4980.402351717817, 5007.098722229961, 5008.824691135793, 5071.644984851025, 4224.260754367973, 4259.38238955356, 4266.87199384019, 4267.850625228102, 4301.763403012802, 3493.8078405687424, 3588.0312315674623, 3619.2580520993133, 3637.654422829827, 3688.2623475305045, 4322.113966636832, 4342.044750154961, 4345.847895323648, 4348.630366418826, 4387.583179597933, 5077.26379674945, 5079.517445842639, 5088.898222035538, 5089.05852417304, 5131.974340128276, 4072.75563466193, 4178.0, 4185.183889141649, 4232.534421213664, 4351.782410879443, 4522.5929666330185, 4535.070310586322, 4537.977310113494, 4553.863384098482, 4591.816327346869, 4843.346148270009, 4847.079054979543, 4851.80592776285, 4856.538628830255, 4894.119058569349, 4815.061063092803, 4912.459629440687, 4949.950500494949, 4966.751662416792, 5121.334226550524, 4807.759612019315, 4829.782659780389, 4832.226843704991, 4835.298881662069, 4878.365812444359, 5024.346834911438, 5026.0, 5027.271045698426, 5030.8239211627415, 5043.747812609428, 4771.904561908673, 4910.656254062182, 4913.729744864067, 4972.825951091694, 5134.820281290137, 4891.486393928586, 4901.411830580353, 4903.509649035211, 4904.032049110119, 4907.116718990616, 4879.512048795092, 4879.975600121977, 4887.902241955212, 4925.064237794808, 4931.950680493293, 4509.481409637933, 4670.64970127235, 4688.156131896291, 4688.3436318916065, 4815.398075240595, 4942.629302802232, 4947.282644016669, 4982.352294201875, 4991.026749783758, 5021.598272138147, 4834.371531700856, 4835.782389792397, 4840.201366774443, 4840.661153719347, 4881.974785294986], "unit": "ms", "name": "dojo.html", "value": 4613.558103497113}, {"lowerIsBetter": false, "replicates": [524.8322482476489, 537.1942086869697, 540.3515781062725, 568.6531215958265, 573.2576313673794, 26252.212433627, 34390.14024649385, 35169.0, 35200.82399588005, 35243.11892202696, 38656.806715966384, 39272.60727392725, 39280.80359598198, 39308.60691393085, 39352.803235983854, 6944.305569443066, 7052.04797352356, 7060.223375428699, 7910.999999999985, 8062.475939063971, 10126.696199114038, 10332.173426125892, 10367.222458315618, 10392.376457412542, 10404.063634272914, 10129.645462408816, 10164.796704065915, 10254.692359229235, 10259.127974122208, 10288.074073333399, 7231.204567497571, 7436.73971410998, 10096.949515252414, 10188.0, 10475.79048419035, 9997.300188986774, 10151.390916545031, 10153.89846101537, 10157.847632285522, 10163.0, 35853.82073089644, 36481.81759091214, 36482.63517364819, 36509.26981460356, 36571.08572285688, 2671.4389978104623, 2712.9321766955786, 2933.3839893622367, 3225.5000474926187, 3558.057114864563, 27606.585901211496, 27836.582451263246, 27871.34310663466, 28169.29576760577, 28633.0, 3463.9826800866085, 3482.233908540117, 3504.737144714157, 3583.7849729016343, 3589.300086483137, 209463.0, 211110.0, 212099.0, 212748.0, 213438.0, 51262.48737512652, 52523.0, 54877.72561137169, 55174.17238741422, 55290.0, 58607.0, 59946.70026649839, 60086.0, 60196.097058544154, 60239.0, 13351.198928064347, 13719.176849389069, 13731.382087806072, 13732.382042808098, 13734.65663358404, 8946.86579701305, 8955.05971872957, 8988.191062804379, 8996.100389961082, 9049.954750226338, 18967.0, 18971.905140474486, 19215.0, 19216.61566768657, 19321.51696207606, 6907.689153988083, 7114.359707626339, 7159.3914517265575, 7176.354128128493, 7195.856082878313, 829.2868133405267, 907.8592818113203, 908.8909330880336, 911.2618778789202, 921.1939552891221, 24150.0, 24962.875185623954, 25034.499310013696, 25038.0, 25069.4986100277, 879.8900137482815, 924.2051835421532, 932.8507438809894, 938.9295802814817, 1002.2082554781641, 13008.54470093561, 13018.804717929239, 13073.477060917457, 13173.27546984925, 13198.340082995812, 253028.0, 256531.0, 256751.0, 256764.0, 258021.0, 45319.32021019687, 45333.54666453359, 45494.77252613782, 45602.0, 45686.314705279445, 1132.371533798733, 1171.0280467212194, 1172.8299396587618, 1181.509673485511, 1186.0985650905202, 23516.412089697893, 26844.194674159808, 28822.567661485515, 29228.70771292345, 29284.267893302836, 40284.59715402926, 40425.39361909515, 40707.0, 40809.0, 40912.386314205905, 195275.0, 195988.0, 196524.05213921517, 196638.0, 197361.0, 24391.756082439657, 25169.748302516742, 28240.152795416172, 28558.714412856436, 29163.41673166567, 33092.669073309924, 33321.0, 33350.49974250437, 33492.49761253534, 33880.15299617529, 28666.85666571654, 29089.41821163607, 29194.41611167807, 29439.0, 29521.0, 24386.0, 29235.85382073076, 29312.41375172527, 29504.409911801213, 33251.50122748112, 29279.268018299714, 29523.0, 29566.113016609535, 29609.25976850596, 32560.0, 25014.11321546529, 25576.23271301864, 28870.278243044093, 28928.276793080342, 28996.565051523823, 21223.151073957488, 21397.46506337354, 21408.0, 21496.140154393648, 21531.892340538197], "unit": "ms", "name": "ext.html", "value": 16523.48454236937}, {"lowerIsBetter": false, "replicates": [277.2375966093244, 278.77280016786307, 279.594587847621, 280.67441767549644, 287.46244522742467, 11079.446027698603, 15606.517380848816, 16197.02817830931, 16201.83798162018, 16252.593685157877, 9427.434353938768, 9710.12608865202, 9742.659006934759, 15654.921725391385, 16069.91965040176, 4477.059817438342, 4584.633229341644, 4585.312203169535, 4585.403897493321, 4589.0, 4529.275315949449, 4543.0, 4546.499885012646, 4554.977225113887, 4562.589366956973, 3367.377035248475, 3475.704565111956, 4535.954640453603, 4536.364908912755, 5112.616553758465, 5193.169092945111, 5230.476952304777, 5233.136532472156, 5242.501962313593, 5245.711485868275, 4874.926876096862, 4960.107180707471, 4965.428975667808, 5044.949550504484, 5047.192449208109, 10883.401412922287, 10961.397123158224, 11000.614978475794, 11058.11535077192, 17955.3715619954, 1770.3803668715975, 1791.8208179182109, 1800.639872025587, 1801.5766294920684, 1817.37300631282, 8573.828523429496, 8574.399792014561, 11169.715482719428, 12906.419211135428, 13346.19922804635, 1715.7389318850635, 1799.5473714644647, 1807.7830660320715, 1842.6683197024531, 1879.432799869149, 49335.50664493345, 51880.99999999962, 56719.71640141773, 64380.356196437904, 65970.34029659738, 15610.29753661088, 15614.843851561565, 15693.21533923322, 15705.0, 15708.450204243025, 23092.884535577214, 23236.0, 23253.60478371303, 23254.883725581603, 23287.883560582428, 7995.880061799077, 8516.489010659381, 8648.308135349156, 8661.22049015579, 8694.956525217334, 7205.531640443354, 7252.891206631904, 7291.598962057032, 7292.0520332356455, 7299.781006569811, 7740.6129693515095, 7748.380129589619, 7776.572288524072, 7807.80480487981, 7825.882611760828, 1704.880658353928, 1722.3196837249468, 2185.2570126157184, 2941.2205765472168, 3058.342456371891, 769.4229328003997, 774.4733581164862, 834.4200780457523, 845.678642115992, 962.4417837654144, 14171.149731015967, 15168.696626067638, 15292.311845966959, 16598.336066557444, 16599.50201493957, 790.5651891459675, 797.9162187970296, 805.9758207253792, 819.5451524404014, 849.3544905871582, 9212.815743685089, 9273.953630231941, 9344.626214951326, 9523.0, 9566.091221333962, 300159.0, 305630.0, 430015.0, 434536.0, 456404.0, 70695.0, 74140.0, 75104.24895750973, 75945.62027189828, 76175.61912190403, 1002.4686915934566, 1010.9848352274722, 1011.4740335025892, 1032.9896701032894, 1033.56073668692, 14067.0, 14763.0, 14900.701985960004, 14923.925380373028, 14941.925290373478, 31726.841365793025, 31838.0, 33804.83097584496, 34863.65136348604, 36595.81702091579, 42058.78970605128, 43523.78238108789, 43767.78116109399, 44112.11775764531, 45012.77493612642, 8179.67281308741, 8644.0, 8668.176523230282, 8697.782555436164, 8701.738947831574, 15336.923315383352, 15478.303476343366, 15580.376784928929, 16175.352985880432, 16704.832951670327, 13663.0, 13672.179669219879, 13714.65713357174, 13771.380287886868, 13932.164070155823, 12925.030622703523, 13287.933560332136, 13300.733985320432, 13717.382717777924, 14346.49787257441, 13673.17960922308, 13742.725145497234, 13777.793333100211, 14134.858651413766, 14170.787438188228, 8843.823123537364, 8901.154390332907, 8901.33240007015, 8924.509151996703, 8938.776530586787, 9906.702798916043, 13355.332233388486, 13617.25105119228, 13913.165210087021, 14363.56909292723], "unit": "ms", "name": "jquery.html", "value": 8517.450890113178}, {"lowerIsBetter": false, "replicates": [1373.4712135827715, 1594.0913679202854, 1666.2252052795448, 1699.7025520533907, 1702.1234064456798, 5823.980803359411, 6128.908066379008, 6605.966970165143, 6786.321367863211, 6803.455723542117, 6643.933560664392, 6663.133792606966, 6721.3278672132765, 6723.294054124308, 6726.125603671528, 2029.2593203480733, 2071.420002399323, 2074.087401543316, 2075.7094006839056, 2077.927272545461, 2087.269455690511, 2098.192196004534, 2104.9052792624293, 2125.7449106107288, 2137.6152292587326, 1994.411648563677, 2036.0023588441704, 2060.6084843879617, 2063.4222417722985, 2063.8555301128927, 2079.313826437272, 2117.385958072165, 2118.671605901088, 2122.3632910127053, 2123.532822778986, 2037.663785475395, 2071.979280207194, 2074.346580827035, 2078.9480262993393, 2079.054030416157, 6902.137232845895, 6943.583384996866, 6956.060931774196, 6960.965195173992, 6979.581225126509, 4082.7346222495444, 4117.07365842686, 4122.969257685579, 4128.525219599755, 4143.81352839123, 2593.0, 2598.3244356467267, 2613.9869300653563, 2724.1146627345993, 2727.4954133485367, 771.6758961236294, 777.9066512018537, 819.7540737778643, 821.7781199076276, 1678.4628918746007, 8950.597223124974, 9087.954560227223, 9092.727218183465, 9107.590158442887, 9111.27109831212, 3688.0964163780045, 3728.440733889938, 3787.772733635991, 3788.8295026723863, 3802.5627052888717, 8190.140035296208, 8191.221833925768, 8200.958995204986, 8202.630881610341, 8206.712765053195, 4204.936925946114, 4210.726302790309, 4223.450951376301, 4226.957730422657, 4230.365445183247, 3176.4917613182242, 3259.5762550868235, 3266.8856590019236, 3816.3512202925567, 3820.0, 3152.5271209318785, 3333.583302087239, 3355.0773537276955, 3360.0, 3389.983050084734, 1035.4253389368973, 1076.8438576406377, 1084.7938891610568, 1085.4301491716913, 1090.334895713614, 816.0452270843009, 826.3678286111129, 827.6813426830594, 906.5739102621757, 1076.7900259449332, 6470.514711396664, 6551.574147680385, 6566.474682025427, 6567.934320656828, 6567.9671601641685, 524.5357858295436, 533.4691981478454, 535.3789604059273, 539.2235181338859, 698.2319448606493, 5073.923891141562, 5178.456262092502, 5205.27126202332, 5217.243499692523, 5235.1623740201385, 7774.455788094892, 7891.644875980594, 8057.113717491071, 8190.959045204736, 8206.425550211547, 8400.033996090406, 8411.663533458594, 8508.489490630582, 8564.52895090776, 8566.100559441293, 6569.277379488252, 6614.305497922649, 6736.427403670645, 6743.763968261087, 6761.256261811197, 6616.470682345497, 6651.567648102858, 6671.066050752802, 6671.366220209073, 6676.265610782712, 7021.262767409553, 7288.854222915618, 7420.851582968418, 7431.739889104072, 7695.2304769524835, 7444.776656700307, 7477.401807855467, 7819.609019548886, 7829.647665855164, 7944.721934732257, 4920.507949205051, 5802.419758024333, 5913.231279933581, 5978.671173085522, 5988.461038506555, 5937.406259374028, 6325.525585581192, 6348.301686814354, 6354.332795056453, 6357.332480089524, 6127.632342059491, 6135.478484328882, 6197.81406557804, 6201.968990155201, 6280.591761535486, 6176.413240742122, 6205.937940620536, 6244.781432650017, 6247.156633854372, 6341.080543321101, 6211.09939058843, 6304.65324407162, 6313.337099604475, 6322.873542529215, 6342.0, 5831.504322132497, 5912.408759124053, 5916.970415147896, 5938.910916336172, 5944.286685597756, 5506.339239291311, 5682.801101961411, 5717.514011309086, 5763.366029736641, 5772.884542309214], "unit": "ms", "name": "mootools.html", "value": 3930.5859851939563}, {"lowerIsBetter": false, "replicates": [257.18087890070126, 258.62112005911337, 261.5684121200021, 262.82128152856063, 263.58748558505937, 5160.432352441228, 5227.424983251844, 5229.947700522994, 5235.8691032724155, 5255.395629502608, 4965.106280869442, 5114.462981386957, 5122.61580381472, 5153.793848246066, 5241.161414173733, 4015.855481187862, 4020.8793736187963, 4028.476298081245, 4030.052937559671, 4043.8584649537274, 3819.4461803038544, 4030.6170913763144, 4031.2340655275552, 4034.919301613966, 4044.5753195914444, 3898.66861316787, 3905.6680182184405, 4015.799210039501, 4018.7387819791766, 4020.2361551305157, 3999.5000624921886, 4004.559498455182, 4007.939880901789, 4014.136960553495, 4015.2371049500503, 3472.149323415754, 3472.8958131256104, 3474.409350410436, 3476.5132881396626, 3477.165480284739, 5069.518395752434, 5071.746412679351, 5073.492650734934, 5075.162598171298, 5082.161443361841, 4505.932411013838, 4587.885302867422, 4591.517890621503, 4591.9081618367445, 4615.2384856498975, 5517.503424691757, 5522.392536820947, 5526.115821468546, 5530.059889818741, 5535.972320138373, 3756.7370284080125, 3757.774533527997, 3760.492333534965, 3761.247750449921, 3771.208046310278, 5815.767369305223, 5821.446962538552, 5823.0, 5823.301203855522, 5825.79609713658, 3776.055986003499, 3861.015441062511, 3866.38137897935, 3870.7677539347164, 3874.651281384689, 3921.2941670499013, 3922.725409221327, 3924.17592305619, 3924.3328634132267, 3927.4108883667677, 4556.794944227518, 4559.247724125548, 4563.041761230113, 4563.06457176278, 4564.7717614119165, 5534.1145416733125, 5535.640183388147, 5537.307836520435, 5537.640053396516, 5547.417521160301, 1353.810466534686, 1359.3543067043076, 1387.0429403711407, 1388.271157642246, 1390.360434200259, 910.349100393222, 918.3755046568398, 918.93108016899, 921.8110287391069, 923.9353245272766, 4856.660033797601, 4857.9028419431415, 4863.70817750929, 4865.7323847188745, 4871.14754917888, 5737.799177028867, 5743.741531631086, 5751.712414379348, 5754.0505816540635, 5755.0, 4680.438347398266, 4763.833265835679, 4783.115123702126, 4850.80596776125, 4861.708297502161, 3062.617172853393, 3089.351236240415, 3098.9535156972665, 3099.9535006974916, 3104.1463597510415, 5492.368377636543, 5506.311711036121, 5514.310711161105, 5516.972415137899, 5517.834464966058, 5980.820575382745, 5981.551383646157, 5985.16207730918, 5988.161657367972, 5989.131575921467, 5350.143976963667, 5517.2275881377445, 5519.613627046068, 5523.6685798852195, 5527.44725527444, 5776.884462310814, 5816.302043754777, 5822.650640961556, 5823.097419899922, 5832.737526811219, 5677.1768093627015, 5686.71566421669, 5689.089745640677, 5694.117411801178, 5701.030824759718, 5303.204519322133, 5497.5601951842955, 5501.284832971688, 5514.80698175562, 5516.724163791875, 3739.046543131593, 3745.2322273934324, 3762.9811850941664, 3771.4908487354955, 3779.7165212608616, 5776.191333213437, 5794.188813566188, 5824.242848429677, 5827.24245848037, 5829.59192856513, 5574.386817450159, 5593.272874526286, 5596.972015140062, 5605.271314729059, 5614.101743720985, 5423.972880135574, 5580.079286917613, 5584.664920104807, 5584.692841893735, 5587.664740115606, 5464.28964234647, 5481.780728770805, 5484.848181881849, 5486.835394938158, 5486.957478079312, 5627.718614069362, 5634.126710359901, 5635.549156067586, 5638.520725738194, 5641.069223578063, 5365.839024829105, 5466.453354664502, 5490.121580547093, 5490.560755139659, 5498.367687715964], "unit": "ms", "name": "prototype.html", "value": 4114.889944843436}, {"lowerIsBetter": false, "replicates": [762.7482930632893, 767.4666107055596, 781.5193655901619, 797.8364435290763, 826.8677011678133, 13807.102538335013, 14029.36867840947, 14040.29798510073, 14060.437582496701, 14090.859091409084, 13199.472021119143, 13253.204807711543, 13278.535251266208, 13291.069625126245, 13297.93351033246, 622.1259130921063, 629.072118625029, 790.3084800799286, 799.1209669363711, 799.4963173200875, 787.2403130978604, 794.7417089445925, 804.903411590607, 805.8952336196315, 805.9194080591923, 823.27551754456, 827.7061643116697, 834.090840983328, 834.7245409015011, 835.1481488881337, 644.1625886347753, 649.8505343770936, 818.893543839303, 821.4701517521195, 832.704389941568, 612.231649280155, 612.7334609444861, 614.5145335185198, 614.6588643302965, 614.695725615823, 12353.382330883509, 12359.876401236052, 12401.317927513983, 12425.937870310681, 12430.316332601704, 10143.442110683909, 11083.667489975314, 11181.273217240934, 11440.885591144066, 11611.941940290244, 8648.351373647001, 9203.217726493256, 9220.538973051387, 9276.72169834906, 9412.341136120474, 3158.242021914747, 3164.4620414529354, 3181.18879685681, 3206.2625596112794, 3230.709236168756, 38032.42951355732, 38400.807995960124, 38447.99999999972, 38469.0, 39155.0, 8561.357898157663, 8738.344624153087, 9018.278537716968, 9146.451212927113, 9208.861867071999, 15851.286692098884, 15935.282912268976, 15995.200239987955, 16024.75962860558, 16090.597735056717, 6285.717142728588, 6472.741090356427, 6474.935250647527, 6560.639164845979, 6639.3692599203, 3563.893083207508, 3597.8021208833243, 3630.2013557017412, 3654.798986055739, 3672.981635091807, 2629.81591288608, 2664.0, 2673.492036513095, 2675.6922953860167, 2677.8928842846067, 465.67868170962606, 470.3767508051845, 472.56287933661224, 473.6258355898801, 478.5692876411188, 486.8807142250101, 571.6227289988587, 583.1107560969556, 585.9209006784115, 603.7283222549783, 6845.0, 6875.106236189264, 6982.197047339621, 7047.859042819115, 7153.3919616833155, 440.4208465867374, 463.3952691737248, 500.2546206152806, 504.5761560289375, 555.416812347034, 3491.4762785581856, 3609.7653652512504, 3627.183883626163, 3687.7602955808325, 3708.9072773180346, 45331.77334113374, 45768.77115614401, 46020.539794601624, 46060.3090953636, 46161.76919115383, 40559.39160912589, 41374.37938430926, 41754.582454175674, 42217.36673949893, 42376.15247695029, 34578.51635362537, 37289.62710372916, 38247.661331853255, 38286.42570361447, 38472.8076359622, 7289.234630363735, 7416.184219735716, 7417.8887316689215, 7443.627818608939, 7738.845223095619, 28852.567211492264, 29054.418911621226, 29223.415531689672, 29395.265118372212, 29832.10503684806, 34037.48943765796, 34432.82783586166, 34854.78008269698, 37477.2504549902, 37794.0, 8983.505907175168, 9467.573959171992, 9577.0, 9601.615935362786, 9786.0, 10838.837417438903, 10883.782324353628, 10922.180836437457, 10979.451027448755, 10998.175136864927, 9883.752906177404, 10062.0, 10107.848382274418, 10283.537240824031, 10294.742631434274, 9582.952085239807, 9783.119519243302, 9905.653302134391, 9941.900580994097, 9956.502174891371, 7855.198433544972, 9466.668666596635, 9783.706488805346, 9829.950850245703, 9973.850392243978, 8508.91491085106, 8746.125387461458, 8824.955875220583, 8861.64553417856, 8911.2425443838, 7163.212046674966, 8009.959950200212, 8315.402235024718, 8487.490750554987, 8752.387332886638], "unit": "ms", "name": "yui.html", "value": 5540.709273865788}], "name": "dromaeo_css", "value": 6225.093747907443}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 111.0, 114.0, 114.0, 104.0, 113.0, 111.0, 119.0], "unit": "ms", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 152.0, 169.0, 130.0, 159.0, 162.0, 137.0, 174.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 86.0, 89.0, 76.0, 72.0, 72.0, 106.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 127.0, 95.0, 96.0, 94.0, 128.0, 101.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 73.0, 72.0, 71.0, 71.0, 79.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 93.0, 85.0, 84.0, 83.0, 84.0, 87.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [119.0, 126.0, 126.0, 127.0, 126.0, 123.0, 119.0, 121.0, 128.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 145.0, 147.0, 148.0, 148.0, 148.0, 146.0, 149.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1523.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [186.6368047779022], "unit": "score", "name": "DeltaBlue", "value": 354.26024399999994}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [11928.57142857143], "unit": "score", "name": "Boyer", "value": 55.871149700598814}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [680.7351940095303], "unit": "score", "name": "Splay", "value": 119.71027900000001}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19614.098267586465}]} 03:15:09 INFO - RETURN: dromaeo_css: 6225.10 03:15:09 INFO - RETURN: kraken: 1523.10 03:15:09 INFO - RETURN: v8_7: 19614.10 03:15:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19614.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6225.10"}}} 03:15:09 INFO - Return code: 0 03:15:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:15:09 ERROR - # TBPL SUCCESS # 03:15:09 INFO - Running post-action listener: _resource_record_post_action 03:15:09 INFO - Running post-run listener: _resource_record_post_run 03:15:10 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519254016; Read time: 12; Write time: 556960 03:15:10 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243294208; Read time: 0; Write time: 374940 03:15:10 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275959808; Read time: 12; Write time: 182020 03:15:10 INFO - Running post-run listener: _upload_blobber_files 03:15:10 INFO - Blob upload gear active. 03:15:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:15:10 INFO - Copying logs to upload dir... 03:15:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.291080 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-09 03:15:10.096036) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:10.100791) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010074 build_url: 'https://queue.taskcluster.net/v1/task/C_QiCq3vQrWdhBMMgV_m1Q/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-09 03:15:10.154175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:10.154595) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449657365.604936-1105534637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:15:10.206811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 03:15:10.207149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 03:15:10.210630) ========= ========= Total master_lag: 0.28 =========