builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1450181613.2 results: success (0) buildid: 20151215031211 builduid: ac8f1bc046114e1cb1f54b57c020f801 revision: 038664873a7bb62ef3fc904511dc063a28e601a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.203654) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.204204) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.204678) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006396 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.230921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.231237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.258196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.258629) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.313195) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.313488) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.313837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.314114) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 04:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-15 04:13:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.508363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.508674) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020253 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.578530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:33.578934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 038664873a7bb62ef3fc904511dc063a28e601a4 --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 038664873a7bb62ef3fc904511dc063a28e601a4 --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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 04:13:33,769 truncating revision to first 12 chars 2015-12-15 04:13:33,770 Setting DEBUG logging. 2015-12-15 04:13:33,770 attempt 1/10 2015-12-15 04:13:33,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/038664873a7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 04:13:34,133 unpacking tar archive at: fx-team-038664873a7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642278 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.243888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.244328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.252407) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.252755) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 04:13:34.253196) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-15 04:13:34.253532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:34 INFO - MultiFileLogger online at 20151215 04:13:34 in /builds/slave/test 04:13:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:13:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:34 INFO - {'append_to_log': False, 04:13:34 INFO - 'base_work_dir': '/builds/slave/test', 04:13:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:13:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:34 INFO - 'branch': 'Fx-Team-Non-PGO', 04:13:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:34 INFO - 'config_files': ('talos/linux_config.py',), 04:13:34 INFO - 'default_actions': ('clobber', 04:13:34 INFO - 'read-buildbot-config', 04:13:34 INFO - 'download-and-extract', 04:13:34 INFO - 'populate-webroot', 04:13:34 INFO - 'create-virtualenv', 04:13:34 INFO - 'install', 04:13:34 INFO - 'run-tests'), 04:13:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:34 INFO - 'download_minidump_stackwalk': True, 04:13:34 INFO - 'download_symbols': 'ondemand', 04:13:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:34 INFO - 'installer_path': 'installer.exe', 04:13:34 INFO - 'log_level': 'info', 04:13:34 INFO - 'log_name': 'talos', 04:13:34 INFO - 'log_to_console': True, 04:13:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:34 INFO - 'opt_config_files': (), 04:13:34 INFO - 'pip_index': False, 04:13:34 INFO - 'sps_profile': False, 04:13:34 INFO - 'sps_profile_interval': 0, 04:13:34 INFO - 'suite': 'dromaeojs-e10s', 04:13:34 INFO - 'system_bits': '64', 04:13:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:34 INFO - 'title': 'talos-linux64-ix-049', 04:13:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:34 INFO - 'use_talos_json': True, 04:13:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:34 INFO - 'work_dir': 'build'} 04:13:34 INFO - ##### 04:13:34 INFO - ##### Running clobber step. 04:13:34 INFO - ##### 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: clobber 04:13:34 INFO - rmtree: /builds/slave/test/build 04:13:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - ##### 04:13:34 INFO - ##### Running read-buildbot-config step. 04:13:34 INFO - ##### 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: read_buildbot_config 04:13:34 INFO - Using buildbot properties: 04:13:34 INFO - { 04:13:34 INFO - "properties": { 04:13:34 INFO - "buildnumber": 573, 04:13:34 INFO - "product": "firefox", 04:13:34 INFO - "script_repo_revision": "production", 04:13:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:13:34 INFO - "repository": "", 04:13:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:13:34 INFO - "buildid": "20151215031211", 04:13:34 INFO - "slavename": "talos-linux64-ix-049", 04:13:34 INFO - "pgo_build": "False", 04:13:34 INFO - "basedir": "/builds/slave/test", 04:13:34 INFO - "project": "", 04:13:34 INFO - "platform": "ubuntu64_hw", 04:13:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:13:34 INFO - "slavebuilddir": "test", 04:13:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:13:34 INFO - "branch": "fx-team", 04:13:34 INFO - "repo_path": "integration/fx-team", 04:13:34 INFO - "stage_platform": "linux64", 04:13:34 INFO - "builduid": "ac8f1bc046114e1cb1f54b57c020f801", 04:13:34 INFO - "revision": "038664873a7bb62ef3fc904511dc063a28e601a4" 04:13:34 INFO - }, 04:13:34 INFO - "sourcestamp": { 04:13:34 INFO - "repository": "", 04:13:34 INFO - "hasPatch": false, 04:13:34 INFO - "project": "", 04:13:34 INFO - "branch": "fx-team-linux64-talos", 04:13:34 INFO - "changes": [ 04:13:34 INFO - { 04:13:34 INFO - "category": null, 04:13:34 INFO - "files": [ 04:13:34 INFO - { 04:13:34 INFO - "url": null, 04:13:34 INFO - "name": "https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:13:34 INFO - } 04:13:34 INFO - ], 04:13:34 INFO - "repository": "", 04:13:34 INFO - "rev": "038664873a7bb62ef3fc904511dc063a28e601a4", 04:13:34 INFO - "who": "apoirot@mozilla.com", 04:13:34 INFO - "when": 1450181570, 04:13:34 INFO - "number": 7361704, 04:13:34 INFO - "comments": "Bug 1228382 - Keep service worker alive when attaching to them. r=janx,ejpbruel", 04:13:34 INFO - "project": "", 04:13:34 INFO - "at": "Tue 15 Dec 2015 04:12:50", 04:13:34 INFO - "branch": "fx-team-linux64-talos", 04:13:34 INFO - "revlink": "", 04:13:34 INFO - "properties": [ 04:13:34 INFO - [ 04:13:34 INFO - "buildid", 04:13:34 INFO - "20151215031211", 04:13:34 INFO - "Change" 04:13:34 INFO - ], 04:13:34 INFO - [ 04:13:34 INFO - "builduid", 04:13:34 INFO - "ac8f1bc046114e1cb1f54b57c020f801", 04:13:34 INFO - "Change" 04:13:34 INFO - ], 04:13:34 INFO - [ 04:13:34 INFO - "pgo_build", 04:13:34 INFO - "False", 04:13:34 INFO - "Change" 04:13:34 INFO - ] 04:13:34 INFO - ], 04:13:34 INFO - "revision": "038664873a7bb62ef3fc904511dc063a28e601a4" 04:13:34 INFO - } 04:13:34 INFO - ], 04:13:34 INFO - "revision": "038664873a7bb62ef3fc904511dc063a28e601a4" 04:13:34 INFO - } 04:13:34 INFO - } 04:13:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:13:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - ##### 04:13:34 INFO - ##### Running download-and-extract step. 04:13:34 INFO - ##### 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: download_and_extract 04:13:34 INFO - mkdir: /builds/slave/test/build/tests 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json 04:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json 04:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:35 INFO - Downloaded 1302 bytes. 04:13:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:35 INFO - Using the following test package requirements: 04:13:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'jsshell-linux-x86_64.zip'], 04:13:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:37 INFO - Downloaded 21869884 bytes. 04:13:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:13:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:13:38 INFO - Return code: 0 04:13:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:38 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')]} 04:13:38 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:44 INFO - Downloaded 21869884 bytes. 04:13:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:13:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:13:45 INFO - Return code: 0 04:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:45 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:46 INFO - Downloaded 11132038 bytes. 04:13:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:13:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:13:46 INFO - Return code: 0 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:46 INFO - https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:48 INFO - Downloaded 57742871 bytes. 04:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:48 INFO - mkdir: /builds/slave/test/properties 04:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:48 INFO - Contents: 04:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:48 INFO - Running post-action listener: _resource_record_post_action 04:13:48 INFO - Running post-action listener: set_extra_try_arguments 04:13:48 INFO - ##### 04:13:48 INFO - ##### Running populate-webroot step. 04:13:48 INFO - ##### 04:13:48 INFO - Running pre-action listener: _resource_record_pre_action 04:13:48 INFO - Running main action method: populate_webroot 04:13:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:48 INFO - '--tppagecycles', 04:13:48 INFO - '7'], 04:13:48 INFO - 'tests': ['tsvgm']}}, 04:13:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'tests': ['damp', 'tps']}, 04:13:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['damp', 'tps']}, 04:13:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:48 INFO - 'other': {'tests': ['a11yr', 04:13:48 INFO - 'ts_paint', 04:13:48 INFO - 'tpaint', 04:13:48 INFO - 'sessionrestore', 04:13:48 INFO - 'sessionrestore_no_auto_restore']}, 04:13:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['a11yr', 04:13:48 INFO - 'ts_paint', 04:13:48 INFO - 'tpaint', 04:13:48 INFO - 'sessionrestore', 04:13:48 INFO - 'sessionrestore_no_auto_restore']}, 04:13:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['a11yr', 04:13:48 INFO - 'ts_paint', 04:13:48 INFO - 'tpaint', 04:13:48 INFO - 'sessionrestore', 04:13:48 INFO - 'sessionrestore_no_auto_restore']}, 04:13:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['a11yr', 04:13:48 INFO - 'ts_paint', 04:13:48 INFO - 'tpaint', 04:13:48 INFO - 'sessionrestore', 04:13:48 INFO - 'sessionrestore_no_auto_restore']}, 04:13:48 INFO - 'other_l64': {'tests': ['a11yr', 04:13:48 INFO - 'ts_paint', 04:13:48 INFO - 'tpaint', 04:13:48 INFO - 'sessionrestore', 04:13:48 INFO - 'sessionrestore_no_auto_restore']}, 04:13:48 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:48 INFO - 'ts_paint', 04:13:48 INFO - 'tpaint', 04:13:48 INFO - 'sessionrestore', 04:13:48 INFO - 'sessionrestore_no_auto_restore']}, 04:13:48 INFO - 'svgr': {'tests': ['tsvgx', 04:13:48 INFO - 'tsvgr_opacity', 04:13:48 INFO - 'tart', 04:13:48 INFO - 'tscrollx', 04:13:48 INFO - 'cart']}, 04:13:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['tsvgx', 04:13:48 INFO - 'tsvgr_opacity', 04:13:48 INFO - 'tart', 04:13:48 INFO - 'tscrollx', 04:13:48 INFO - 'cart']}, 04:13:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'tests': ['tp5o']}, 04:13:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'talos_options': ['--e10s'], 04:13:48 INFO - 'tests': ['tp5o']}, 04:13:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'talos_options': ['--xperf_path', 04:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:48 INFO - 'tests': ['tp5n']}, 04:13:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:48 INFO - 'talos_options': ['--e10s', 04:13:48 INFO - '--xperf_path', 04:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:48 INFO - 'tests': ['tp5n']}}, 04:13:48 INFO - 'talos.zip': {'path': '', 04:13:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:48 INFO - Running post-action listener: _resource_record_post_action 04:13:48 INFO - ##### 04:13:48 INFO - ##### Running create-virtualenv step. 04:13:48 INFO - ##### 04:13:48 INFO - Running pre-action listener: _resource_record_pre_action 04:13:48 INFO - Running main action method: create_virtualenv 04:13:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:48 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 04:13:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:48 INFO - Using real prefix '/usr' 04:13:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:50 INFO - Installing pip.................done. 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:13:50 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 04:13:50 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 04:13:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:51 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 04:13:51 INFO - Cleaning up... 04:13:51 INFO - Return code: 0 04:13:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13:51 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')]} 04:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:51 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')]} 04:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:51 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:13:51 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 04:13:51 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 04:13:51 INFO - Using env: {'DISPLAY': ':0', 04:13:51 INFO - 'HOME': '/home/cltbld', 04:13:51 INFO - 'LANG': 'en_US.UTF-8', 04:13:51 INFO - 'LANGUAGE': 'en_US:en', 04:13:51 INFO - 'LOGNAME': 'cltbld', 04:13:51 INFO - 'MAIL': '/var/mail/cltbld', 04:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:51 INFO - 'MOZ_NO_REMOTE': '1', 04:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:51 INFO - 'NO_EM_RESTART': '1', 04:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:51 INFO - 'PWD': '/builds/slave/test', 04:13:51 INFO - 'SHELL': '/bin/bash', 04:13:51 INFO - 'SHLVL': '1', 04:13:51 INFO - 'TERM': 'linux', 04:13:51 INFO - 'TMOUT': '86400', 04:13:51 INFO - 'USER': 'cltbld', 04:13:51 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:51 INFO - '_': '/tools/buildbot/bin/python'} 04:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:51 INFO - Downloading/unpacking psutil>=0.7.1 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:13:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:53 INFO - Installing collected packages: psutil 04:13:53 INFO - Running setup.py install for psutil 04:13:53 INFO - building 'psutil._psutil_linux' extension 04:13:53 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 04:13:53 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 04:13:53 INFO - building 'psutil._psutil_posix' extension 04:13:53 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 04:13:53 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 04:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:53 INFO - Successfully installed psutil 04:13:53 INFO - Cleaning up... 04:13:53 INFO - Return code: 0 04:13:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:13:53 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')]} 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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')]} 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:13:53 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 04:13:53 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 04:13:53 INFO - Using env: {'DISPLAY': ':0', 04:13:53 INFO - 'HOME': '/home/cltbld', 04:13:53 INFO - 'LANG': 'en_US.UTF-8', 04:13:53 INFO - 'LANGUAGE': 'en_US:en', 04:13:53 INFO - 'LOGNAME': 'cltbld', 04:13:53 INFO - 'MAIL': '/var/mail/cltbld', 04:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:53 INFO - 'MOZ_NO_REMOTE': '1', 04:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:53 INFO - 'NO_EM_RESTART': '1', 04:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:53 INFO - 'PWD': '/builds/slave/test', 04:13:53 INFO - 'SHELL': '/bin/bash', 04:13:53 INFO - 'SHLVL': '1', 04:13:53 INFO - 'TERM': 'linux', 04:13:53 INFO - 'TMOUT': '86400', 04:13:53 INFO - 'USER': 'cltbld', 04:13:53 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:53 INFO - '_': '/tools/buildbot/bin/python'} 04:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:13:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:13:55 INFO - Installing collected packages: mozsystemmonitor 04:13:55 INFO - Running setup.py install for mozsystemmonitor 04:13:55 INFO - Successfully installed mozsystemmonitor 04:13:55 INFO - Cleaning up... 04:13:55 INFO - Return code: 0 04:13:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:55 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')]} 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:55 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')]} 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:55 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:13:55 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 04:13:55 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 04:13:55 INFO - Using env: {'DISPLAY': ':0', 04:13:55 INFO - 'HOME': '/home/cltbld', 04:13:55 INFO - 'LANG': 'en_US.UTF-8', 04:13:55 INFO - 'LANGUAGE': 'en_US:en', 04:13:55 INFO - 'LOGNAME': 'cltbld', 04:13:55 INFO - 'MAIL': '/var/mail/cltbld', 04:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:55 INFO - 'MOZ_NO_REMOTE': '1', 04:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:55 INFO - 'NO_EM_RESTART': '1', 04:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:55 INFO - 'PWD': '/builds/slave/test', 04:13:55 INFO - 'SHELL': '/bin/bash', 04:13:55 INFO - 'SHLVL': '1', 04:13:55 INFO - 'TERM': 'linux', 04:13:55 INFO - 'TMOUT': '86400', 04:13:55 INFO - 'USER': 'cltbld', 04:13:55 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:55 INFO - '_': '/tools/buildbot/bin/python'} 04:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:55 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 04:13:55 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 04:13:55 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 04:13:55 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 04:13:55 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 04:13:55 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 04:13:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:58 INFO - Downloading docopt-0.6.1.tar.gz 04:13:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:58 INFO - Running setup.py install for blobuploader 04:13:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:58 INFO - Running setup.py install for requests 04:13:58 INFO - Running setup.py install for docopt 04:13:58 INFO - Successfully installed blobuploader requests docopt 04:13:58 INFO - Cleaning up... 04:13:58 INFO - Return code: 0 04:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:58 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:13:58 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 04:13:58 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 04:13:58 INFO - Using env: {'DISPLAY': ':0', 04:13:58 INFO - 'HOME': '/home/cltbld', 04:13:58 INFO - 'LANG': 'en_US.UTF-8', 04:13:58 INFO - 'LANGUAGE': 'en_US:en', 04:13:58 INFO - 'LOGNAME': 'cltbld', 04:13:58 INFO - 'MAIL': '/var/mail/cltbld', 04:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:58 INFO - 'MOZ_NO_REMOTE': '1', 04:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:58 INFO - 'NO_EM_RESTART': '1', 04:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:58 INFO - 'PWD': '/builds/slave/test', 04:13:58 INFO - 'SHELL': '/bin/bash', 04:13:58 INFO - 'SHLVL': '1', 04:13:58 INFO - 'TERM': 'linux', 04:13:58 INFO - 'TMOUT': '86400', 04:13:58 INFO - 'USER': 'cltbld', 04:13:58 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:58 INFO - '_': '/tools/buildbot/bin/python'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:59 INFO - Running setup.py (path:/tmp/pip-UxQPeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:59 INFO - Running setup.py (path:/tmp/pip-hnulG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:59 INFO - Running setup.py (path:/tmp/pip-ZqHCmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:59 INFO - Running setup.py (path:/tmp/pip-YgC3Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:59 INFO - Running setup.py (path:/tmp/pip-MkcPWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:59 INFO - Running setup.py (path:/tmp/pip-eI6GtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:59 INFO - Running setup.py (path:/tmp/pip-K6VBin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:59 INFO - Running setup.py (path:/tmp/pip-L9PvGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:59 INFO - Running setup.py (path:/tmp/pip-c81U_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:59 INFO - Running setup.py (path:/tmp/pip-bm9xDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:59 INFO - Running setup.py (path:/tmp/pip-gKhiJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:59 INFO - Running setup.py (path:/tmp/pip-FLwOFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:59 INFO - Running setup.py (path:/tmp/pip-4SfqGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:00 INFO - Running setup.py (path:/tmp/pip-e1Gtbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:00 INFO - Running setup.py (path:/tmp/pip-Pzn4um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:00 INFO - Running setup.py (path:/tmp/pip-wB069n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:00 INFO - Running setup.py (path:/tmp/pip-S_linf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:00 INFO - Running setup.py install for manifestparser 04:14:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozcrash 04:14:00 INFO - Running setup.py install for mozdebug 04:14:00 INFO - Running setup.py install for mozdevice 04:14:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozfile 04:14:00 INFO - Running setup.py install for mozhttpd 04:14:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:00 INFO - Running setup.py install for mozinfo 04:14:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Running setup.py install for mozInstall 04:14:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Running setup.py install for mozleak 04:14:01 INFO - Running setup.py install for mozlog 04:14:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Running setup.py install for moznetwork 04:14:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Running setup.py install for mozprocess 04:14:01 INFO - Running setup.py install for mozprofile 04:14:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Running setup.py install for mozrunner 04:14:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:01 INFO - Running setup.py install for mozscreenshot 04:14:01 INFO - Running setup.py install for moztest 04:14:02 INFO - Running setup.py install for mozversion 04:14:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:14:02 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 04:14:02 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 04:14:02 INFO - Using env: {'DISPLAY': ':0', 04:14:02 INFO - 'HOME': '/home/cltbld', 04:14:02 INFO - 'LANG': 'en_US.UTF-8', 04:14:02 INFO - 'LANGUAGE': 'en_US:en', 04:14:02 INFO - 'LOGNAME': 'cltbld', 04:14:02 INFO - 'MAIL': '/var/mail/cltbld', 04:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:02 INFO - 'MOZ_NO_REMOTE': '1', 04:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:02 INFO - 'NO_EM_RESTART': '1', 04:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:02 INFO - 'PWD': '/builds/slave/test', 04:14:02 INFO - 'SHELL': '/bin/bash', 04:14:02 INFO - 'SHLVL': '1', 04:14:02 INFO - 'TERM': 'linux', 04:14:02 INFO - 'TMOUT': '86400', 04:14:02 INFO - 'USER': 'cltbld', 04:14:02 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:02 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:02 INFO - Running setup.py (path:/tmp/pip-ZwUfnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:02 INFO - Running setup.py (path:/tmp/pip-fN35gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:02 INFO - Running setup.py (path:/tmp/pip-oPoV2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:02 INFO - Running setup.py (path:/tmp/pip-UQKlHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:02 INFO - Running setup.py (path:/tmp/pip-oxZz6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:02 INFO - Running setup.py (path:/tmp/pip-XCjvvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:02 INFO - Running setup.py (path:/tmp/pip-1bFsvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:02 INFO - Running setup.py (path:/tmp/pip-T8OwsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:02 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)) 04:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:02 INFO - Running setup.py (path:/tmp/pip-kRCU36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:03 INFO - Running setup.py (path:/tmp/pip-LNnvU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:03 INFO - Running setup.py (path:/tmp/pip-1Pzj_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:03 INFO - Running setup.py (path:/tmp/pip-VWrw0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:03 INFO - Running setup.py (path:/tmp/pip-Qu31bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:03 INFO - Running setup.py (path:/tmp/pip-xKkKfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:03 INFO - Running setup.py (path:/tmp/pip-_LwJU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:03 INFO - Running setup.py (path:/tmp/pip-6rEVOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:03 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)) 04:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:03 INFO - Running setup.py (path:/tmp/pip-vQoCng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:03 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)) 04:14:03 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)) 04:14:03 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)) 04:14:03 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)) 04:14:03 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)) 04:14:03 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)) 04:14:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:05 INFO - Downloading blessings-1.5.1.tar.gz 04:14:05 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 04:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:05 INFO - Installing collected packages: blessings 04:14:05 INFO - Running setup.py install for blessings 04:14:05 INFO - Successfully installed blessings 04:14:05 INFO - Cleaning up... 04:14:05 INFO - Return code: 0 04:14:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:05 INFO - Reading from file tmpfile_stdout 04:14:05 INFO - Current package versions: 04:14:05 INFO - argparse == 1.2.1 04:14:05 INFO - blessings == 1.5.1 04:14:05 INFO - blobuploader == 1.2.4 04:14:05 INFO - docopt == 0.6.1 04:14:05 INFO - manifestparser == 1.1 04:14:05 INFO - mozInstall == 1.12 04:14:05 INFO - mozcrash == 0.16 04:14:05 INFO - mozdebug == 0.1 04:14:05 INFO - mozdevice == 0.47 04:14:05 INFO - mozfile == 1.2 04:14:05 INFO - mozhttpd == 0.7 04:14:05 INFO - mozinfo == 0.9 04:14:05 INFO - mozleak == 0.1 04:14:05 INFO - mozlog == 3.1 04:14:05 INFO - moznetwork == 0.27 04:14:05 INFO - mozprocess == 0.22 04:14:05 INFO - mozprofile == 0.27 04:14:05 INFO - mozrunner == 6.11 04:14:05 INFO - mozscreenshot == 0.1 04:14:05 INFO - mozsystemmonitor == 0.0 04:14:05 INFO - moztest == 0.7 04:14:05 INFO - mozversion == 1.4 04:14:05 INFO - psutil == 3.1.1 04:14:05 INFO - requests == 1.2.3 04:14:05 INFO - wsgiref == 0.1.2 04:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 04:14:05 INFO - Using env: {'DISPLAY': ':0', 04:14:05 INFO - 'HOME': '/home/cltbld', 04:14:05 INFO - 'LANG': 'en_US.UTF-8', 04:14:05 INFO - 'LANGUAGE': 'en_US:en', 04:14:05 INFO - 'LOGNAME': 'cltbld', 04:14:05 INFO - 'MAIL': '/var/mail/cltbld', 04:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:05 INFO - 'MOZ_NO_REMOTE': '1', 04:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:05 INFO - 'NO_EM_RESTART': '1', 04:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:05 INFO - 'PWD': '/builds/slave/test', 04:14:05 INFO - 'SHELL': '/bin/bash', 04:14:05 INFO - 'SHLVL': '1', 04:14:05 INFO - 'TERM': 'linux', 04:14:05 INFO - 'TMOUT': '86400', 04:14:05 INFO - 'USER': 'cltbld', 04:14:05 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:05 INFO - '_': '/tools/buildbot/bin/python'} 04:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 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)) 04:14:05 INFO - Cleaning up... 04:14:05 INFO - Return code: 0 04:14:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:14:05 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 04:14:05 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 04:14:05 INFO - Using env: {'DISPLAY': ':0', 04:14:05 INFO - 'HOME': '/home/cltbld', 04:14:05 INFO - 'LANG': 'en_US.UTF-8', 04:14:05 INFO - 'LANGUAGE': 'en_US:en', 04:14:05 INFO - 'LOGNAME': 'cltbld', 04:14:05 INFO - 'MAIL': '/var/mail/cltbld', 04:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:05 INFO - 'MOZ_NO_REMOTE': '1', 04:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:05 INFO - 'NO_EM_RESTART': '1', 04:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:05 INFO - 'PWD': '/builds/slave/test', 04:14:05 INFO - 'SHELL': '/bin/bash', 04:14:05 INFO - 'SHLVL': '1', 04:14:05 INFO - 'TERM': 'linux', 04:14:05 INFO - 'TMOUT': '86400', 04:14:05 INFO - 'USER': 'cltbld', 04:14:05 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:05 INFO - '_': '/tools/buildbot/bin/python'} 04:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:06 INFO - Downloading/unpacking jsonschema 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:07 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 04:14:07 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:08 INFO - warning: no files found matching '*.txt' 04:14:08 INFO - no previously-included directories found matching 'build' 04:14:08 INFO - no previously-included directories found matching 'dist' 04:14:08 INFO - no previously-included directories found matching '.git*' 04:14:08 INFO - Installing collected packages: jsonschema, functools32 04:14:08 INFO - Running setup.py install for functools32 04:14:08 INFO - warning: no files found matching '*.txt' 04:14:08 INFO - no previously-included directories found matching 'build' 04:14:08 INFO - no previously-included directories found matching 'dist' 04:14:08 INFO - no previously-included directories found matching '.git*' 04:14:08 INFO - Successfully installed jsonschema functools32 04:14:08 INFO - Cleaning up... 04:14:08 INFO - Return code: 0 04:14:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:08 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 0x7fec760c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, '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': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', '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 04:14:08 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 04:14:08 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 04:14:08 INFO - Using env: {'DISPLAY': ':0', 04:14:08 INFO - 'HOME': '/home/cltbld', 04:14:08 INFO - 'LANG': 'en_US.UTF-8', 04:14:08 INFO - 'LANGUAGE': 'en_US:en', 04:14:08 INFO - 'LOGNAME': 'cltbld', 04:14:08 INFO - 'MAIL': '/var/mail/cltbld', 04:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:08 INFO - 'MOZ_NO_REMOTE': '1', 04:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:08 INFO - 'NO_EM_RESTART': '1', 04:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:08 INFO - 'PWD': '/builds/slave/test', 04:14:08 INFO - 'SHELL': '/bin/bash', 04:14:08 INFO - 'SHLVL': '1', 04:14:08 INFO - 'TERM': 'linux', 04:14:08 INFO - 'TMOUT': '86400', 04:14:08 INFO - 'USER': 'cltbld', 04:14:08 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:08 INFO - '_': '/tools/buildbot/bin/python'} 04:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:08 INFO - Downloading/unpacking flake8 04:14:08 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 04:14:08 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 04:14:08 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 04:14:08 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 04:14:08 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 04:14:08 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 04:14:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:10 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 04:14:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:10 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 04:14:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 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 04:14:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:10 INFO - no previously-included directories found matching 'docs/_build' 04:14:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:10 INFO - Running setup.py install for pep8 04:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:11 INFO - no previously-included directories found matching 'docs/_build' 04:14:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:11 INFO - Cleaning up... 04:14:11 INFO - Return code: 0 04:14:11 INFO - Running post-action listener: _resource_record_post_action 04:14:11 INFO - Running post-action listener: _start_resource_monitoring 04:14:11 INFO - Starting resource monitoring. 04:14:11 INFO - ##### 04:14:11 INFO - ##### Running install step. 04:14:11 INFO - ##### 04:14:11 INFO - Running pre-action listener: _resource_record_pre_action 04:14:11 INFO - Running main action method: install 04:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:11 INFO - Reading from file tmpfile_stdout 04:14:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:11 INFO - Reading from file tmpfile_stdout 04:14:11 INFO - Output received: 04:14:11 INFO - Usage: mozinstall [options] installer 04:14:11 INFO - Options: 04:14:11 INFO - -h, --help show this help message and exit 04:14:11 INFO - -d DEST, --destination=DEST 04:14:11 INFO - Directory to install application into. [default: 04:14:11 INFO - "/builds/slave/test"] 04:14:11 INFO - --app=APP Application being installed. [default: firefox] 04:14:11 INFO - mkdir: /builds/slave/test/build/application 04:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:25 INFO - Reading from file tmpfile_stdout 04:14:25 INFO - Output received: 04:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:25 INFO - Running post-action listener: _resource_record_post_action 04:14:25 INFO - ##### 04:14:25 INFO - ##### Running run-tests step. 04:14:25 INFO - ##### 04:14:25 INFO - Running pre-action listener: _resource_record_pre_action 04:14:25 INFO - Running main action method: run_tests 04:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:25 INFO - Python 2.7.3 04:14:25 INFO - Return code: 0 04:14:25 INFO - grabbing minidump binary from tooltool 04:14:25 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')]} 04:14:25 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 0x1dfa0b0>, '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 0x1dfafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:25 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 04:14:25 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 04:14:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:26 INFO - Return code: 0 04:14:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:26 INFO - Return code: 0 04:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test/build 04:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 04:14:26 INFO - Using env: {'DISPLAY': ':0', 04:14:26 INFO - 'HOME': '/home/cltbld', 04:14:26 INFO - 'LANG': 'en_US.UTF-8', 04:14:26 INFO - 'LANGUAGE': 'en_US:en', 04:14:26 INFO - 'LOGNAME': 'cltbld', 04:14:26 INFO - 'MAIL': '/var/mail/cltbld', 04:14:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:26 INFO - 'MOZ_NO_REMOTE': '1', 04:14:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:26 INFO - 'NO_EM_RESTART': '1', 04:14:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:26 INFO - 'PWD': '/builds/slave/test', 04:14:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:26 INFO - 'SHELL': '/bin/bash', 04:14:26 INFO - 'SHLVL': '1', 04:14:26 INFO - 'TERM': 'linux', 04:14:26 INFO - 'TMOUT': '86400', 04:14:26 INFO - 'USER': 'cltbld', 04:14:26 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156', 04:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:26 INFO - '_': '/tools/buildbot/bin/python'} 04:14:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 04:14:27 INFO - mozversion INFO | application_buildid: 20151215031211 04:14:27 INFO - mozversion INFO | application_changeset: 038664873a7bb62ef3fc904511dc063a28e601a4 04:14:27 INFO - mozversion INFO | application_display_name: Nightly 04:14:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:27 INFO - mozversion INFO | application_name: Firefox 04:14:27 INFO - mozversion INFO | application_remotingname: firefox 04:14:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:14:27 INFO - mozversion INFO | application_vendor: Mozilla 04:14:27 INFO - mozversion INFO | application_version: 46.0a1 04:14:27 INFO - mozversion INFO | platform_buildid: 20151215031211 04:14:27 INFO - mozversion INFO | platform_changeset: 038664873a7bb62ef3fc904511dc063a28e601a4 04:14:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:14:27 INFO - mozversion INFO | platform_version: 46.0a1 04:14:27 INFO - 2015-12-15 04:14:27,167 DEBUG : using testdate: 1450181667 04:14:27 INFO - 2015-12-15 04:14:27,167 DEBUG : actual date: 1450181667 04:14:27 INFO - 2015-12-15 04:14:27,177 INFO : starting webserver on 'localhost:60883' 04:14:27 INFO - 2015-12-15 04:14:27,178 INFO : Starting test suite talos-linux64-ix-049.e 04:14:27 INFO - 2015-12-15 04:14:27,178 INFO : Starting test dromaeo_css 04:14:27 INFO - 2015-12-15 04:14:27,178 DEBUG : operating with platform_type : linux_ 04:14:27 INFO - 2015-12-15 04:14:27,179 INFO : Initialising browser for dromaeo_css test... 04:14:27 INFO - 2015-12-15 04:14:27,196 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqYICQU/profile http://localhost:60883/getInfo.html 04:14:31 INFO - 2015-12-15 04:14:31,762 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:14:31 INFO - 2015-12-15 04:14:31,762 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:14:31 INFO - 2015-12-15 04:14:31,762 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:14:31 INFO - 2015-12-15 04:14:31,762 DEBUG : BROWSER_OUTPUT: __metrics 04:14:31 INFO - 2015-12-15 04:14:31,899 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] 04:14:32 INFO - 2015-12-15 04:14:32,806 INFO : Browser initialized. 04:14:32 INFO - 2015-12-15 04:14:32,806 INFO : Running cycle 1/1 for dromaeo_css test... 04:14:32 INFO - 2015-12-15 04:14:32,807 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqYICQU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:14:44 INFO - 2015-12-15 04:14:44,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 143093760 04:14:44 INFO - 2015-12-15 04:14:44,914 DEBUG : BROWSER_OUTPUT: 04:15:34 INFO - 2015-12-15 04:15:34,562 DEBUG : BROWSER_OUTPUT: 1450181734561 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] 04:17:45 INFO - 2015-12-15 04:17:45,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60883/tests/dromaeo/cssquery-ext.html) 04:17:47 INFO - 2015-12-15 04:17:47,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 146944000 04:17:47 INFO - 2015-12-15 04:17:47,102 DEBUG : BROWSER_OUTPUT: 04:20:49 INFO - 2015-12-15 04:20:49,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/dromaeo/cssquery-ext.html (next: http://localhost:60883/tests/dromaeo/cssquery-jquery.html) 04:20:49 INFO - 2015-12-15 04:20:49,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 143134720 04:20:49 INFO - 2015-12-15 04:20:49,823 DEBUG : BROWSER_OUTPUT: 04:23:51 INFO - 2015-12-15 04:23:51,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60883/tests/dromaeo/cssquery-mootools.html) 04:23:52 INFO - 2015-12-15 04:23:52,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 145936384 04:23:52 INFO - 2015-12-15 04:23:52,211 DEBUG : BROWSER_OUTPUT: 04:26:54 INFO - 2015-12-15 04:26:54,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60883/tests/dromaeo/cssquery-prototype.html) 04:26:54 INFO - 2015-12-15 04:26:54,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 143970304 04:26:54 INFO - 2015-12-15 04:26:54,604 DEBUG : BROWSER_OUTPUT: 04:29:57 INFO - 2015-12-15 04:29:57,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60883/tests/dromaeo/cssquery-yui.html) 04:29:57 INFO - 2015-12-15 04:29:57,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 144183296 04:29:57 INFO - 2015-12-15 04:29:57,738 DEBUG : BROWSER_OUTPUT: 04:32:59 INFO - 2015-12-15 04:32:59,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/dromaeo/cssquery-yui.html (next: http://localhost:60883/tests/dromaeo/cssquery-dojo.html) 04:33:00 INFO - 2015-12-15 04:33:00,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 147550208 04:33:00 INFO - 2015-12-15 04:33:00,214 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,215 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:00 INFO - 2015-12-15 04:33:00,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:00 INFO - 2015-12-15 04:33:00,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:00 INFO - 2015-12-15 04:33:00,215 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:00 INFO - 2015-12-15 04:33:00,216 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2625.829321094129;2692.5961105834135;2718.605802158687;2720.4695084458513;2741.972580274197;4676.7427791471455;4775.450823155343;4799.760011999403;4800.735959522225;4818.301346304784;4674.813007479705;4691.29630555416;4716.410448693913;4883.389576302962;4886.438059623144;4341.587549182823;4435.379046933432;4508.278675411935;4527.026689261808;4552.385427967215;4365.908522869283;4402.691811573191;4419.801108950089;4421.027373977719;4448.510663826993;4176.081262122329;4281.978590107061;4389.736615803062;4393.956060439386;4520.186366454037;4275.995141141829;4371.475422949235;4372.994211331412;4396.472423309224;4409.140217657526;4312.892177695583;4353.5428779977965;4371.34429835524;4380.60574548289;4396.340548917688;4436.534163912807;4575.290829921334;4602.654800889946;4621.838235661769;4679.134360143385;5059.3169922060415;5072.492750724935;5095.923561146586;5113.079645663779;5145.691258524463;5103.923441148386;5108;5114.33513643224;5121.487851214849;5172.353455818023;4530.048689775184;4633.0733853229485;4703.600193983481;4750.857474275777;4825.155597770447;5158.948410515922;5177.637565370388;5178.741062946838;5191.247269146028;5192.039472697563;4946.4064312282035;4963.677360971526;4979;4979.90040199194;5001.674891132065;4941.110600092018;4993.101241776442;5068.0370729562;5074.188129899272;5141.614378921596;4998.100341938413;5000.249962505581;5017.523335283142;5019.29729837823;5051.368578927634;4828.95171048292;4989.775460104304;4991.625628077836;4998.100341938413;5031.396232452056;4058.8782336529953;4135.6898232632075;4144.171165766858;4154.688398370074;4170.91658166835;3693.3351996640863;3697.500837386918;3715.5169827922196;3720.2373513429684;3744.0078379229526;4190.266703326905;4403.251447253974;4403.8238470461465;4408.7575183365225;4424.7123936944;4944.9258261126115;5033.723145226974;5116.692998420107;5131.538161565477;5151.124308867502;4363.825446982149;4420.31485119807;4431.7340959542535;4443.622292105208;4448.088141930896;4286.935695964563;4398.560143985575;4523.886902827456;4531.252343363308;4551.704139230939;4754.95245047552;4769.689970151929;4846.17615005457;4867.610591152699;4894.045661096124;5064.518870707277;5092.8472145835685;5098.9490105098475;5102.36220472441;5144.511271429208;4612.331211974178;4730.9763451182525;4750.358701575381;4851;4928.802847886044;4883.780229889735;4943.332650092191;4947.257911313188;4971.676841005323;4993.675411098267;5073.086844368049;5076.238564215398;5078.289039534542;5082.288479612931;5129.7691603877165;4733.313669517832;4794.041191761592;4856.660033797601;4917.975410122926;4967.379077615298;4951.554360107608;4959.553640172402;4966.379202599675;4966.428860681068;5003.849884503471;4842.539958703917;4852.781624826962;4860.416749990024;4871.561559459666;4911.091448082117;4772.904541909073;4903.16646170159;4935.703857768545;5050.747462626928;5071.163258062378;4837.806487740451;4871.098846713369;4877.975610121926;4878.56092951636;4899.534544218293 04:33:00 INFO - 2015-12-15 04:33:00,220 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.1126009644667;562.7748900439826;571.7112858006709;572.8882867840772;574.4140976204271;30240.848795756046;31502;31511.36977260456;31542.68457315426;31644.525332120036;40128.59871401285;40380.59619403805;40412;40617.18765624693;40675.18649627006;7825.060992680872;7936.127026027132;7982.241687039722;8023.077346105185;8043.075046369684;7886.6845326186885;7935.682572697114;7941.523508589503;7960.601969901481;7973.401994850409;7877.094134174586;7977.680892764282;7985.680572777082;7988.7203947861835;8007.31937785286;7887.684492620288;7950.880736788953;7954.363650907913;7961.522308661499;7984.960075199587;7820.217978202191;7911.406644501685;7924.732042873113;7929.444938854283;7952.8409431811615;36524;36995.26009479795;37054.44418333727;37100.62899370999;37161.070973225615;2894.9276268093254;3000.489916714164;3027.3793872256133;3322.983385083059;3737.682297004758;27091.1872643821;27320.453590928268;27404.725952740417;27472.725272747215;27968.860155699294;3432.6910578048096;3455.4298540740747;3463.8787642432644;3506.9649303506894;3551.449525323579;215249;215629;215635;215761.9211903946;216285;36254;54342.18486722702;54679.453205468235;54681;54854.45145548573;41006.79496602498;55944.16083758747;57326;57385;57620.71189644025;14720.411183552538;15009.249537523081;15010.324535395934;15017.924910375377;15045.774313385307;10893.727656808644;10941.56233750641;10968.780624387628;10985.670429886957;11020.283681560673;18538.25846966106;18727.812721872608;18904.432867014013;18933.81066189348;18952.905235473736;7530.962345188239;7812.218778122142;7911.881321780178;7917.445778795429;8064.709646456538;805.5529181304315;838.6142374507795;965.918171647759;982.832918403873;994.4480813148627;25802.48395032089;25948.74051259501;26228.868855655983;26363.73636263651;26400.339991499983;906.2251774732508;943.5887227212753;1018.8115198688266;1036.8600238967795;1122.2212792723624;13461.192328460324;13911.23488208138;13921.651958701113;13974.441022359195;15125;260609;263591;263703;265074;266372;46440;46620;46627;46755.76622116868;46761.5323846764;1229.465182645552;1235.2711899979056;1236.3076677060874;1240.1443004327166;1253.360785999147;26473.33816654522;26579.60130598004;26716.599251010863;26822.329441764112;27068.45863082688;39788.403173953;40264;40268.395974061;40327;40406.79796600998;246996;248361;248488;248819;249082;27963.300917477227;28737;29244.41511169722;29254.853725731235;29312.534373280825;34464.82767586146;34501.48247776235;34616.65383346134;34981.07524324721;35115.82442087773;31887.84056079705;31889.840550797097;32479.837600811843;33242.168945776546;33297.83351083229;32126.03621891347;33832.830835846646;34412.291095499786;34554.65445345615;34699.47950780791;32601.34797304088;32883.50674739929;32999.67000329966;33129.50305745367;33234.16914577155;27476.45047099007;30004.84997574998;30203.848980754956;30294.545581815848;30684;22967.540649186587;25392.746072539037;25522.617160742233;25660.35849103713;25872.611910820975 04:33:00 INFO - 2015-12-15 04:33:00,220 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.8775752971401;331.74455669134767;334.16292188068894;334.7706820827732;334.92129349602845;14843.851561484382;15348.079115253078;15869.841301586981;16449.342026318947;16498;15214.771778423332;15239.31423085961;15249.84750152501;15265.38938442461;15852.128132952683;4708.646851486135;5040.395152581696;5041.067402530525;5042.0168067226905;5042.4201216860165;5082.974585127069;5103.56619687327;5126.461721519243;5131.050755610224;5132.820351287705;4494.438195225597;4782.402199725035;4839.7338146401935;4978.327925730035;4996.350474438318;4877.292792545061;4905.828296009622;4925.876853078666;4931.235658472942;4967.602591792648;4984.077945580043;5032.823851165228;5048.1670524363435;5053.36832895888;5062.190049592047;10109.090181883592;10285.292032393674;10402.27184097106;19046.238150474102;19057.142428590745;1767.1252729898654;1870.7568016157813;1888.1975160556708;1896.753422055138;1922.5196598619125;9029.277657787361;9201.079892010812;12208.32854193019;12664.176828506117;12755.61733148007;1770.725537541683;1804.6571151481176;1808.2766893242676;1810.6650269700147;1824.4982629776785;55670.72164639151;58976.41023589795;60361.094583580845;60537.09194362044;61362.38637613611;9174.770630734152;9183.58673859678;9187.908120918839;9490.525473726424;9534.856977145348;11397.430128493543;11412.42937853104;11449.198556100993;11475.713107172387;11494.137939654393;6952.130983627047;7005.299470053056;7012.439004879598;7085.362317391459;7152.892706609405;6850.828729281808;6864.862702746017;6893.862122757617;6912.619805910723;6925.376716095576;3728.9627103728617;3739.9813000934823;3785.337565925952;3788.976976216406;3790.6588407042946;1764.841164295194;1772.5480002599254;1795.0486242291606;1804.8375646191644;1818.7362832389229;776.945613807028;815.902091748982;849.9192576705203;883.726044926075;994.3487016004528;14561.126332420088;14625;14762.114273143647;15081.924590377197;15138.318775655121;858.4977787993969;861.3195575495414;874.7681864305964;885.7741275974586;892.6429428228761;8570.314374850122;8881.866771998426;9028.503432311154;9302.395344302598;9354.111359420844;449045;449415;450402;452768;457200;73549.26450735531;75113.24886751063;75577;76299;76939.61530192313;1102.8511150994514;1116.983245251322;1124.2130508643982;1145.9369734664674;1149.4367759797806;14987.925060374628;15030.323635436212;15140.318685659393;15176.165310908005;15334.693306134039;34101.82949085239;34731.4790278141;34914.127146821535;35714.64285357113;36245;44612.33081503845;46283.53716462792;46398.76800615976;47614.523854761006;48281.75859120682;8996.955015225143;9031.322650801347;9064;9094.499802510662;9157.31320150978;15478.380864765284;15502.612434689223;16074.67850643004;16243.918780406022;16422.096784676956;11299.322040677585;13370;13562.321883905568;13693.178409295475;14001.43994240219;13106.344682765633;13345.466181352636;13769.173849569059;14507;14507.78238326447;13359.799603005767;14141.575752727435;14225.288735563387;14521.273936303354;14779.334929928395;8261.752147435587;8375.478471271785;8398.286145677686;8466.830663386821;8540.914590854012;9032.45805251687;10891.237613366988;13238.536651217546;13369.064165508322;14273.785893211403 04:33:00 INFO - 2015-12-15 04:33:00,220 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1460.1093333066833;1645.9259333330003;1683.1668324179534;1709.9658006839863;1725.611737359094;6722.529422940396;6810.557313774608;6887.4490040796745;7031.929680703198;7032.859342813141;6931.549449285793;6998.1952075511335;7027.613481258529;7029.824254393643;7049.894251586217;2013.7482814648206;2050.5693804301113;2052.3124753207617;2052.9897350513224;2054.034603736249;1988.1848442138726;1998.99000504998;2025.6151331247015;2084.718562993999;2087.7912208779153;1659.444086231114;1692.272322901152;2000.9299674511394;2053.035073515445;2079.396974877284;1940.6506828770816;1943.6015616798593;1944.7666280046485;1950.1809240119185;1956.3544030469911;1997.3808119482862;2000.449876284019;2084;2088.363049269972;2089.686547017944;6785.660716964132;6914.827129321757;6919.757808476679;6946.027556142144;6948.687309071104;4051.210014047262;4105;4115.54728979812;4119.134981653856;4127.463429754142;2615.973840261592;2637.9472410551875;2698.7571118599226;2713.8236014658983;2722.564389697639;826.2192228344217;827.8385714785619;842.6376658037042;871.1332224436662;889.4129874283007;8642.783930401727;8690.217880390732;8697.391182617219;8699.695510657097;8733.170348816915;3561.4479755637917;3595.8381872815785;3651.9634803652157;3660.890173294805;3692.4830523726164;6905.620190889549;6908.274631163656;6921.273266307066;6935.063766391573;6953;4011.2178125265877;4020.43713880057;4026.174634199982;4031.1333063390925;4037.515498140242;3657.487951686766;3660.4143337065943;3662.597114317476;3669.4679271505483;3674.6692797647806;3023.591815104977;3060.0360886320736;3060.7704422168426;3065.92335191622;3066.9693303066683;929.5723966975268;934.3272843552631;939.2908354192678;945.7068308824287;946.0255936385533;760.3461023519768;817.6892780743399;915.1214833759532;1167.9240849344935;1198.0774803401507;6249.0938813871735;6267.122602835607;6293.937060629335;6320.462760665395;6343;530.1385248970423;532.0662237772684;576.4407278312156;582.9591928565045;695.1415002471944;4773.331733557305;4790.760461976887;4823.252395878644;4833.903321933612;4876.82931097417;7813.765587032398;7910.920890791133;8118.553479558681;8128.309093727099;8155;7922.683092676229;8000.079990801132;8001.1198768135455;8028.919710802934;8042.879356809653;6300.338464461257;6389.616623002635;6409.359064093554;6465.806025819233;6478.02829575558;5952.76188952437;5963.970180149072;5973.163757073926;5978.521718262442;5993.430624090704;6810.250872403933;7152.6066066364765;7249.963750181215;7252.093488313961;7297.525660832029;7284.599347035964;7355.705771769283;7378.741744038933;7523.962380188064;7530.887036694564;5930.52555795544;5945.762169513171;5972;5979.222701048836;5986.55100867428;6464.127342808661;6472.320406357265;6545;6580.440662543738;6581.934180658323;6007.189029480965;6169.5064394849205;6203.06953956892;6220.595661282002;6228.128062071404;5718.142278658234;5916.467517923407;6156.07658851158;6209.658468784261;6297.086922396318;5984.042553191469;6025.1564780931585;6026.608270462406;6041.9395806041375;6043.244594425697;5488.588355873405;5569.944300556943;5574.9163762542785;5596.608237423341;5619.353774316006;5563.721813909369;5643.35101463337;5644.6613203207935;5667.659940403589;5667.716614169192 04:33:00 INFO - 2015-12-15 04:33:00,221 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.6744448551079;301.22584956661376;307.36222338647315;307.5647958139233;308.65893188027235;5508.944910550893;5523.088690366089;5548.389677135517;5565.554755619551;5614;5484.972575137119;5493.587980901439;5502.367227768807;5513.696746678931;5518.034343989806;4075.9184816303805;4224.556421575737;4231.555686652903;4237.6609871210385;4238.364245363205;4144.606262405066;4145.813438395279;4156.085661154541;4167.354060120671;4170.666346692257;4109.815058322382;4112.588741125878;4115.464989551369;4117.5882411758885;4125.2780763366445;4101.5488296287385;4106.589341065899;4109.3425051991535;4121.52602450719;4125.690573207022;3582.229820588586;3601.9099522511883;3614.7469677122613;3614.9096272593397;3619.402798538238;5191.117510023305;5315.893682126374;5321.627486075938;5322.893542129174;5324;4793.921367692276;4809.591184749301;4810.518948105197;4814.422269327703;4815.951840481621;5762.567807414461;5769.163471296639;5771.220885180489;5791.102379131242;5801.955647983361;3936.744111632763;3940.133170702441;3941.1329507508303;3943.98028009861;3954.387070004154;5962.642241465526;6018.608790428608;6075.544334174954;6084.056971169476;6101.450869421729;4073.6333729964445;4079.3065178919655;4081.551029386765;4081.9591804082174;4086.9182616347507;4124.092699606082;4138.79306034697;4142.668586513132;4150.3566947122645;4153.958460415357;4775.498572649891;4785.114753770564;4792.161371759928;4805.255185446262;4805.27920811881;5549.528290095306;5643.95586816432;5773.740181691834;5789.681567513827;5796.072628379523;1455.0687559961632;1473.0572433642478;1473.4548217159506;1473.616859616486;1473.8305094914008;969.3844408800321;980.8626792249091;981.3768257156756;993.8906720260766;998.8862418403428;5012.273220383024;5045.84862454127;5046.646734728533;5052.8484145475695;5060.418051924076;5990.131430942489;5991.161237426763;5992.520598352121;6023.2772067351325;6029.336772954972;5034.270030845581;5034.622403319766;5043.420006699203;5045.142325804622;5048.217526283432;3189.6650851660706;3227.128675257667;3250.5449237106823;3258.869645214212;3261.445554255782;5650.3502097258515;5658.321001479767;5664.575156863251;5682.801101961411;5694.4590263924865;6169.876602468015;6171.660558669317;6172.845678858064;6176.104464852661;6185.505159587222;5530.308711411074;5592.440755924375;5646.435356464321;5647.322321321468;5673.177389278614;6000;6010.398960103955;6013.789517366871;6016.2479690038745;6027.18632984559;5829.7085145743395;5862.237909071793;5863.472287494146;5865.73604187804;5878.529717622494;5636.774529018793;5661.547076233809;5673;5681.375048744718;5695.088785794253;4025.255327764373;4078.184363127327;4108.568600296926;4108.609682080198;4114.876553703393;5911.615744976562;5994.910076348945;5996.280446346466;5999.850003749767;6058.303295121117;5768.769249229984;5827.475527202572;5845.444682755132;5850.824475265749;5859.091840764689;5742.885142297047;5757.9424205757405;5820.505257053029;5830.2129212555765;5854.502367298827;5588.972055139699;5683.9715801420725;5698.800541981011;5698.886022279614;5707.486326230659;5787.247657804459;5806.82579522615;5831.1836342912875;5833.79581714638;5840.1531777892815;5708.514776244066;5708.885822283448;5713.857153571028;5715.028445164249;5718.199452076629 04:33:00 INFO - 2015-12-15 04:33:00,222 DEBUG : BROWSER_OUTPUT: |5;yui.html;695.6973716433349;726.1757904778075;771.6643260181821;772.339649599592;773.3503856760321;11901.58344457944;11985.820212696806;12039.458224379901;12089.939550302237;12146.878531214685;11247.775044499105;11284.322940623548;11289.09687225022;11295.49170287337;11305.095592352613;422.66609378590874;422.9069604686964;792.6512334572799;793.1632128104861;817.7546735979212;805.7220259010631;810.7689308547066;813.9186081391844;817.1175130858659;818.9058258300312;844.4553263145268;858.9699360522383;860.8751730999032;860.956952152393;862.3532350736947;842.4692443760453;846.3398549131656;848.0544193224541;850.3792231670853;852.0882655558555;627.6328347916474;631.059721015688;631.2393565753256;631.908373285871;632.3707910628908;11686.415679216005;11825;11884.049276057982;11898.405079746064;11916.106292028133;10013.449260290681;10625.521851516623;11092.944535277353;11233;11277.097832173406;9473.952630236874;9554.092361225672;9555.27014128011;9558.761030974212;9676.806463870684;3245.237369218232;3273.4107860585086;3283.9835800820842;3292.423825830494;3297.3075654112663;38568.42147367792;38585.22829543393;38975.22049559021;39080;40185;8977.955110224408;9012.909870901338;9015.27877769777;9084.22784063362;9174.311926605531;16679.91660041692;16758.74861877073;16758.74861877073;16830.915845420695;16837.32650693983;6248.218972628421;6264.592801467981;6395.936040639627;6491.772787952494;6499.252585952676;3407.897763067112;3457.567804024497;3526.7354948378975;3572.017695133859;3580.5166302548823;2577.78088862445;2622.895084196649;2623.77697895681;2624.3439140214946;2626.7898568114506;447.76268577653894;453.67108846086984;453.69148978694807;453.9445788541654;457.7459509971931;472.89123501594827;551.9806806761744;563.8646724786104;564.3679079431064;566.7619599768108;7151.678174482161;7239.348458638748;7698.961505192438;8009.399295052895;8248.917510824935;455.2852022324984;532.8534652970386;550.204953841703;573.6844735395516;618.6473709985265;3674.706023518112;3675.7243206759067;3717.182219911615;3748.250349930025;3784.8902491131666;49565;50030;50581.24128138081;50676.239856402186;51018.48981510212;44181.337279940824;44388.112237755064;44404.777976109915;44476.55523444724;44755;40825;41257.58742412538;42022.78988605038;42173.789131054145;42386.364204536956;7433.25667433274;7480.513766605153;7485.887711684438;7539.811504712206;7708.075030996316;30621.846890765402;30842.074737757903;31014.68985310118;31709.36581268408;31946.20134496656;35992.820035899655;37992.810035949646;40105.39841902316;40202;40212.1957560853;9643.855342170013;9756.804863902824;9838.06538378853;9936.403815770787;9940.950295248478;10987.61543345979;11067.557297708001;11103.50034248477;11870.940645296718;11871.050315974873;10006.11888546748;10101.545430455793;10332.586696532055;10363.740906477096;10372.533236004549;10423.791524169626;10540.525676344736;10865.674029779118;10932.930104852656;11149.72125696864;9343.34596578233;9405.576749046173;9482.762930926781;9512.524373781145;9668.323217374716;9387.953060234655;9563.569639366384;9571.760705982406;9604.9039509604;9612.375195612263;8749.518776467356;8752.69365572202;8926.509042002752;9037.909620903707;9197.356185066981 04:33:00 INFO - 2015-12-15 04:33:00,222 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:00 INFO - 2015-12-15 04:33:00,222 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:00 INFO - 2015-12-15 04:33:00,222 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: __startTimestamp1450182780213__endTimestamp 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,223 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4675.84 Median:4837.81 stddev:488.92 (10.1%) stddev-sans-first:463.21 04:33:00 INFO - 2015-12-15 04:33:00,224 DEBUG : BROWSER_OUTPUT: Values: 2625.8 2692.6 2718.6 2720.5 2742.0 4676.7 4775.5 4799.8 4800.7 4818.3 4674.8 4691.3 4716.4 4883.4 4886.4 4341.6 4435.4 4508.3 4527.0 4552.4 4365.9 4402.7 4419.8 4421.0 4448.5 4176.1 4282.0 4389.7 4394.0 4520.2 4276.0 4371.5 4373.0 4396.5 4409.1 4312.9 4353.5 4371.3 4380.6 4396.3 4436.5 4575.3 4602.7 4621.8 4679.1 5059.3 5072.5 5095.9 5113.1 5145.7 5103.9 5108.0 5114.3 5121.5 5172.4 4530.0 4633.1 4703.6 4750.9 4825.2 5158.9 5177.6 5178.7 5191.2 5192.0 4946.4 4963.7 4979.0 4979.9 5001.7 4941.1 4993.1 5068.0 5074.2 5141.6 4998.1 5000.2 5017.5 5019.3 5051.4 4829.0 4989.8 4991.6 4998.1 5031.4 4058.9 4135.7 4144.2 4154.7 4170.9 3693.3 3697.5 3715.5 3720.2 3744.0 4190.3 4403.3 4403.8 4408.8 4424.7 4944.9 5033.7 5116.7 5131.5 5151.1 4363.8 4420.3 4431.7 4443.6 4448.1 4286.9 4398.6 4523.9 4531.3 4551.7 4755.0 4769.7 4846.2 4867.6 4894.0 5064.5 5092.8 5098.9 5102.4 5144.5 4612.3 4731.0 4750.4 4851.0 4928.8 4883.8 4943.3 4947.3 4971.7 4993.7 5073.1 5076.2 5078.3 5082.3 5129.8 4733.3 4794.0 4856.7 4918.0 4967.4 4951.6 4959.6 4966.4 4966.4 5003.8 4842.5 4852.8 4860.4 4871.6 4911.1 4772.9 4903.2 4935.7 5050.7 5071.2 4837.8 4871.1 4878.0 4878.6 4899.5 04:33:00 INFO - 2015-12-15 04:33:00,224 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,224 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40092.61 Median:33238.17 stddev:63344.86 (190.6%) stddev-sans-first:63453.01 04:33:00 INFO - 2015-12-15 04:33:00,224 DEBUG : BROWSER_OUTPUT: Values: 558.1 562.8 571.7 572.9 574.4 30240.8 31502.0 31511.4 31542.7 31644.5 40128.6 40380.6 40412.0 40617.2 40675.2 7825.1 7936.1 7982.2 8023.1 8043.1 7886.7 7935.7 7941.5 7960.6 7973.4 7877.1 7977.7 7985.7 7988.7 8007.3 7887.7 7950.9 7954.4 7961.5 7985.0 7820.2 7911.4 7924.7 7929.4 7952.8 36524.0 36995.3 37054.4 37100.6 37161.1 2894.9 3000.5 3027.4 3323.0 3737.7 27091.2 27320.5 27404.7 27472.7 27968.9 3432.7 3455.4 3463.9 3507.0 3551.4 215249.0 215629.0 215635.0 215761.9 216285.0 36254.0 54342.2 54679.5 54681.0 54854.5 41006.8 55944.2 57326.0 57385.0 57620.7 14720.4 15009.2 15010.3 15017.9 15045.8 10893.7 10941.6 10968.8 10985.7 11020.3 18538.3 18727.8 18904.4 18933.8 18952.9 7531.0 7812.2 7911.9 7917.4 8064.7 805.6 838.6 965.9 982.8 994.4 25802.5 25948.7 26228.9 26363.7 26400.3 906.2 943.6 1018.8 1036.9 1122.2 13461.2 13911.2 13921.7 13974.4 15125.0 260609.0 263591.0 263703.0 265074.0 266372.0 46440.0 46620.0 46627.0 46755.8 46761.5 1229.5 1235.3 1236.3 1240.1 1253.4 26473.3 26579.6 26716.6 26822.3 27068.5 39788.4 40264.0 40268.4 40327.0 40406.8 246996.0 248361.0 248488.0 248819.0 249082.0 27963.3 28737.0 29244.4 29254.9 29312.5 34464.8 34501.5 34616.7 34981.1 35115.8 31887.8 31889.8 32479.8 33242.2 33297.8 32126.0 33832.8 34412.3 34554.7 34699.5 32601.3 32883.5 32999.7 33129.5 33234.2 27476.5 30004.8 30203.8 30294.5 30684.0 22967.5 25392.7 25522.6 25660.4 25872.6 04:33:00 INFO - 2015-12-15 04:33:00,224 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,225 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25620.68 Median:3789.82 stddev:74003.68 (1952.7%) stddev-sans-first:74186.92 04:33:00 INFO - 2015-12-15 04:33:00,226 DEBUG : BROWSER_OUTPUT: Values: 330.9 331.7 334.2 334.8 334.9 14843.9 15348.1 15869.8 16449.3 16498.0 15214.8 15239.3 15249.8 15265.4 15852.1 4708.6 5040.4 5041.1 5042.0 5042.4 5083.0 5103.6 5126.5 5131.1 5132.8 4494.4 4782.4 4839.7 4978.3 4996.4 4877.3 4905.8 4925.9 4931.2 4967.6 4984.1 5032.8 5048.2 5053.4 5062.2 10109.1 10285.3 10402.3 19046.2 19057.1 1767.1 1870.8 1888.2 1896.8 1922.5 9029.3 9201.1 12208.3 12664.2 12755.6 1770.7 1804.7 1808.3 1810.7 1824.5 55670.7 58976.4 60361.1 60537.1 61362.4 9174.8 9183.6 9187.9 9490.5 9534.9 11397.4 11412.4 11449.2 11475.7 11494.1 6952.1 7005.3 7012.4 7085.4 7152.9 6850.8 6864.9 6893.9 6912.6 6925.4 3729.0 3740.0 3785.3 3789.0 3790.7 1764.8 1772.5 1795.0 1804.8 1818.7 776.9 815.9 849.9 883.7 994.3 14561.1 14625.0 14762.1 15081.9 15138.3 858.5 861.3 874.8 885.8 892.6 8570.3 8881.9 9028.5 9302.4 9354.1 449045.0 449415.0 450402.0 452768.0 457200.0 73549.3 75113.2 75577.0 76299.0 76939.6 1102.9 1117.0 1124.2 1145.9 1149.4 14987.9 15030.3 15140.3 15176.2 15334.7 34101.8 34731.5 34914.1 35714.6 36245.0 44612.3 46283.5 46398.8 47614.5 48281.8 8997.0 9031.3 9064.0 9094.5 9157.3 15478.4 15502.6 16074.7 16243.9 16422.1 11299.3 13370.0 13562.3 13693.2 14001.4 13106.3 13345.5 13769.2 14507.0 14507.8 13359.8 14141.6 14225.3 14521.3 14779.3 8261.8 8375.5 8398.3 8466.8 8540.9 9032.5 10891.2 13238.5 13369.1 14273.8 04:33:00 INFO - 2015-12-15 04:33:00,226 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,226 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4683.01 Median:5981.63 stddev:2401.16 (40.1%) stddev-sans-first:2395.68 04:33:00 INFO - 2015-12-15 04:33:00,226 DEBUG : BROWSER_OUTPUT: Values: 1460.1 1645.9 1683.2 1710.0 1725.6 6722.5 6810.6 6887.4 7031.9 7032.9 6931.5 6998.2 7027.6 7029.8 7049.9 2013.7 2050.6 2052.3 2053.0 2054.0 1988.2 1999.0 2025.6 2084.7 2087.8 1659.4 1692.3 2000.9 2053.0 2079.4 1940.7 1943.6 1944.8 1950.2 1956.4 1997.4 2000.4 2084.0 2088.4 2089.7 6785.7 6914.8 6919.8 6946.0 6948.7 4051.2 4105.0 4115.5 4119.1 4127.5 2616.0 2637.9 2698.8 2713.8 2722.6 826.2 827.8 842.6 871.1 889.4 8642.8 8690.2 8697.4 8699.7 8733.2 3561.4 3595.8 3652.0 3660.9 3692.5 6905.6 6908.3 6921.3 6935.1 6953.0 4011.2 4020.4 4026.2 4031.1 4037.5 3657.5 3660.4 3662.6 3669.5 3674.7 3023.6 3060.0 3060.8 3065.9 3067.0 929.6 934.3 939.3 945.7 946.0 760.3 817.7 915.1 1167.9 1198.1 6249.1 6267.1 6293.9 6320.5 6343.0 530.1 532.1 576.4 583.0 695.1 4773.3 4790.8 4823.3 4833.9 4876.8 7813.8 7910.9 8118.6 8128.3 8155.0 7922.7 8000.1 8001.1 8028.9 8042.9 6300.3 6389.6 6409.4 6465.8 6478.0 5952.8 5964.0 5973.2 5978.5 5993.4 6810.3 7152.6 7250.0 7252.1 7297.5 7284.6 7355.7 7378.7 7524.0 7530.9 5930.5 5945.8 5972.0 5979.2 5986.6 6464.1 6472.3 6545.0 6580.4 6581.9 6007.2 6169.5 6203.1 6220.6 6228.1 5718.1 5916.5 6156.1 6209.7 6297.1 5984.0 6025.2 6026.6 6041.9 6043.2 5488.6 5569.9 5574.9 5596.6 5619.4 5563.7 5643.4 5644.7 5667.7 5667.7 04:33:00 INFO - 2015-12-15 04:33:00,226 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,226 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4773.94 Median:5520.56 stddev:1424.54 (25.8%) stddev-sans-first:1388.37 04:33:00 INFO - 2015-12-15 04:33:00,228 DEBUG : BROWSER_OUTPUT: Values: 298.7 301.2 307.4 307.6 308.7 5508.9 5523.1 5548.4 5565.6 5614.0 5485.0 5493.6 5502.4 5513.7 5518.0 4075.9 4224.6 4231.6 4237.7 4238.4 4144.6 4145.8 4156.1 4167.4 4170.7 4109.8 4112.6 4115.5 4117.6 4125.3 4101.5 4106.6 4109.3 4121.5 4125.7 3582.2 3601.9 3614.7 3614.9 3619.4 5191.1 5315.9 5321.6 5322.9 5324.0 4793.9 4809.6 4810.5 4814.4 4816.0 5762.6 5769.2 5771.2 5791.1 5802.0 3936.7 3940.1 3941.1 3944.0 3954.4 5962.6 6018.6 6075.5 6084.1 6101.5 4073.6 4079.3 4081.6 4082.0 4086.9 4124.1 4138.8 4142.7 4150.4 4154.0 4775.5 4785.1 4792.2 4805.3 4805.3 5549.5 5644.0 5773.7 5789.7 5796.1 1455.1 1473.1 1473.5 1473.6 1473.8 969.4 980.9 981.4 993.9 998.9 5012.3 5045.8 5046.6 5052.8 5060.4 5990.1 5991.2 5992.5 6023.3 6029.3 5034.3 5034.6 5043.4 5045.1 5048.2 3189.7 3227.1 3250.5 3258.9 3261.4 5650.4 5658.3 5664.6 5682.8 5694.5 6169.9 6171.7 6172.8 6176.1 6185.5 5530.3 5592.4 5646.4 5647.3 5673.2 6000.0 6010.4 6013.8 6016.2 6027.2 5829.7 5862.2 5863.5 5865.7 5878.5 5636.8 5661.5 5673.0 5681.4 5695.1 4025.3 4078.2 4108.6 4108.6 4114.9 5911.6 5994.9 5996.3 5999.9 6058.3 5768.8 5827.5 5845.4 5850.8 5859.1 5742.9 5757.9 5820.5 5830.2 5854.5 5589.0 5684.0 5698.8 5698.9 5707.5 5787.2 5806.8 5831.2 5833.8 5840.2 5708.5 5708.9 5713.9 5715.0 5718.2 04:33:00 INFO - 2015-12-15 04:33:00,228 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,228 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12170.26 Median:454.61 stddev:13822.00 (3040.4%) stddev-sans-first:13833.91 04:33:00 INFO - 2015-12-15 04:33:00,228 DEBUG : BROWSER_OUTPUT: Values: 695.7 726.2 771.7 772.3 773.4 11901.6 11985.8 12039.5 12089.9 12146.9 11247.8 11284.3 11289.1 11295.5 11305.1 422.7 422.9 792.7 793.2 817.8 805.7 810.8 813.9 817.1 818.9 844.5 859.0 860.9 861.0 862.4 842.5 846.3 848.1 850.4 852.1 627.6 631.1 631.2 631.9 632.4 11686.4 11825.0 11884.0 11898.4 11916.1 10013.4 10625.5 11092.9 11233.0 11277.1 9474.0 9554.1 9555.3 9558.8 9676.8 3245.2 3273.4 3284.0 3292.4 3297.3 38568.4 38585.2 38975.2 39080.0 40185.0 8978.0 9012.9 9015.3 9084.2 9174.3 16679.9 16758.7 16758.7 16830.9 16837.3 6248.2 6264.6 6395.9 6491.8 6499.3 3407.9 3457.6 3526.7 3572.0 3580.5 2577.8 2622.9 2623.8 2624.3 2626.8 447.8 453.7 453.7 453.9 457.7 472.9 552.0 563.9 564.4 566.8 7151.7 7239.3 7699.0 8009.4 8248.9 455.3 532.9 550.2 573.7 618.6 3674.7 3675.7 3717.2 3748.3 3784.9 49565.0 50030.0 50581.2 50676.2 51018.5 44181.3 44388.1 44404.8 44476.6 44755.0 40825.0 41257.6 42022.8 42173.8 42386.4 7433.3 7480.5 7485.9 7539.8 7708.1 30621.8 30842.1 31014.7 31709.4 31946.2 35992.8 37992.8 40105.4 40202.0 40212.2 9643.9 9756.8 9838.1 9936.4 9941.0 10987.6 11067.6 11103.5 11870.9 11871.1 10006.1 10101.5 10332.6 10363.7 10372.5 10423.8 10540.5 10865.7 10932.9 11149.7 9343.3 9405.6 9482.8 9512.5 9668.3 9388.0 9563.6 9571.8 9604.9 9612.4 8749.5 8752.7 8926.5 9037.9 9197.4 04:33:00 INFO - 2015-12-15 04:33:00,228 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:00 INFO - 2015-12-15 04:33:00,228 DEBUG : BROWSER_OUTPUT: 04:33:00 INFO - 2015-12-15 04:33:00,946 INFO : Browser exited with error code: 0 04:33:00 INFO - 2015-12-15 04:33:00,962 INFO : Completed test dromaeo_css (00:18:33) 04:33:00 INFO - 2015-12-15 04:33:00,963 INFO : Starting test kraken 04:33:00 INFO - 2015-12-15 04:33:00,963 DEBUG : operating with platform_type : linux_ 04:33:00 INFO - 2015-12-15 04:33:00,963 INFO : Initialising browser for kraken test... 04:33:00 INFO - 2015-12-15 04:33:00,969 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunhUWa/profile http://localhost:60883/getInfo.html 04:33:05 INFO - 2015-12-15 04:33:05,611 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:05 INFO - 2015-12-15 04:33:05,611 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:05 INFO - 2015-12-15 04:33:05,612 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:05 INFO - 2015-12-15 04:33:05,612 DEBUG : BROWSER_OUTPUT: __metrics 04:33:05 INFO - 2015-12-15 04:33:05,760 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] 04:33:06 INFO - 2015-12-15 04:33:06,670 INFO : Browser initialized. 04:33:06 INFO - 2015-12-15 04:33:06,670 INFO : Running cycle 1/1 for kraken test... 04:33:06 INFO - 2015-12-15 04:33:06,671 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunhUWa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:18 INFO - 2015-12-15 04:33:18,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 142925824 04:33:18 INFO - 2015-12-15 04:33:18,757 DEBUG : BROWSER_OUTPUT: 04:33:21 INFO - 2015-12-15 04:33:21,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60883/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:21 INFO - 2015-12-15 04:33:21,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 144601088 04:33:21 INFO - 2015-12-15 04:33:21,940 DEBUG : BROWSER_OUTPUT: 04:33:24 INFO - 2015-12-15 04:33:24,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60883/tests/kraken/driver.html?testName=audio-dft) 04:33:25 INFO - 2015-12-15 04:33:25,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 144011264 04:33:25 INFO - 2015-12-15 04:33:25,264 DEBUG : BROWSER_OUTPUT: 04:33:28 INFO - 2015-12-15 04:33:28,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60883/tests/kraken/driver.html?testName=audio-fft) 04:33:28 INFO - 2015-12-15 04:33:28,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 137900032 04:33:28 INFO - 2015-12-15 04:33:28,768 DEBUG : BROWSER_OUTPUT: 04:33:30 INFO - 2015-12-15 04:33:30,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60883/tests/kraken/driver.html?testName=audio-oscillator) 04:33:31 INFO - 2015-12-15 04:33:31,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 138477568 04:33:31 INFO - 2015-12-15 04:33:31,407 DEBUG : BROWSER_OUTPUT: 04:33:33 INFO - 2015-12-15 04:33:33,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60883/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:34 INFO - 2015-12-15 04:33:34,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 140652544 04:33:34 INFO - 2015-12-15 04:33:34,237 DEBUG : BROWSER_OUTPUT: 04:33:37 INFO - 2015-12-15 04:33:37,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60883/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:37 INFO - 2015-12-15 04:33:37,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 140451840 04:33:37 INFO - 2015-12-15 04:33:37,926 DEBUG : BROWSER_OUTPUT: 04:33:41 INFO - 2015-12-15 04:33:41,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60883/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:41 INFO - 2015-12-15 04:33:41,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 04:33:41 INFO - 2015-12-15 04:33:41,981 DEBUG : BROWSER_OUTPUT: 04:33:44 INFO - 2015-12-15 04:33:44,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60883/tests/kraken/driver.html?testName=json-parse-financial) 04:33:45 INFO - 2015-12-15 04:33:45,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 141070336 04:33:45 INFO - 2015-12-15 04:33:45,440 DEBUG : BROWSER_OUTPUT: 04:33:47 INFO - 2015-12-15 04:33:47,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60883/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:47 INFO - 2015-12-15 04:33:47,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 04:33:47 INFO - 2015-12-15 04:33:47,776 DEBUG : BROWSER_OUTPUT: 04:33:49 INFO - 2015-12-15 04:33:49,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:50 INFO - 2015-12-15 04:33:50,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 140230656 04:33:50 INFO - 2015-12-15 04:33:50,285 DEBUG : BROWSER_OUTPUT: 04:33:52 INFO - 2015-12-15 04:33:52,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:53 INFO - 2015-12-15 04:33:53,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 140480512 04:33:53 INFO - 2015-12-15 04:33:53,129 DEBUG : BROWSER_OUTPUT: 04:33:55 INFO - 2015-12-15 04:33:55,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:56 INFO - 2015-12-15 04:33:56,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 140623872 04:33:56 INFO - 2015-12-15 04:33:56,322 DEBUG : BROWSER_OUTPUT: 04:33:58 INFO - 2015-12-15 04:33:58,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:59 INFO - 2015-12-15 04:33:59,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 140247040 04:33:59 INFO - 2015-12-15 04:33:59,524 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60883/tests/kraken/driver.html?testName=ai-astar) 04:34:01 INFO - 2015-12-15 04:34:01,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 141144064 04:34:01 INFO - 2015-12-15 04:34:01,560 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;115;114;115;126;115;113;114;115 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;133;156;165;140;167;151;133;166;131 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;164;162;162;163;168;162;167;164 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;72;127;73;80;72;73;92 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;125;93;94;95;144;95;94;134 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;110;111;110;110;110;109;112;110 04:34:01 INFO - 2015-12-15 04:34:01,562 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;147;148;147;147;146;148 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;96;96;96;95 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;74;75;72;75;73;74;74;73;74 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;67;69;68;68 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;93;84;84;87;85;86;85;96;104 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;127;131;127;126;127;130;126;131;121 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;152;153;157;144;139;149;153;154;139 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;76;74;71;70;73;72;71;71 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,775 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: __startTimestamp1450182841560__endTimestamp 04:34:01 INFO - 2015-12-15 04:34:01,563 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:4.27 (3.7%) stddev-sans-first:4.51 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 115.0 114.0 115.0 126.0 115.0 113.0 114.0 115.0 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.50 stddev:14.63 (9.3%) stddev-sans-first:15.16 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: Values: 159.0 133.0 156.0 165.0 140.0 167.0 151.0 133.0 166.0 131.0 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.15 (1.3%) stddev-sans-first:2.18 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 164.0 162.0 162.0 163.0 168.0 162.0 167.0 164.0 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:17.49 (24.0%) stddev-sans-first:18.27 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 127.0 73.0 80.0 72.0 73.0 92.0 04:34:01 INFO - 2015-12-15 04:34:01,567 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.00 stddev:19.87 (21.1%) stddev-sans-first:20.65 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 125.0 93.0 94.0 95.0 144.0 95.0 94.0 134.0 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 110.0 111.0 110.0 110.0 110.0 109.0 112.0 110.0 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 148.0 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,568 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:74.00 stddev:1.07 (1.5%) stddev-sans-first:0.97 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 75.0 72.0 75.0 73.0 74.0 74.0 73.0 74.0 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 04:34:01 INFO - 2015-12-15 04:34:01,569 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 67.0 69.0 68.0 68.0 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:86.50 stddev:6.97 (8.1%) stddev-sans-first:6.93 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: Values: 97.0 93.0 84.0 84.0 87.0 85.0 86.0 85.0 96.0 104.0 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:3.03 (2.4%) stddev-sans-first:3.12 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: Values: 125.0 127.0 131.0 127.0 126.0 127.0 130.0 126.0 131.0 121.0 04:34:01 INFO - 2015-12-15 04:34:01,570 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:152.50 stddev:7.02 (4.6%) stddev-sans-first:6.66 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: Values: 139.0 152.0 153.0 157.0 144.0 139.0 149.0 153.0 154.0 139.0 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.79 (2.5%) stddev-sans-first:1.86 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 76.0 74.0 71.0 70.0 73.0 72.0 71.0 71.0 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:01 INFO - 2015-12-15 04:34:01,571 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-15 04:34:02,522 INFO : Browser exited with error code: 0 04:34:02 INFO - 2015-12-15 04:34:02,573 INFO : Completed test kraken (00:01:01) 04:34:02 INFO - 2015-12-15 04:34:02,573 INFO : Starting test v8_7 04:34:02 INFO - 2015-12-15 04:34:02,573 DEBUG : operating with platform_type : linux_ 04:34:02 INFO - 2015-12-15 04:34:02,573 INFO : Initialising browser for v8_7 test... 04:34:02 INFO - 2015-12-15 04:34:02,579 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA0q3P/profile http://localhost:60883/getInfo.html 04:34:07 INFO - 2015-12-15 04:34:07,079 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:07 INFO - 2015-12-15 04:34:07,080 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:07 INFO - 2015-12-15 04:34:07,080 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:07 INFO - 2015-12-15 04:34:07,080 DEBUG : BROWSER_OUTPUT: __metrics 04:34:07 INFO - 2015-12-15 04:34:07,196 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] 04:34:08 INFO - 2015-12-15 04:34:08,122 INFO : Browser initialized. 04:34:08 INFO - 2015-12-15 04:34:08,122 INFO : Running cycle 1/1 for v8_7 test... 04:34:08 INFO - 2015-12-15 04:34:08,123 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA0q3P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:20 INFO - 2015-12-15 04:34:20,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 143413248 04:34:20 INFO - 2015-12-15 04:34:20,146 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60883/tests/v8_7/run.html (next: http://localhost:60883/tests/v8_7/run.html) 04:34:41 INFO - 2015-12-15 04:34:41,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 138461184 04:34:41 INFO - 2015-12-15 04:34:41,919 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,919 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:41 INFO - 2015-12-15 04:34:41,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.60402436773123 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5213.541666666667 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.7344753747323 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |5;Earley;718.077474892396 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |6;Boyer;12240.963855421687 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |7;RegExp;25846.153846153848 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |8;Splay;607.5334143377886 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: __startTimestamp1450182881913__endTimestamp 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,920 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: Values: 166.0 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.60 Median:184.60 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: Values: 184.6 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,921 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: Values: 278.3 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: Values: 5213.5 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.73 Median:1071.73 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,922 DEBUG : BROWSER_OUTPUT: Values: 1071.7 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:718.08 Median:718.08 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: Values: 718.1 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12240.96 Median:12240.96 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: Values: 12241.0 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,923 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: Values: 25846.2 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.53 Median:607.53 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: Values: 607.5 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:34:41 INFO - 2015-12-15 04:34:41,924 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:34:41 INFO - 2015-12-15 04:34:41,925 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:41 INFO - 2015-12-15 04:34:41,925 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-15 04:34:42,862 INFO : Browser exited with error code: 0 04:34:42 INFO - 2015-12-15 04:34:42,879 INFO : Completed test v8_7 (00:00:40) 04:34:42 INFO - 2015-12-15 04:34:42,902 INFO : Completed test suite (00:20:15) 04:34:42 INFO - 2015-12-15 04:34:42,902 DEBUG : Working with test: dromaeo_css 04:34:42 INFO - 2015-12-15 04:34:42,902 DEBUG : Generating results file: dromaeo_css 04:34:42 INFO - 2015-12-15 04:34:42,903 DEBUG : Working with test: kraken 04:34:42 INFO - 2015-12-15 04:34:42,903 DEBUG : Generating results file: kraken 04:34:42 INFO - 2015-12-15 04:34:42,904 INFO : javascript benchmark 04:34:42 INFO - 2015-12-15 04:34:42,904 DEBUG : Working with test: v8_7 04:34:42 INFO - 2015-12-15 04:34:42,904 DEBUG : Generating results file: v8_7 04:34:42 INFO - 2015-12-15 04:34:42,904 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:42 INFO - 2015-12-15 04:34:42,963 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 04:34:42 INFO - 2015-12-15 04:34:42,964 DEBUG : process_Request line: dromaeo_css 6257.95 graph.html#tests=[[72,132,43]] 04:34:42 INFO - 2015-12-15 04:34:42,964 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:42 INFO - 2015-12-15 04:34:42,996 DEBUG : process_Request line: kraken 1548.00 graph.html#tests=[[232,132,43]] 04:34:42 INFO - 2015-12-15 04:34:42,996 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:43 INFO - 2015-12-15 04:34:43,026 DEBUG : process_Request line: v8_7 21339.67 graph.html#tests=[[230,132,43]] 04:34:43 INFO - 2015-12-15 04:34:43,028 INFO : javascript benchmark 04:34:43 INFO - 2015-12-15 04:34:43,031 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.829321094129, 2692.5961105834135, 2718.605802158687, 2720.4695084458513, 2741.972580274197, 4676.7427791471455, 4775.450823155343, 4799.760011999403, 4800.735959522225, 4818.301346304784, 4674.813007479705, 4691.29630555416, 4716.410448693913, 4883.389576302962, 4886.438059623144, 4341.587549182823, 4435.379046933432, 4508.278675411935, 4527.026689261808, 4552.385427967215, 4365.908522869283, 4402.691811573191, 4419.801108950089, 4421.027373977719, 4448.510663826993, 4176.081262122329, 4281.978590107061, 4389.736615803062, 4393.956060439386, 4520.186366454037, 4275.995141141829, 4371.475422949235, 4372.994211331412, 4396.472423309224, 4409.140217657526, 4312.892177695583, 4353.5428779977965, 4371.34429835524, 4380.60574548289, 4396.340548917688, 4436.534163912807, 4575.290829921334, 4602.654800889946, 4621.838235661769, 4679.134360143385, 5059.3169922060415, 5072.492750724935, 5095.923561146586, 5113.079645663779, 5145.691258524463, 5103.923441148386, 5108.0, 5114.33513643224, 5121.487851214849, 5172.353455818023, 4530.048689775184, 4633.0733853229485, 4703.600193983481, 4750.857474275777, 4825.155597770447, 5158.948410515922, 5177.637565370388, 5178.741062946838, 5191.247269146028, 5192.039472697563, 4946.4064312282035, 4963.677360971526, 4979.0, 4979.90040199194, 5001.674891132065, 4941.110600092018, 4993.101241776442, 5068.0370729562, 5074.188129899272, 5141.614378921596, 4998.100341938413, 5000.249962505581, 5017.523335283142, 5019.29729837823, 5051.368578927634, 4828.95171048292, 4989.775460104304, 4991.625628077836, 4998.100341938413, 5031.396232452056, 4058.8782336529953, 4135.6898232632075, 4144.171165766858, 4154.688398370074, 4170.91658166835, 3693.3351996640863, 3697.500837386918, 3715.5169827922196, 3720.2373513429684, 3744.0078379229526, 4190.266703326905, 4403.251447253974, 4403.8238470461465, 4408.7575183365225, 4424.7123936944, 4944.9258261126115, 5033.723145226974, 5116.692998420107, 5131.538161565477, 5151.124308867502, 4363.825446982149, 4420.31485119807, 4431.7340959542535, 4443.622292105208, 4448.088141930896, 4286.935695964563, 4398.560143985575, 4523.886902827456, 4531.252343363308, 4551.704139230939, 4754.95245047552, 4769.689970151929, 4846.17615005457, 4867.610591152699, 4894.045661096124, 5064.518870707277, 5092.8472145835685, 5098.9490105098475, 5102.36220472441, 5144.511271429208, 4612.331211974178, 4730.9763451182525, 4750.358701575381, 4851.0, 4928.802847886044, 4883.780229889735, 4943.332650092191, 4947.257911313188, 4971.676841005323, 4993.675411098267, 5073.086844368049, 5076.238564215398, 5078.289039534542, 5082.288479612931, 5129.7691603877165, 4733.313669517832, 4794.041191761592, 4856.660033797601, 4917.975410122926, 4967.379077615298, 4951.554360107608, 4959.553640172402, 4966.379202599675, 4966.428860681068, 5003.849884503471, 4842.539958703917, 4852.781624826962, 4860.416749990024, 4871.561559459666, 4911.091448082117, 4772.904541909073, 4903.16646170159, 4935.703857768545, 5050.747462626928, 5071.163258062378, 4837.806487740451, 4871.098846713369, 4877.975610121926, 4878.56092951636, 4899.534544218293], "unit": "ms", "name": "dojo.html", "value": 4645.334073999423}, {"lowerIsBetter": false, "replicates": [558.1126009644667, 562.7748900439826, 571.7112858006709, 572.8882867840772, 574.4140976204271, 30240.848795756046, 31502.0, 31511.36977260456, 31542.68457315426, 31644.525332120036, 40128.59871401285, 40380.59619403805, 40412.0, 40617.18765624693, 40675.18649627006, 7825.060992680872, 7936.127026027132, 7982.241687039722, 8023.077346105185, 8043.075046369684, 7886.6845326186885, 7935.682572697114, 7941.523508589503, 7960.601969901481, 7973.401994850409, 7877.094134174586, 7977.680892764282, 7985.680572777082, 7988.7203947861835, 8007.31937785286, 7887.684492620288, 7950.880736788953, 7954.363650907913, 7961.522308661499, 7984.960075199587, 7820.217978202191, 7911.406644501685, 7924.732042873113, 7929.444938854283, 7952.8409431811615, 36524.0, 36995.26009479795, 37054.44418333727, 37100.62899370999, 37161.070973225615, 2894.9276268093254, 3000.489916714164, 3027.3793872256133, 3322.983385083059, 3737.682297004758, 27091.1872643821, 27320.453590928268, 27404.725952740417, 27472.725272747215, 27968.860155699294, 3432.6910578048096, 3455.4298540740747, 3463.8787642432644, 3506.9649303506894, 3551.449525323579, 215249.0, 215629.0, 215635.0, 215761.9211903946, 216285.0, 36254.0, 54342.18486722702, 54679.453205468235, 54681.0, 54854.45145548573, 41006.79496602498, 55944.16083758747, 57326.0, 57385.0, 57620.71189644025, 14720.411183552538, 15009.249537523081, 15010.324535395934, 15017.924910375377, 15045.774313385307, 10893.727656808644, 10941.56233750641, 10968.780624387628, 10985.670429886957, 11020.283681560673, 18538.25846966106, 18727.812721872608, 18904.432867014013, 18933.81066189348, 18952.905235473736, 7530.962345188239, 7812.218778122142, 7911.881321780178, 7917.445778795429, 8064.709646456538, 805.5529181304315, 838.6142374507795, 965.918171647759, 982.832918403873, 994.4480813148627, 25802.48395032089, 25948.74051259501, 26228.868855655983, 26363.73636263651, 26400.339991499983, 906.2251774732508, 943.5887227212753, 1018.8115198688266, 1036.8600238967795, 1122.2212792723624, 13461.192328460324, 13911.23488208138, 13921.651958701113, 13974.441022359195, 15125.0, 260609.0, 263591.0, 263703.0, 265074.0, 266372.0, 46440.0, 46620.0, 46627.0, 46755.76622116868, 46761.5323846764, 1229.465182645552, 1235.2711899979056, 1236.3076677060874, 1240.1443004327166, 1253.360785999147, 26473.33816654522, 26579.60130598004, 26716.599251010863, 26822.329441764112, 27068.45863082688, 39788.403173953, 40264.0, 40268.395974061, 40327.0, 40406.79796600998, 246996.0, 248361.0, 248488.0, 248819.0, 249082.0, 27963.300917477227, 28737.0, 29244.41511169722, 29254.853725731235, 29312.534373280825, 34464.82767586146, 34501.48247776235, 34616.65383346134, 34981.07524324721, 35115.82442087773, 31887.84056079705, 31889.840550797097, 32479.837600811843, 33242.168945776546, 33297.83351083229, 32126.03621891347, 33832.830835846646, 34412.291095499786, 34554.65445345615, 34699.47950780791, 32601.34797304088, 32883.50674739929, 32999.67000329966, 33129.50305745367, 33234.16914577155, 27476.45047099007, 30004.84997574998, 30203.848980754956, 30294.545581815848, 30684.0, 22967.540649186587, 25392.746072539037, 25522.617160742233, 25660.35849103713, 25872.611910820975], "unit": "ms", "name": "ext.html", "value": 16835.974205030554}, {"lowerIsBetter": false, "replicates": [330.8775752971401, 331.74455669134767, 334.16292188068894, 334.7706820827732, 334.92129349602845, 14843.851561484382, 15348.079115253078, 15869.841301586981, 16449.342026318947, 16498.0, 15214.771778423332, 15239.31423085961, 15249.84750152501, 15265.38938442461, 15852.128132952683, 4708.646851486135, 5040.395152581696, 5041.067402530525, 5042.0168067226905, 5042.4201216860165, 5082.974585127069, 5103.56619687327, 5126.461721519243, 5131.050755610224, 5132.820351287705, 4494.438195225597, 4782.402199725035, 4839.7338146401935, 4978.327925730035, 4996.350474438318, 4877.292792545061, 4905.828296009622, 4925.876853078666, 4931.235658472942, 4967.602591792648, 4984.077945580043, 5032.823851165228, 5048.1670524363435, 5053.36832895888, 5062.190049592047, 10109.090181883592, 10285.292032393674, 10402.27184097106, 19046.238150474102, 19057.142428590745, 1767.1252729898654, 1870.7568016157813, 1888.1975160556708, 1896.753422055138, 1922.5196598619125, 9029.277657787361, 9201.079892010812, 12208.32854193019, 12664.176828506117, 12755.61733148007, 1770.725537541683, 1804.6571151481176, 1808.2766893242676, 1810.6650269700147, 1824.4982629776785, 55670.72164639151, 58976.41023589795, 60361.094583580845, 60537.09194362044, 61362.38637613611, 9174.770630734152, 9183.58673859678, 9187.908120918839, 9490.525473726424, 9534.856977145348, 11397.430128493543, 11412.42937853104, 11449.198556100993, 11475.713107172387, 11494.137939654393, 6952.130983627047, 7005.299470053056, 7012.439004879598, 7085.362317391459, 7152.892706609405, 6850.828729281808, 6864.862702746017, 6893.862122757617, 6912.619805910723, 6925.376716095576, 3728.9627103728617, 3739.9813000934823, 3785.337565925952, 3788.976976216406, 3790.6588407042946, 1764.841164295194, 1772.5480002599254, 1795.0486242291606, 1804.8375646191644, 1818.7362832389229, 776.945613807028, 815.902091748982, 849.9192576705203, 883.726044926075, 994.3487016004528, 14561.126332420088, 14625.0, 14762.114273143647, 15081.924590377197, 15138.318775655121, 858.4977787993969, 861.3195575495414, 874.7681864305964, 885.7741275974586, 892.6429428228761, 8570.314374850122, 8881.866771998426, 9028.503432311154, 9302.395344302598, 9354.111359420844, 449045.0, 449415.0, 450402.0, 452768.0, 457200.0, 73549.26450735531, 75113.24886751063, 75577.0, 76299.0, 76939.61530192313, 1102.8511150994514, 1116.983245251322, 1124.2130508643982, 1145.9369734664674, 1149.4367759797806, 14987.925060374628, 15030.323635436212, 15140.318685659393, 15176.165310908005, 15334.693306134039, 34101.82949085239, 34731.4790278141, 34914.127146821535, 35714.64285357113, 36245.0, 44612.33081503845, 46283.53716462792, 46398.76800615976, 47614.523854761006, 48281.75859120682, 8996.955015225143, 9031.322650801347, 9064.0, 9094.499802510662, 9157.31320150978, 15478.380864765284, 15502.612434689223, 16074.67850643004, 16243.918780406022, 16422.096784676956, 11299.322040677585, 13370.0, 13562.321883905568, 13693.178409295475, 14001.43994240219, 13106.344682765633, 13345.466181352636, 13769.173849569059, 14507.0, 14507.78238326447, 13359.799603005767, 14141.575752727435, 14225.288735563387, 14521.273936303354, 14779.334929928395, 8261.752147435587, 8375.478471271785, 8398.286145677686, 8466.830663386821, 8540.914590854012, 9032.45805251687, 10891.237613366988, 13238.536651217546, 13369.064165508322, 14273.785893211403], "unit": "ms", "name": "jquery.html", "value": 8250.760069519923}, {"lowerIsBetter": false, "replicates": [1460.1093333066833, 1645.9259333330003, 1683.1668324179534, 1709.9658006839863, 1725.611737359094, 6722.529422940396, 6810.557313774608, 6887.4490040796745, 7031.929680703198, 7032.859342813141, 6931.549449285793, 6998.1952075511335, 7027.613481258529, 7029.824254393643, 7049.894251586217, 2013.7482814648206, 2050.5693804301113, 2052.3124753207617, 2052.9897350513224, 2054.034603736249, 1988.1848442138726, 1998.99000504998, 2025.6151331247015, 2084.718562993999, 2087.7912208779153, 1659.444086231114, 1692.272322901152, 2000.9299674511394, 2053.035073515445, 2079.396974877284, 1940.6506828770816, 1943.6015616798593, 1944.7666280046485, 1950.1809240119185, 1956.3544030469911, 1997.3808119482862, 2000.449876284019, 2084.0, 2088.363049269972, 2089.686547017944, 6785.660716964132, 6914.827129321757, 6919.757808476679, 6946.027556142144, 6948.687309071104, 4051.210014047262, 4105.0, 4115.54728979812, 4119.134981653856, 4127.463429754142, 2615.973840261592, 2637.9472410551875, 2698.7571118599226, 2713.8236014658983, 2722.564389697639, 826.2192228344217, 827.8385714785619, 842.6376658037042, 871.1332224436662, 889.4129874283007, 8642.783930401727, 8690.217880390732, 8697.391182617219, 8699.695510657097, 8733.170348816915, 3561.4479755637917, 3595.8381872815785, 3651.9634803652157, 3660.890173294805, 3692.4830523726164, 6905.620190889549, 6908.274631163656, 6921.273266307066, 6935.063766391573, 6953.0, 4011.2178125265877, 4020.43713880057, 4026.174634199982, 4031.1333063390925, 4037.515498140242, 3657.487951686766, 3660.4143337065943, 3662.597114317476, 3669.4679271505483, 3674.6692797647806, 3023.591815104977, 3060.0360886320736, 3060.7704422168426, 3065.92335191622, 3066.9693303066683, 929.5723966975268, 934.3272843552631, 939.2908354192678, 945.7068308824287, 946.0255936385533, 760.3461023519768, 817.6892780743399, 915.1214833759532, 1167.9240849344935, 1198.0774803401507, 6249.0938813871735, 6267.122602835607, 6293.937060629335, 6320.462760665395, 6343.0, 530.1385248970423, 532.0662237772684, 576.4407278312156, 582.9591928565045, 695.1415002471944, 4773.331733557305, 4790.760461976887, 4823.252395878644, 4833.903321933612, 4876.82931097417, 7813.765587032398, 7910.920890791133, 8118.553479558681, 8128.309093727099, 8155.0, 7922.683092676229, 8000.079990801132, 8001.1198768135455, 8028.919710802934, 8042.879356809653, 6300.338464461257, 6389.616623002635, 6409.359064093554, 6465.806025819233, 6478.02829575558, 5952.76188952437, 5963.970180149072, 5973.163757073926, 5978.521718262442, 5993.430624090704, 6810.250872403933, 7152.6066066364765, 7249.963750181215, 7252.093488313961, 7297.525660832029, 7284.599347035964, 7355.705771769283, 7378.741744038933, 7523.962380188064, 7530.887036694564, 5930.52555795544, 5945.762169513171, 5972.0, 5979.222701048836, 5986.55100867428, 6464.127342808661, 6472.320406357265, 6545.0, 6580.440662543738, 6581.934180658323, 6007.189029480965, 6169.5064394849205, 6203.06953956892, 6220.595661282002, 6228.128062071404, 5718.142278658234, 5916.467517923407, 6156.07658851158, 6209.658468784261, 6297.086922396318, 5984.042553191469, 6025.1564780931585, 6026.608270462406, 6041.9395806041375, 6043.244594425697, 5488.588355873405, 5569.944300556943, 5574.9163762542785, 5596.608237423341, 5619.353774316006, 5563.721813909369, 5643.35101463337, 5644.6613203207935, 5667.659940403589, 5667.716614169192], "unit": "ms", "name": "mootools.html", "value": 3823.275402975329}, {"lowerIsBetter": false, "replicates": [298.6744448551079, 301.22584956661376, 307.36222338647315, 307.5647958139233, 308.65893188027235, 5508.944910550893, 5523.088690366089, 5548.389677135517, 5565.554755619551, 5614.0, 5484.972575137119, 5493.587980901439, 5502.367227768807, 5513.696746678931, 5518.034343989806, 4075.9184816303805, 4224.556421575737, 4231.555686652903, 4237.6609871210385, 4238.364245363205, 4144.606262405066, 4145.813438395279, 4156.085661154541, 4167.354060120671, 4170.666346692257, 4109.815058322382, 4112.588741125878, 4115.464989551369, 4117.5882411758885, 4125.2780763366445, 4101.5488296287385, 4106.589341065899, 4109.3425051991535, 4121.52602450719, 4125.690573207022, 3582.229820588586, 3601.9099522511883, 3614.7469677122613, 3614.9096272593397, 3619.402798538238, 5191.117510023305, 5315.893682126374, 5321.627486075938, 5322.893542129174, 5324.0, 4793.921367692276, 4809.591184749301, 4810.518948105197, 4814.422269327703, 4815.951840481621, 5762.567807414461, 5769.163471296639, 5771.220885180489, 5791.102379131242, 5801.955647983361, 3936.744111632763, 3940.133170702441, 3941.1329507508303, 3943.98028009861, 3954.387070004154, 5962.642241465526, 6018.608790428608, 6075.544334174954, 6084.056971169476, 6101.450869421729, 4073.6333729964445, 4079.3065178919655, 4081.551029386765, 4081.9591804082174, 4086.9182616347507, 4124.092699606082, 4138.79306034697, 4142.668586513132, 4150.3566947122645, 4153.958460415357, 4775.498572649891, 4785.114753770564, 4792.161371759928, 4805.255185446262, 4805.27920811881, 5549.528290095306, 5643.95586816432, 5773.740181691834, 5789.681567513827, 5796.072628379523, 1455.0687559961632, 1473.0572433642478, 1473.4548217159506, 1473.616859616486, 1473.8305094914008, 969.3844408800321, 980.8626792249091, 981.3768257156756, 993.8906720260766, 998.8862418403428, 5012.273220383024, 5045.84862454127, 5046.646734728533, 5052.8484145475695, 5060.418051924076, 5990.131430942489, 5991.161237426763, 5992.520598352121, 6023.2772067351325, 6029.336772954972, 5034.270030845581, 5034.622403319766, 5043.420006699203, 5045.142325804622, 5048.217526283432, 3189.6650851660706, 3227.128675257667, 3250.5449237106823, 3258.869645214212, 3261.445554255782, 5650.3502097258515, 5658.321001479767, 5664.575156863251, 5682.801101961411, 5694.4590263924865, 6169.876602468015, 6171.660558669317, 6172.845678858064, 6176.104464852661, 6185.505159587222, 5530.308711411074, 5592.440755924375, 5646.435356464321, 5647.322321321468, 5673.177389278614, 6000.0, 6010.398960103955, 6013.789517366871, 6016.2479690038745, 6027.18632984559, 5829.7085145743395, 5862.237909071793, 5863.472287494146, 5865.73604187804, 5878.529717622494, 5636.774529018793, 5661.547076233809, 5673.0, 5681.375048744718, 5695.088785794253, 4025.255327764373, 4078.184363127327, 4108.568600296926, 4108.609682080198, 4114.876553703393, 5911.615744976562, 5994.910076348945, 5996.280446346466, 5999.850003749767, 6058.303295121117, 5768.769249229984, 5827.475527202572, 5845.444682755132, 5850.824475265749, 5859.091840764689, 5742.885142297047, 5757.9424205757405, 5820.505257053029, 5830.2129212555765, 5854.502367298827, 5588.972055139699, 5683.9715801420725, 5698.800541981011, 5698.886022279614, 5707.486326230659, 5787.247657804459, 5806.82579522615, 5831.1836342912875, 5833.79581714638, 5840.1531777892815, 5708.514776244066, 5708.885822283448, 5713.857153571028, 5715.028445164249, 5718.199452076629], "unit": "ms", "name": "prototype.html", "value": 4312.917238349488}, {"lowerIsBetter": false, "replicates": [695.6973716433349, 726.1757904778075, 771.6643260181821, 772.339649599592, 773.3503856760321, 11901.58344457944, 11985.820212696806, 12039.458224379901, 12089.939550302237, 12146.878531214685, 11247.775044499105, 11284.322940623548, 11289.09687225022, 11295.49170287337, 11305.095592352613, 422.66609378590874, 422.9069604686964, 792.6512334572799, 793.1632128104861, 817.7546735979212, 805.7220259010631, 810.7689308547066, 813.9186081391844, 817.1175130858659, 818.9058258300312, 844.4553263145268, 858.9699360522383, 860.8751730999032, 860.956952152393, 862.3532350736947, 842.4692443760453, 846.3398549131656, 848.0544193224541, 850.3792231670853, 852.0882655558555, 627.6328347916474, 631.059721015688, 631.2393565753256, 631.908373285871, 632.3707910628908, 11686.415679216005, 11825.0, 11884.049276057982, 11898.405079746064, 11916.106292028133, 10013.449260290681, 10625.521851516623, 11092.944535277353, 11233.0, 11277.097832173406, 9473.952630236874, 9554.092361225672, 9555.27014128011, 9558.761030974212, 9676.806463870684, 3245.237369218232, 3273.4107860585086, 3283.9835800820842, 3292.423825830494, 3297.3075654112663, 38568.42147367792, 38585.22829543393, 38975.22049559021, 39080.0, 40185.0, 8977.955110224408, 9012.909870901338, 9015.27877769777, 9084.22784063362, 9174.311926605531, 16679.91660041692, 16758.74861877073, 16758.74861877073, 16830.915845420695, 16837.32650693983, 6248.218972628421, 6264.592801467981, 6395.936040639627, 6491.772787952494, 6499.252585952676, 3407.897763067112, 3457.567804024497, 3526.7354948378975, 3572.017695133859, 3580.5166302548823, 2577.78088862445, 2622.895084196649, 2623.77697895681, 2624.3439140214946, 2626.7898568114506, 447.76268577653894, 453.67108846086984, 453.69148978694807, 453.9445788541654, 457.7459509971931, 472.89123501594827, 551.9806806761744, 563.8646724786104, 564.3679079431064, 566.7619599768108, 7151.678174482161, 7239.348458638748, 7698.961505192438, 8009.399295052895, 8248.917510824935, 455.2852022324984, 532.8534652970386, 550.204953841703, 573.6844735395516, 618.6473709985265, 3674.706023518112, 3675.7243206759067, 3717.182219911615, 3748.250349930025, 3784.8902491131666, 49565.0, 50030.0, 50581.24128138081, 50676.239856402186, 51018.48981510212, 44181.337279940824, 44388.112237755064, 44404.777976109915, 44476.55523444724, 44755.0, 40825.0, 41257.58742412538, 42022.78988605038, 42173.789131054145, 42386.364204536956, 7433.25667433274, 7480.513766605153, 7485.887711684438, 7539.811504712206, 7708.075030996316, 30621.846890765402, 30842.074737757903, 31014.68985310118, 31709.36581268408, 31946.20134496656, 35992.820035899655, 37992.810035949646, 40105.39841902316, 40202.0, 40212.1957560853, 9643.855342170013, 9756.804863902824, 9838.06538378853, 9936.403815770787, 9940.950295248478, 10987.61543345979, 11067.557297708001, 11103.50034248477, 11870.940645296718, 11871.050315974873, 10006.11888546748, 10101.545430455793, 10332.586696532055, 10363.740906477096, 10372.533236004549, 10423.791524169626, 10540.525676344736, 10865.674029779118, 10932.930104852656, 11149.72125696864, 9343.34596578233, 9405.576749046173, 9482.762930926781, 9512.524373781145, 9668.323217374716, 9387.953060234655, 9563.569639366384, 9571.760705982406, 9604.9039509604, 9612.375195612263, 8749.518776467356, 8752.69365572202, 8926.509042002752, 9037.909620903707, 9197.356185066981], "unit": "ms", "name": "yui.html", "value": 5644.017481910931}], "name": "dromaeo_css", "value": 6257.946248826522}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 115.0, 114.0, 115.0, 126.0, 115.0, 113.0, 114.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [159.0, 133.0, 156.0, 165.0, 140.0, 167.0, 151.0, 133.0, 166.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 164.0, 162.0, 162.0, 163.0, 168.0, 162.0, 167.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 127.0, 73.0, 80.0, 72.0, 73.0, 92.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 125.0, 93.0, 94.0, 95.0, 144.0, 95.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 112.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 75.0, 72.0, 75.0, 73.0, 74.0, 74.0, 73.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 73.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 67.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [97.0, 93.0, 84.0, 84.0, 87.0, 85.0, 86.0, 85.0, 96.0, 104.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 90.1}, {"lowerIsBetter": true, "replicates": [125.0, 127.0, 131.0, 127.0, 126.0, 127.0, 130.0, 126.0, 131.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 153.0, 157.0, 144.0, 139.0, 149.0, 153.0, 154.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 76.0, 74.0, 71.0, 70.0, 73.0, 72.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1547.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [184.60402436773123], "unit": "score", "name": "DeltaBlue", "value": 358.16120599999994}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1071.7344753747323], "unit": "score", "name": "RayTrace", "value": 690.4592667332666}, {"lowerIsBetter": false, "replicates": [718.077474892396], "unit": "score", "name": "Earley", "value": 928.1213006993005}, {"lowerIsBetter": false, "replicates": [12240.963855421687], "unit": "score", "name": "Boyer", "value": 54.4453041338583}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [607.5334143377886], "unit": "score", "name": "Splay", "value": 134.13418600000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21339.670096981004}]} 04:34:43 INFO - RETURN: dromaeo_css: 6257.95 04:34:43 INFO - RETURN: kraken: 1548.00 04:34:43 INFO - RETURN: v8_7: 21339.67 04:34:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21339.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6257.95"}}} 04:34:43 INFO - Return code: 0 04:34:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:43 INFO - # TBPL SUCCESS # 04:34:43 INFO - Running post-action listener: _resource_record_post_action 04:34:43 INFO - Running post-run listener: _resource_record_post_run 04:34:44 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 12288; Write bytes: 518135808; Read time: 264; Write time: 497880 04:34:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 242503680; Read time: 228; Write time: 326412 04:34:44 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8192; Write bytes: 274812928; Read time: 36; Write time: 171436 04:34:44 INFO - Running post-run listener: _upload_blobber_files 04:34:44 INFO - Blob upload gear active. 04:34:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:34:44 INFO - Copying logs to upload dir... 04:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.901513 ========= master_lag: 1.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-15 04:34:45.315992) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:34:45.317452) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009938 build_url: 'https://queue.taskcluster.net/v1/task/z_0tH3ubTWuB-MRBYcK2_w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.50 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:34:45.827263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2015-12-15 04:34:45.830657) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450178383.732020-1299415156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 2.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2015-12-15 04:34:48.219104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 04:34:48.219469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 04:34:48.262292) ========= ========= Total master_lag: 4.20 =========