builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1449783817.66 results: success (0) buildid: 20151210130140 builduid: 79a25ca2a6d54e44a53a677b7fb9b9b7 revision: 760f2be9b5490933e5c64dfab9e39b620b57c945 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.656254) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.656735) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.657021) ========= 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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004958 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.681838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.682234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.699107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.699490) ========= 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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.748138) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.748457) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.748800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.749081) ========= 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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 13:43:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-10 13:43:39 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.898038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.901451) ========= 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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022469 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:37.951062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-10 13:43:37.954458) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 760f2be9b5490933e5c64dfab9e39b620b57c945 --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 760f2be9b5490933e5c64dfab9e39b620b57c945 --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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 13:43:39,468 truncating revision to first 12 chars 2015-12-10 13:43:39,468 Setting DEBUG logging. 2015-12-10 13:43:39,468 attempt 1/10 2015-12-10 13:43:39,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/760f2be9b549?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 13:43:40,664 unpacking tar archive at: fx-team-760f2be9b549/testing/mozharness/ program finished with exit code 0 elapsedTime=1.476496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-10 13:43:39.446198) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:39.446548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:39.456701) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:39.457014) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 13:43:39.457492) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-10 13:43:39.457770) ========= /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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:43:41 INFO - MultiFileLogger online at 20151210 13:43:41 in /builds/slave/test 13:43:41 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 13:43:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:41 INFO - {'append_to_log': False, 13:43:41 INFO - 'base_work_dir': '/builds/slave/test', 13:43:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:43:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:41 INFO - 'branch': 'Fx-Team-Non-PGO', 13:43:41 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:41 INFO - 'config_files': ('talos/linux_config.py',), 13:43:41 INFO - 'default_actions': ('clobber', 13:43:41 INFO - 'read-buildbot-config', 13:43:41 INFO - 'download-and-extract', 13:43:41 INFO - 'populate-webroot', 13:43:41 INFO - 'create-virtualenv', 13:43:41 INFO - 'install', 13:43:41 INFO - 'run-tests'), 13:43:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:41 INFO - 'download_minidump_stackwalk': True, 13:43:41 INFO - 'download_symbols': 'ondemand', 13:43:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:41 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:41 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:41 INFO - 'installer_path': 'installer.exe', 13:43:41 INFO - 'log_level': 'info', 13:43:41 INFO - 'log_name': 'talos', 13:43:41 INFO - 'log_to_console': True, 13:43:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:43:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:43:41 INFO - 'opt_config_files': (), 13:43:41 INFO - 'pip_index': False, 13:43:41 INFO - 'sps_profile': False, 13:43:41 INFO - 'sps_profile_interval': 0, 13:43:41 INFO - 'suite': 'dromaeojs-e10s', 13:43:41 INFO - 'system_bits': '64', 13:43:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:41 INFO - 'title': 'talos-linux64-ix-053', 13:43:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:41 INFO - 'use_talos_json': True, 13:43:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:41 INFO - 'work_dir': 'build'} 13:43:41 INFO - ##### 13:43:41 INFO - ##### Running clobber step. 13:43:41 INFO - ##### 13:43:41 INFO - Running pre-action listener: _resource_record_pre_action 13:43:41 INFO - Running main action method: clobber 13:43:41 INFO - rmtree: /builds/slave/test/build 13:43:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:42 INFO - Running post-action listener: _resource_record_post_action 13:43:42 INFO - ##### 13:43:42 INFO - ##### Running read-buildbot-config step. 13:43:42 INFO - ##### 13:43:42 INFO - Running pre-action listener: _resource_record_pre_action 13:43:42 INFO - Running main action method: read_buildbot_config 13:43:42 INFO - Using buildbot properties: 13:43:42 INFO - { 13:43:42 INFO - "properties": { 13:43:42 INFO - "buildnumber": 556, 13:43:42 INFO - "product": "firefox", 13:43:42 INFO - "script_repo_revision": "production", 13:43:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:43:42 INFO - "repository": "", 13:43:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:43:42 INFO - "buildid": "20151210130140", 13:43:42 INFO - "slavename": "talos-linux64-ix-053", 13:43:42 INFO - "pgo_build": "False", 13:43:42 INFO - "basedir": "/builds/slave/test", 13:43:42 INFO - "project": "", 13:43:42 INFO - "platform": "ubuntu64_hw", 13:43:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:43:42 INFO - "slavebuilddir": "test", 13:43:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:43:42 INFO - "branch": "fx-team", 13:43:42 INFO - "repo_path": "integration/fx-team", 13:43:42 INFO - "stage_platform": "linux64", 13:43:42 INFO - "builduid": "79a25ca2a6d54e44a53a677b7fb9b9b7", 13:43:42 INFO - "revision": "760f2be9b5490933e5c64dfab9e39b620b57c945" 13:43:42 INFO - }, 13:43:42 INFO - "sourcestamp": { 13:43:42 INFO - "repository": "", 13:43:42 INFO - "hasPatch": false, 13:43:42 INFO - "project": "", 13:43:42 INFO - "branch": "fx-team-linux64-talos", 13:43:42 INFO - "changes": [ 13:43:42 INFO - { 13:43:42 INFO - "category": null, 13:43:42 INFO - "files": [ 13:43:42 INFO - { 13:43:42 INFO - "url": null, 13:43:42 INFO - "name": "https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:43:42 INFO - } 13:43:42 INFO - ], 13:43:42 INFO - "repository": "", 13:43:42 INFO - "rev": "760f2be9b5490933e5c64dfab9e39b620b57c945", 13:43:42 INFO - "who": "pbrosset@mozilla.com", 13:43:42 INFO - "when": 1449783316, 13:43:42 INFO - "number": 7273089, 13:43:42 INFO - "comments": "Bug 1229859 - Introduce new import-globals-from eslint rule to import globals from other modules; r=Mossop", 13:43:42 INFO - "project": "", 13:43:42 INFO - "at": "Thu 10 Dec 2015 13:35:16", 13:43:42 INFO - "branch": "fx-team-linux64-talos", 13:43:42 INFO - "revlink": "", 13:43:42 INFO - "properties": [ 13:43:42 INFO - [ 13:43:42 INFO - "buildid", 13:43:42 INFO - "20151210130140", 13:43:42 INFO - "Change" 13:43:42 INFO - ], 13:43:42 INFO - [ 13:43:42 INFO - "builduid", 13:43:42 INFO - "79a25ca2a6d54e44a53a677b7fb9b9b7", 13:43:42 INFO - "Change" 13:43:42 INFO - ], 13:43:42 INFO - [ 13:43:42 INFO - "pgo_build", 13:43:42 INFO - "False", 13:43:42 INFO - "Change" 13:43:42 INFO - ] 13:43:42 INFO - ], 13:43:42 INFO - "revision": "760f2be9b5490933e5c64dfab9e39b620b57c945" 13:43:42 INFO - } 13:43:42 INFO - ], 13:43:42 INFO - "revision": "760f2be9b5490933e5c64dfab9e39b620b57c945" 13:43:42 INFO - } 13:43:42 INFO - } 13:43:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:43:42 INFO - Running post-action listener: _resource_record_post_action 13:43:42 INFO - ##### 13:43:42 INFO - ##### Running download-and-extract step. 13:43:42 INFO - ##### 13:43:42 INFO - Running pre-action listener: _resource_record_pre_action 13:43:42 INFO - Running main action method: download_and_extract 13:43:42 INFO - mkdir: /builds/slave/test/build/tests 13:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:42 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json 13:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json 13:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:43:42 INFO - Downloaded 1302 bytes. 13:43:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:43:42 INFO - Using the following test package requirements: 13:43:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'jsshell-linux-x86_64.zip'], 13:43:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:43:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:43:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:42 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:44 INFO - Downloaded 21866925 bytes. 13:43:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:43:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:43:45 INFO - Return code: 0 13:43:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:43: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')]} 13:43:45 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:46 INFO - Downloaded 21866925 bytes. 13:43:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:43:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:43:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:43:48 INFO - Return code: 0 13:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:48 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:43:49 INFO - Downloaded 11132038 bytes. 13:43:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:43:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:43:49 INFO - Return code: 0 13:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:49 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:43:50 INFO - Downloaded 57730351 bytes. 13:43:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:43:50 INFO - mkdir: /builds/slave/test/properties 13:43:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:50 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:50 INFO - Contents: 13:43:50 INFO - build_url:https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:43:50 INFO - Running post-action listener: _resource_record_post_action 13:43:50 INFO - Running post-action listener: set_extra_try_arguments 13:43:50 INFO - ##### 13:43:50 INFO - ##### Running populate-webroot step. 13:43:50 INFO - ##### 13:43:50 INFO - Running pre-action listener: _resource_record_pre_action 13:43:50 INFO - Running main action method: populate_webroot 13:43:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:50 INFO - '--tppagecycles', 13:43:50 INFO - '7'], 13:43:50 INFO - 'tests': ['tsvgm']}}, 13:43:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:43:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:43:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:43:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'tests': ['damp', 'tps']}, 13:43:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['damp', 'tps']}, 13:43:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:43:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:50 INFO - 'other': {'tests': ['a11yr', 13:43:50 INFO - 'ts_paint', 13:43:50 INFO - 'tpaint', 13:43:50 INFO - 'sessionrestore', 13:43:50 INFO - 'sessionrestore_no_auto_restore']}, 13:43:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['a11yr', 13:43:50 INFO - 'ts_paint', 13:43:50 INFO - 'tpaint', 13:43:50 INFO - 'sessionrestore', 13:43:50 INFO - 'sessionrestore_no_auto_restore']}, 13:43:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['a11yr', 13:43:50 INFO - 'ts_paint', 13:43:50 INFO - 'tpaint', 13:43:50 INFO - 'sessionrestore', 13:43:50 INFO - 'sessionrestore_no_auto_restore']}, 13:43:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['a11yr', 13:43:50 INFO - 'ts_paint', 13:43:50 INFO - 'tpaint', 13:43:50 INFO - 'sessionrestore', 13:43:50 INFO - 'sessionrestore_no_auto_restore']}, 13:43:50 INFO - 'other_l64': {'tests': ['a11yr', 13:43:50 INFO - 'ts_paint', 13:43:50 INFO - 'tpaint', 13:43:50 INFO - 'sessionrestore', 13:43:50 INFO - 'sessionrestore_no_auto_restore']}, 13:43:50 INFO - 'other_nol64': {'tests': ['a11yr', 13:43:50 INFO - 'ts_paint', 13:43:50 INFO - 'tpaint', 13:43:50 INFO - 'sessionrestore', 13:43:50 INFO - 'sessionrestore_no_auto_restore']}, 13:43:50 INFO - 'svgr': {'tests': ['tsvgx', 13:43:50 INFO - 'tsvgr_opacity', 13:43:50 INFO - 'tart', 13:43:50 INFO - 'tscrollx', 13:43:50 INFO - 'cart']}, 13:43:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['tsvgx', 13:43:50 INFO - 'tsvgr_opacity', 13:43:50 INFO - 'tart', 13:43:50 INFO - 'tscrollx', 13:43:50 INFO - 'cart']}, 13:43:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'tests': ['tp5o']}, 13:43:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'talos_options': ['--e10s'], 13:43:50 INFO - 'tests': ['tp5o']}, 13:43:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'talos_options': ['--xperf_path', 13:43:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:50 INFO - 'tests': ['tp5n']}, 13:43:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:50 INFO - 'talos_options': ['--e10s', 13:43:50 INFO - '--xperf_path', 13:43:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:50 INFO - 'tests': ['tp5n']}}, 13:43:50 INFO - 'talos.zip': {'path': '', 13:43:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:50 INFO - Running post-action listener: _resource_record_post_action 13:43:50 INFO - ##### 13:43:50 INFO - ##### Running create-virtualenv step. 13:43:50 INFO - ##### 13:43:50 INFO - Running pre-action listener: _resource_record_pre_action 13:43:50 INFO - Running main action method: create_virtualenv 13:43:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:50 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 13:43:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:50 INFO - Using real prefix '/usr' 13:43:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:53 INFO - Installing pip.................done. 13:43:53 INFO - Return code: 0 13:43:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:43: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', 'pip>=1.5'] in /builds/slave/test/build 13:43: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 pip>=1.5 13:43:53 INFO - Using env: {'DISPLAY': ':0', 13:43:53 INFO - 'HOME': '/home/cltbld', 13:43:53 INFO - 'LANG': 'en_US.UTF-8', 13:43:53 INFO - 'LANGUAGE': 'en_US:en', 13:43:53 INFO - 'LOGNAME': 'cltbld', 13:43:53 INFO - 'MAIL': '/var/mail/cltbld', 13:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:53 INFO - 'MOZ_NO_REMOTE': '1', 13:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:53 INFO - 'NO_EM_RESTART': '1', 13:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:53 INFO - 'PWD': '/builds/slave/test', 13:43:53 INFO - 'SHELL': '/bin/bash', 13:43:53 INFO - 'SHLVL': '1', 13:43:53 INFO - 'TERM': 'linux', 13:43:53 INFO - 'TMOUT': '86400', 13:43:53 INFO - 'USER': 'cltbld', 13:43:53 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:53 INFO - '_': '/tools/buildbot/bin/python'} 13:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:53 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 13:43:53 INFO - Cleaning up... 13:43:53 INFO - Return code: 0 13:43:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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', '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 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:43: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', 'psutil>=0.7.1'] in /builds/slave/test/build 13:43: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 psutil>=0.7.1 13:43:53 INFO - Using env: {'DISPLAY': ':0', 13:43:53 INFO - 'HOME': '/home/cltbld', 13:43:53 INFO - 'LANG': 'en_US.UTF-8', 13:43:53 INFO - 'LANGUAGE': 'en_US:en', 13:43:53 INFO - 'LOGNAME': 'cltbld', 13:43:53 INFO - 'MAIL': '/var/mail/cltbld', 13:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:53 INFO - 'MOZ_NO_REMOTE': '1', 13:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:53 INFO - 'NO_EM_RESTART': '1', 13:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:53 INFO - 'PWD': '/builds/slave/test', 13:43:53 INFO - 'SHELL': '/bin/bash', 13:43:53 INFO - 'SHLVL': '1', 13:43:53 INFO - 'TERM': 'linux', 13:43:53 INFO - 'TMOUT': '86400', 13:43:53 INFO - 'USER': 'cltbld', 13:43:53 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:53 INFO - '_': '/tools/buildbot/bin/python'} 13:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:53 INFO - Downloading/unpacking psutil>=0.7.1 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:43:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:55 INFO - Installing collected packages: psutil 13:43:55 INFO - Running setup.py install for psutil 13:43:55 INFO - building 'psutil._psutil_linux' extension 13:43:55 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 13:43:55 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 13:43:55 INFO - building 'psutil._psutil_posix' extension 13:43:55 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 13:43:55 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 13:43:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:56 INFO - Successfully installed psutil 13:43:56 INFO - Cleaning up... 13:43:56 INFO - Return code: 0 13:43:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:43:56 INFO - Using env: {'DISPLAY': ':0', 13:43:56 INFO - 'HOME': '/home/cltbld', 13:43:56 INFO - 'LANG': 'en_US.UTF-8', 13:43:56 INFO - 'LANGUAGE': 'en_US:en', 13:43:56 INFO - 'LOGNAME': 'cltbld', 13:43:56 INFO - 'MAIL': '/var/mail/cltbld', 13:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:56 INFO - 'MOZ_NO_REMOTE': '1', 13:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:56 INFO - 'NO_EM_RESTART': '1', 13:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:56 INFO - 'PWD': '/builds/slave/test', 13:43:56 INFO - 'SHELL': '/bin/bash', 13:43:56 INFO - 'SHLVL': '1', 13:43:56 INFO - 'TERM': 'linux', 13:43:56 INFO - 'TMOUT': '86400', 13:43:56 INFO - 'USER': 'cltbld', 13:43:56 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:56 INFO - '_': '/tools/buildbot/bin/python'} 13:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:43:56 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 13:43:56 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 13:43:56 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 13:43:56 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 13:43:56 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 13:43:56 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 13:43:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:43:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:43:57 INFO - Installing collected packages: mozsystemmonitor 13:43:57 INFO - Running setup.py install for mozsystemmonitor 13:43:58 INFO - Successfully installed mozsystemmonitor 13:43:58 INFO - Cleaning up... 13:43:58 INFO - Return code: 0 13:43:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:58 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 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:43:58 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 13:43:58 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 13:43:58 INFO - Using env: {'DISPLAY': ':0', 13:43:58 INFO - 'HOME': '/home/cltbld', 13:43:58 INFO - 'LANG': 'en_US.UTF-8', 13:43:58 INFO - 'LANGUAGE': 'en_US:en', 13:43:58 INFO - 'LOGNAME': 'cltbld', 13:43:58 INFO - 'MAIL': '/var/mail/cltbld', 13:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:58 INFO - 'MOZ_NO_REMOTE': '1', 13:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:58 INFO - 'NO_EM_RESTART': '1', 13:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:58 INFO - 'PWD': '/builds/slave/test', 13:43:58 INFO - 'SHELL': '/bin/bash', 13:43:58 INFO - 'SHLVL': '1', 13:43:58 INFO - 'TERM': 'linux', 13:43:58 INFO - 'TMOUT': '86400', 13:43:58 INFO - 'USER': 'cltbld', 13:43:58 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:58 INFO - '_': '/tools/buildbot/bin/python'} 13:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:44:00 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:00 INFO - Downloading docopt-0.6.1.tar.gz 13:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:00 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:00 INFO - Running setup.py install for blobuploader 13:44:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:00 INFO - Running setup.py install for requests 13:44:01 INFO - Running setup.py install for docopt 13:44:01 INFO - Successfully installed blobuploader requests docopt 13:44:01 INFO - Cleaning up... 13:44:01 INFO - Return code: 0 13:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:01 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')]} 13:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:01 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')]} 13:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:01 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 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:44:01 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 13:44:01 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 13:44:01 INFO - Using env: {'DISPLAY': ':0', 13:44:01 INFO - 'HOME': '/home/cltbld', 13:44:01 INFO - 'LANG': 'en_US.UTF-8', 13:44:01 INFO - 'LANGUAGE': 'en_US:en', 13:44:01 INFO - 'LOGNAME': 'cltbld', 13:44:01 INFO - 'MAIL': '/var/mail/cltbld', 13:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:01 INFO - 'MOZ_NO_REMOTE': '1', 13:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:01 INFO - 'NO_EM_RESTART': '1', 13:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:01 INFO - 'PWD': '/builds/slave/test', 13:44:01 INFO - 'SHELL': '/bin/bash', 13:44:01 INFO - 'SHLVL': '1', 13:44:01 INFO - 'TERM': 'linux', 13:44:01 INFO - 'TMOUT': '86400', 13:44:01 INFO - 'USER': 'cltbld', 13:44:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:01 INFO - '_': '/tools/buildbot/bin/python'} 13:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:01 INFO - Running setup.py (path:/tmp/pip-U7qML4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:01 INFO - Running setup.py (path:/tmp/pip-m0xz6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:01 INFO - Running setup.py (path:/tmp/pip-7ZBo0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:01 INFO - Running setup.py (path:/tmp/pip-PjaYBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:01 INFO - Running setup.py (path:/tmp/pip-NF5bAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:01 INFO - Running setup.py (path:/tmp/pip-OoQH6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:02 INFO - Running setup.py (path:/tmp/pip-VJMqPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:02 INFO - Running setup.py (path:/tmp/pip-pl8nbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:02 INFO - Running setup.py (path:/tmp/pip-M_5rWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:02 INFO - Running setup.py (path:/tmp/pip-axXI2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:02 INFO - Running setup.py (path:/tmp/pip-dK5zCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:02 INFO - Running setup.py (path:/tmp/pip-wnUWkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:02 INFO - Running setup.py (path:/tmp/pip-pfzDUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:02 INFO - Running setup.py (path:/tmp/pip-DMfV5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:02 INFO - Running setup.py (path:/tmp/pip-PykRgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:02 INFO - Running setup.py (path:/tmp/pip-dlrXuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:02 INFO - Running setup.py (path:/tmp/pip-3FPu6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:02 INFO - Running setup.py install for manifestparser 13:44:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:02 INFO - Running setup.py install for mozcrash 13:44:02 INFO - Running setup.py install for mozdebug 13:44:03 INFO - Running setup.py install for mozdevice 13:44:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Running setup.py install for mozfile 13:44:03 INFO - Running setup.py install for mozhttpd 13:44:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Running setup.py install for mozinfo 13:44:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Running setup.py install for mozInstall 13:44:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Running setup.py install for mozleak 13:44:03 INFO - Running setup.py install for mozlog 13:44:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Running setup.py install for moznetwork 13:44:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:03 INFO - Running setup.py install for mozprocess 13:44:04 INFO - Running setup.py install for mozprofile 13:44:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:04 INFO - Running setup.py install for mozrunner 13:44:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:04 INFO - Running setup.py install for mozscreenshot 13:44:04 INFO - Running setup.py install for moztest 13:44:04 INFO - Running setup.py install for mozversion 13:44:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:04 INFO - Cleaning up... 13:44:04 INFO - Return code: 0 13:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:04 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')]} 13:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:04 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')]} 13:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:04 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 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:44:04 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 13:44:04 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 13:44:04 INFO - Using env: {'DISPLAY': ':0', 13:44:04 INFO - 'HOME': '/home/cltbld', 13:44:04 INFO - 'LANG': 'en_US.UTF-8', 13:44:04 INFO - 'LANGUAGE': 'en_US:en', 13:44:04 INFO - 'LOGNAME': 'cltbld', 13:44:04 INFO - 'MAIL': '/var/mail/cltbld', 13:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:04 INFO - 'MOZ_NO_REMOTE': '1', 13:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:04 INFO - 'NO_EM_RESTART': '1', 13:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:04 INFO - 'PWD': '/builds/slave/test', 13:44:04 INFO - 'SHELL': '/bin/bash', 13:44:04 INFO - 'SHLVL': '1', 13:44:04 INFO - 'TERM': 'linux', 13:44:04 INFO - 'TMOUT': '86400', 13:44:04 INFO - 'USER': 'cltbld', 13:44:04 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:04 INFO - '_': '/tools/buildbot/bin/python'} 13:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:04 INFO - Running setup.py (path:/tmp/pip-rNU3gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:04 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)) 13:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:04 INFO - Running setup.py (path:/tmp/pip-wJ5nfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:04 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)) 13:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:04 INFO - Running setup.py (path:/tmp/pip-0Tbbak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:04 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)) 13:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:05 INFO - Running setup.py (path:/tmp/pip-0QmVOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:05 INFO - Running setup.py (path:/tmp/pip-yUSPbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:05 INFO - Running setup.py (path:/tmp/pip-gTBdaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:05 INFO - Running setup.py (path:/tmp/pip-sgVJBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:05 INFO - Running setup.py (path:/tmp/pip-Uqapfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:05 INFO - Running setup.py (path:/tmp/pip-s6cDSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:05 INFO - Running setup.py (path:/tmp/pip-3X_jh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:05 INFO - Running setup.py (path:/tmp/pip-_ZNCa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:05 INFO - Running setup.py (path:/tmp/pip-IEmaIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:05 INFO - Running setup.py (path:/tmp/pip-o_6FQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:05 INFO - Running setup.py (path:/tmp/pip-l0BKYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:05 INFO - Running setup.py (path:/tmp/pip-0wmXZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:05 INFO - Running setup.py (path:/tmp/pip-sLUPy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:05 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)) 13:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:05 INFO - Running setup.py (path:/tmp/pip-t9k9EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:44:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:07 INFO - Downloading blessings-1.5.1.tar.gz 13:44:07 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 13:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:07 INFO - Installing collected packages: blessings 13:44:07 INFO - Running setup.py install for blessings 13:44:07 INFO - Successfully installed blessings 13:44:07 INFO - Cleaning up... 13:44:07 INFO - Return code: 0 13:44:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:08 INFO - Reading from file tmpfile_stdout 13:44:08 INFO - Current package versions: 13:44:08 INFO - argparse == 1.2.1 13:44:08 INFO - blessings == 1.5.1 13:44:08 INFO - blobuploader == 1.2.4 13:44:08 INFO - docopt == 0.6.1 13:44:08 INFO - manifestparser == 1.1 13:44:08 INFO - mozInstall == 1.12 13:44:08 INFO - mozcrash == 0.16 13:44:08 INFO - mozdebug == 0.1 13:44:08 INFO - mozdevice == 0.47 13:44:08 INFO - mozfile == 1.2 13:44:08 INFO - mozhttpd == 0.7 13:44:08 INFO - mozinfo == 0.9 13:44:08 INFO - mozleak == 0.1 13:44:08 INFO - mozlog == 3.1 13:44:08 INFO - moznetwork == 0.27 13:44:08 INFO - mozprocess == 0.22 13:44:08 INFO - mozprofile == 0.27 13:44:08 INFO - mozrunner == 6.11 13:44:08 INFO - mozscreenshot == 0.1 13:44:08 INFO - mozsystemmonitor == 0.0 13:44:08 INFO - moztest == 0.7 13:44:08 INFO - mozversion == 1.4 13:44:08 INFO - psutil == 3.1.1 13:44:08 INFO - requests == 1.2.3 13:44:08 INFO - wsgiref == 0.1.2 13:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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', '-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 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:44:08 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 13:44:08 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 13:44:08 INFO - Using env: {'DISPLAY': ':0', 13:44:08 INFO - 'HOME': '/home/cltbld', 13:44:08 INFO - 'LANG': 'en_US.UTF-8', 13:44:08 INFO - 'LANGUAGE': 'en_US:en', 13:44:08 INFO - 'LOGNAME': 'cltbld', 13:44:08 INFO - 'MAIL': '/var/mail/cltbld', 13:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:08 INFO - 'MOZ_NO_REMOTE': '1', 13:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:08 INFO - 'NO_EM_RESTART': '1', 13:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:08 INFO - 'PWD': '/builds/slave/test', 13:44:08 INFO - 'SHELL': '/bin/bash', 13:44:08 INFO - 'SHLVL': '1', 13:44:08 INFO - 'TERM': 'linux', 13:44:08 INFO - 'TMOUT': '86400', 13:44:08 INFO - 'USER': 'cltbld', 13:44:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:08 INFO - '_': '/tools/buildbot/bin/python'} 13:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 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)) 13:44:08 INFO - Cleaning up... 13:44:08 INFO - Return code: 0 13:44:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:44: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', 'jsonschema'] in /builds/slave/test/build 13:44: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 jsonschema 13:44:08 INFO - Using env: {'DISPLAY': ':0', 13:44:08 INFO - 'HOME': '/home/cltbld', 13:44:08 INFO - 'LANG': 'en_US.UTF-8', 13:44:08 INFO - 'LANGUAGE': 'en_US:en', 13:44:08 INFO - 'LOGNAME': 'cltbld', 13:44:08 INFO - 'MAIL': '/var/mail/cltbld', 13:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:08 INFO - 'MOZ_NO_REMOTE': '1', 13:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:08 INFO - 'NO_EM_RESTART': '1', 13:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:08 INFO - 'PWD': '/builds/slave/test', 13:44:08 INFO - 'SHELL': '/bin/bash', 13:44:08 INFO - 'SHLVL': '1', 13:44:08 INFO - 'TERM': 'linux', 13:44:08 INFO - 'TMOUT': '86400', 13:44:08 INFO - 'USER': 'cltbld', 13:44:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:08 INFO - '_': '/tools/buildbot/bin/python'} 13:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:08 INFO - Downloading/unpacking jsonschema 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:10 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 13:44:10 INFO - Downloading/unpacking functools32 (from jsonschema) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:10 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:10 INFO - warning: no files found matching '*.txt' 13:44:10 INFO - no previously-included directories found matching 'build' 13:44:10 INFO - no previously-included directories found matching 'dist' 13:44:10 INFO - no previously-included directories found matching '.git*' 13:44:10 INFO - Installing collected packages: jsonschema, functools32 13:44:10 INFO - Running setup.py install for functools32 13:44:10 INFO - warning: no files found matching '*.txt' 13:44:10 INFO - no previously-included directories found matching 'build' 13:44:10 INFO - no previously-included directories found matching 'dist' 13:44:10 INFO - no previously-included directories found matching '.git*' 13:44:10 INFO - Successfully installed jsonschema functools32 13:44:10 INFO - Cleaning up... 13:44:10 INFO - Return code: 0 13:44:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:10 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 0x7fcc2f0ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bed240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, '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': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', '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 13:44:10 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 13:44:10 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 13:44:10 INFO - Using env: {'DISPLAY': ':0', 13:44:10 INFO - 'HOME': '/home/cltbld', 13:44:10 INFO - 'LANG': 'en_US.UTF-8', 13:44:10 INFO - 'LANGUAGE': 'en_US:en', 13:44:10 INFO - 'LOGNAME': 'cltbld', 13:44:10 INFO - 'MAIL': '/var/mail/cltbld', 13:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:10 INFO - 'MOZ_NO_REMOTE': '1', 13:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:10 INFO - 'NO_EM_RESTART': '1', 13:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:10 INFO - 'PWD': '/builds/slave/test', 13:44:10 INFO - 'SHELL': '/bin/bash', 13:44:10 INFO - 'SHLVL': '1', 13:44:10 INFO - 'TERM': 'linux', 13:44:10 INFO - 'TMOUT': '86400', 13:44:10 INFO - 'USER': 'cltbld', 13:44:10 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:10 INFO - '_': '/tools/buildbot/bin/python'} 13:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:10 INFO - Downloading/unpacking flake8 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:44:12 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 13:44:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:44:12 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 13:44:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:12 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 13:44:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:13 INFO - no previously-included directories found matching 'docs/_build' 13:44:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:44:13 INFO - Running setup.py install for pep8 13:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:13 INFO - no previously-included directories found matching 'docs/_build' 13:44:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:44:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:44:13 INFO - Cleaning up... 13:44:13 INFO - Return code: 0 13:44:13 INFO - Running post-action listener: _resource_record_post_action 13:44:13 INFO - Running post-action listener: _start_resource_monitoring 13:44:13 INFO - Starting resource monitoring. 13:44:13 INFO - ##### 13:44:13 INFO - ##### Running install step. 13:44:13 INFO - ##### 13:44:13 INFO - Running pre-action listener: _resource_record_pre_action 13:44:13 INFO - Running main action method: install 13:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:13 INFO - Reading from file tmpfile_stdout 13:44:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:44:13 INFO - Reading from file tmpfile_stdout 13:44:13 INFO - Output received: 13:44:13 INFO - Usage: mozinstall [options] installer 13:44:13 INFO - Options: 13:44:13 INFO - -h, --help show this help message and exit 13:44:13 INFO - -d DEST, --destination=DEST 13:44:13 INFO - Directory to install application into. [default: 13:44:13 INFO - "/builds/slave/test"] 13:44:13 INFO - --app=APP Application being installed. [default: firefox] 13:44:13 INFO - mkdir: /builds/slave/test/build/application 13:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:44:28 INFO - Reading from file tmpfile_stdout 13:44:28 INFO - Output received: 13:44:28 INFO - /builds/slave/test/build/application/firefox/firefox 13:44:28 INFO - Running post-action listener: _resource_record_post_action 13:44:28 INFO - ##### 13:44:28 INFO - ##### Running run-tests step. 13:44:28 INFO - ##### 13:44:28 INFO - Running pre-action listener: _resource_record_pre_action 13:44:28 INFO - Running main action method: run_tests 13:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:44:28 INFO - Python 2.7.3 13:44:28 INFO - Return code: 0 13:44:28 INFO - grabbing minidump binary from tooltool 13:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:28 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 0x1c7c0b0>, '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 0x1c7cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:44:28 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 13:44:28 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 13:44:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:44:28 INFO - Return code: 0 13:44:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:44:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:44:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:44:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:44:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:44:29 INFO - Return code: 0 13:44:29 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/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test/build 13:44:29 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/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 13:44:29 INFO - Using env: {'DISPLAY': ':0', 13:44:29 INFO - 'HOME': '/home/cltbld', 13:44:29 INFO - 'LANG': 'en_US.UTF-8', 13:44:29 INFO - 'LANGUAGE': 'en_US:en', 13:44:29 INFO - 'LOGNAME': 'cltbld', 13:44:29 INFO - 'MAIL': '/var/mail/cltbld', 13:44:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:44:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:29 INFO - 'MOZ_NO_REMOTE': '1', 13:44:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:29 INFO - 'NO_EM_RESTART': '1', 13:44:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:29 INFO - 'PWD': '/builds/slave/test', 13:44:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:44:29 INFO - 'SHELL': '/bin/bash', 13:44:29 INFO - 'SHLVL': '1', 13:44:29 INFO - 'TERM': 'linux', 13:44:29 INFO - 'TMOUT': '86400', 13:44:29 INFO - 'USER': 'cltbld', 13:44:29 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449783817.41195-403611689', 13:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:29 INFO - '_': '/tools/buildbot/bin/python'} 13:44:29 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/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 13:44:29 INFO - mozversion INFO | application_buildid: 20151210130140 13:44:29 INFO - mozversion INFO | application_changeset: 760f2be9b5490933e5c64dfab9e39b620b57c945 13:44:29 INFO - mozversion INFO | application_display_name: Nightly 13:44:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:44:29 INFO - mozversion INFO | application_name: Firefox 13:44:29 INFO - mozversion INFO | application_remotingname: firefox 13:44:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:44:29 INFO - mozversion INFO | application_vendor: Mozilla 13:44:29 INFO - mozversion INFO | application_version: 45.0a1 13:44:29 INFO - mozversion INFO | platform_buildid: 20151210130140 13:44:29 INFO - mozversion INFO | platform_changeset: 760f2be9b5490933e5c64dfab9e39b620b57c945 13:44:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:44:29 INFO - mozversion INFO | platform_version: 45.0a1 13:44:29 INFO - 2015-12-10 13:44:29,555 DEBUG : using testdate: 1449783869 13:44:29 INFO - 2015-12-10 13:44:29,555 DEBUG : actual date: 1449783869 13:44:29 INFO - 2015-12-10 13:44:29,564 INFO : starting webserver on 'localhost:48437' 13:44:29 INFO - 2015-12-10 13:44:29,565 INFO : Starting test suite talos-linux64-ix-053.e 13:44:29 INFO - 2015-12-10 13:44:29,565 INFO : Starting test dromaeo_css 13:44:29 INFO - 2015-12-10 13:44:29,565 DEBUG : operating with platform_type : linux_ 13:44:29 INFO - 2015-12-10 13:44:29,566 INFO : Initialising browser for dromaeo_css test... 13:44:29 INFO - 2015-12-10 13:44:29,582 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVN2wPE/profile http://localhost:48437/getInfo.html 13:44:34 INFO - 2015-12-10 13:44:34,143 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:44:34 INFO - 2015-12-10 13:44:34,143 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:44:34 INFO - 2015-12-10 13:44:34,143 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:44:34 INFO - 2015-12-10 13:44:34,143 DEBUG : BROWSER_OUTPUT: __metrics 13:44:34 INFO - 2015-12-10 13:44:34,260 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] 13:44:35 INFO - 2015-12-10 13:44:35,067 INFO : Browser initialized. 13:44:35 INFO - 2015-12-10 13:44:35,067 INFO : Running cycle 1/1 for dromaeo_css test... 13:44:35 INFO - 2015-12-10 13:44:35,068 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVN2wPE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:44:47 INFO - 2015-12-10 13:44:47,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 143073280 13:44:47 INFO - 2015-12-10 13:44:47,146 DEBUG : BROWSER_OUTPUT: 13:45:36 INFO - 2015-12-10 13:45:36,762 DEBUG : BROWSER_OUTPUT: 1449783936759 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] 13:47:48 INFO - 2015-12-10 13:47:48,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48437/tests/dromaeo/cssquery-ext.html) 13:47:49 INFO - 2015-12-10 13:47:49,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 147189760 13:47:49 INFO - 2015-12-10 13:47:49,628 DEBUG : BROWSER_OUTPUT: 13:50:51 INFO - 2015-12-10 13:50:51,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/dromaeo/cssquery-ext.html (next: http://localhost:48437/tests/dromaeo/cssquery-jquery.html) 13:50:52 INFO - 2015-12-10 13:50:52,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 145342464 13:50:52 INFO - 2015-12-10 13:50:52,263 DEBUG : BROWSER_OUTPUT: 13:53:54 INFO - 2015-12-10 13:53:54,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48437/tests/dromaeo/cssquery-mootools.html) 13:53:54 INFO - 2015-12-10 13:53:54,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 145846272 13:53:54 INFO - 2015-12-10 13:53:54,736 DEBUG : BROWSER_OUTPUT: 13:56:56 INFO - 2015-12-10 13:56:56,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48437/tests/dromaeo/cssquery-prototype.html) 13:56:57 INFO - 2015-12-10 13:56:57,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 144375808 13:56:57 INFO - 2015-12-10 13:56:57,086 DEBUG : BROWSER_OUTPUT: 13:59:59 INFO - 2015-12-10 13:59:59,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48437/tests/dromaeo/cssquery-yui.html) 14:00:00 INFO - 2015-12-10 14:00:00,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 143781888 14:00:00 INFO - 2015-12-10 14:00:00,312 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/dromaeo/cssquery-yui.html (next: http://localhost:48437/tests/dromaeo/cssquery-dojo.html) 14:03:02 INFO - 2015-12-10 14:03:02,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 146968576 14:03:02 INFO - 2015-12-10 14:03:02,889 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,890 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:03:02 INFO - 2015-12-10 14:03:02,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:03:02 INFO - 2015-12-10 14:03:02,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:03:02 INFO - 2015-12-10 14:03:02,890 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:03:02 INFO - 2015-12-10 14:03:02,890 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2642.379040925382;2713.986430067852;2729.945401091978;2737.7262273772612;2742.547479665856;4520.050789334236;4727.361806156172;4743.193657078301;4745.691530050544;4761.095391875541;4599.655025873056;4647.395838540985;4647.488776234612;4691.038337140878;4692.601128904047;4314.288142456491;4326.826926922935;4346.391505189276;4401.317795741666;4411.4706235251815;4193.287141186006;4300.956990430087;4308.655307575402;4375.540568240337;4431.26884064129;4229.809658565372;4277.871663850089;4279.379489973952;4292.828286868522;4299.097189590189;4304.935425968613;4353.303471444554;4375.8249670013165;4396.736195828228;4412.0955204183065;4145.17096580685;4237.427947227146;4345.543717909605;4380.408644832939;4406.228909940747;4583.9541604583865;4636.188666983265;4684.250519916831;4684.344191813149;4686.671932964694;5058.861756104847;5072.061668591323;5107.3105130807235;5110.8245103626;5115.7442127893455;4891.828785992473;4990.950090499085;5030.723310217936;5112.156494178494;5174.741262936838;4654.115718013567;4670.789814458358;4679.485256621769;4720.291956206562;4728.3143944127905;5142.742862856842;5143.8456846294675;5144.485551444825;5151.793928242828;5153.3300670913295;4764.285357196448;4869.610431165498;4879.2925025871045;4959.553640172402;5012.974935125301;5109.284700141983;5125;5135.589152867761;5145.434002259748;5182.844514664566;5074.873128171826;5076.873078173076;5077.339945807022;5099.64302498829;5101.132807422747;4758.547937945958;4868.78090485929;4918.0901533216465;4966.453690094087;5035.446100928895;4114.156597897424;4158.979205104016;4159.251334759711;4162.105147393325;4169.249535083653;3601.991442396133;3625.2749450109554;3649.927001459956;3667.3765459871884;3671.9816400918357;4199.475065616798;4293.592108749664;4306.763128027988;4307.483102027777;4338.58783415575;4998.325226094504;5034.924476132861;5038.546530812245;5054.342935418372;5060.696358218519;4161.687873409506;4243.151369726005;4349.847755328548;4362.672799540047;4371.169477799208;4368.672349573794;4443.022535042285;4447.444069491314;4477.865664030084;4484.955150448519;4732.337472753818;4798.520147985174;4811.422629284508;4812.639052071038;4859.708417494961;4842.806287748451;4902.950970490392;4971.875703107451;5078.035173317058;5093.388793344822;4738.147133515862;4786.1863483208635;4787.138315103315;4816.590589799906;4868;5008.599312055099;5020.221865610836;5021.221710634857;5026.974865125651;5034.352166714666;4873.390826146731;4994.225894986283;5021.096202683552;5117.8464646060675;5128.076946149728;4851.490593487633;4880.487548807466;4882.829100981448;4897.632677549269;4939.16034274167;4889.951100489092;4903.460619331942;4906.288588154769;4921.532454416824;4962.404511458648;4589.58693717567;4720.221163507983;4730.645201609824;4810.783514741775;4839.95160048395;4885.609151267961;4893.90212195747;4930.260460930889;4935.901281974268;4993.850184494471;4638.953610463852;4833.10587541306;4846.757662116951;4857.611391088775;4877.170880950176 14:03:02 INFO - 2015-12-10 14:03:02,891 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.758679974211;564.1847530318688;585.0084107437895;588.1883001457988;601.3745704467354;36515;37275.627243727555;37280.25439491209;37342.81328593357;37371.43942840853;40709.796451017704;40830.59169408312;40876;41150.382744258786;41218;7896.328812050968;8052.235037671441;8053.154418786031;8063.435559510836;8074.798130046737;7754.883676744853;7848.097468791077;7849.64676589552;7850.097238817523;7855.528668279893;7944.880826787603;7999.320057795095;8016.599170041503;8054.919450805475;8059.959700201491;7733.342665873408;7749.7675069748;7800.297973182441;7814.6483408246195;7818.8827167592535;7862.488938219055;7915.841683166304;7958.283754462068;7977.680892764282;8020;37259.81370093132;37798.43302350467;37929;37993.81003094994;38001.429978550346;2809.7330753578376;2878.6113874626867;3079.5534647476215;3090.5209692497474;3393.9490907636405;28041.439171216665;28230.717692823015;28399.432011359862;28447.431051378855;28527.714722852714;3388.4070287699556;3414.5219669246326;3424.5890493140732;3533.134382076382;3535.169235229719;219682;219849;220532;220752;221342;50375.74812125916;51469.227961580604;53157.46842531602;53711.19433208505;54471.182932256044;49993.75003125034;50048;50051.74353205849;50193;50254.24618630723;13042.54351097707;13189.340532973312;13290.73418531624;13307.467701292033;13390.464381424828;10118.494075296207;10212.285140040274;10220.540075696612;10241.743956401;10271.897281027244;17679.292828286983;18520.629587408177;18903.621927561373;18944;18996.810031899506;7271.200167981518;7385.150707668687;7432.85134297311;7497.2877576630135;7497.475176737576;815.9836803263902;840.7603832907714;853.6926706385697;966.2028826218398;994.8457989011715;25985.480290394087;26877.193684189504;27073.729262707122;27093.32266693309;27198.45603087927;854.372036553133;913.3828496947991;1009.5053423822275;1062.7449412141184;1096.166913145999;12650.304233267074;12818.35350631084;12824.294663793395;12993.610191694264;13028.153170043917;271450;274722;276554;276955;278166;44109.11781764411;44113;44213.77893110514;44496.99999999935;44618.77690611591;1185.0387608507933;1186.0985650905375;1193.6717402714323;1197.2935967778878;1199.7900367435664;24773.50452990894;24999;25180.370490737878;25432;25521;39440.40839387469;39503;39829;39843.203135936536;39845.40231896582;253213;254068;256449;256828;257240;28072.85963570169;28810.567841482814;29135.85432072826;29283.267918302212;29389.26526836846;33821.49267760936;33829.492557612146;34796.65203347934;34961.65038349685;36306.455403168446;31652.841735792095;31985.68014319827;32188.19529511687;32215.677843221267;33162.17094572655;31732.841335793175;32478.83760581182;32691;32801.34397312088;33039.66960330366;32101.83949080333;32270.677293226767;32440.35119297648;32526.83736581302;32527;27923.581146282417;28654.283642909093;29389.26526836846;29436.893975520652;29458;23081.30300578365;23347.299581012598;23687.881560592086;23866.40333991664;23903.76096239015 14:03:02 INFO - 2015-12-10 14:03:02,892 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.62911853283595;348.82035751587927;350.1054804973292;350.4253025038936;352.4466587457689;15337.693246135084;15726.370945162194;16278.186090695448;16742.41401550946;16839.74740378895;14983.550493485185;15427.84572154278;15839.445619403323;16123.355065797383;16153.111578863158;4614.238650622643;4712.976435117819;4721.669483136182;4725.527447255281;4730.881727956794;4680.5787479126875;4698.412698412699;4717.033008233304;4724.811007559693;4735.81056757731;4719.032598317354;5033.798648054073;6198.690065496729;6397.5521713480075;6415.422611964922;6322.178116844827;6353.936460635381;6392.105105285264;6707.5975441473665;6726.159230096238;6471;6497.642629655367;6501.154849869534;6517.185351831021;6519.739210431577;19399;19752;20102.69845952312;20252.594948100956;20330.69503957427;1919.577692907558;1932.4975506368305;1933.4006457997925;2003.4690806936173;2090.571432856276;13021.153625014344;13686;13774.793378099337;13973.23147226902;14332.57002289933;1808.2134271591767;1888.9055547222583;1909.493984094216;1944.912478938437;1962.0189905047475;51209.743951280376;53310;61017.6949115256;61038.38961610371;61067.38932610661;15142.848571514143;15593.688126237412;15603;15699.843001570067;15726.606834828992;23238.65142022871;23287.18494852672;23343.299701008997;23589.882050589636;23628.409289767893;8181.509449039205;8217.79455513617;8323.375746818892;8559.828803423896;8714.215720585178;6687;6732.225794033749;6752.153377323609;6753.527253092335;7306.5981371024045;7675.654595543214;7712.2287771223555;7794.337481314038;7797;7867.449278550446;1786.8749187557007;1833;3172.9682703173135;3199.120241933487;3248.1256978784704;398.6631296554407;401.26167851154014;406.059971166748;417.8537511870821;771.864923638361;9474.905250947402;9744.171745401578;9928.453935033498;10014.29899907014;10131.138853197413;805.6334367862609;834.8121672623732;860;898.8606765951288;915.1260546178383;8512.106228845882;8662.22040016389;9045.638174472948;9476.194523465445;9513.334066615409;524783;524921;525528;540013;551082;73828.63085684537;74401;75552.24447755562;76867.61566192133;77582.6120869392;1048.8007278617038;1052.8420736889375;1066.893310668927;1082.2910993299402;1082.350589646206;14542;14917.776233356291;15022.248887555359;15077.472288469851;15383.692326153638;34104.48843267403;34706;35723;36073.81963090168;37021;47810.521894780606;48986;49217.50782492129;50677.23984140315;51187;8547.487150770974;9213.447193168431;9246.306527010367;9289.34974551775;9401.670941517013;11000.449977500934;11014.118870490182;11093.33439993603;11182;12574.182678125893;12603.432845522157;13673.794893076412;13729.588112356645;13890.930545347208;13949.3722782473;12378.48185412336;12662.113652044269;12832.29422381778;12947.611571652866;13775.517856874962;14261.572152835432;14281.928590356982;14403.855961440251;14617.853821462075;14718.63203419923;9084.772880678036;9142.63429462814;9185.173334399937;9207.76980575491;9208.12522810332;9877.901220987698;9946.154576860758;11016.834747478633;14168.291585420482;14374.353154107881 14:03:02 INFO - 2015-12-10 14:03:02,894 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1468.5447511271514;1653.9917300413497;1705.8635309175268;1707.3938751743135;1712.9486115416535;6023.518118550516;6132.938670613293;7013.473989450792;7153.14162300524;7161.498695091339;6547.57440766351;6810.897836532456;6852.965735171317;6870.519063665545;6891.276415976326;2081.6669332906736;2095.2876022152464;2112.9788702113015;2113.3765539165984;2114.8202402795782;2059.3615979046544;2062.484378905274;2091.1948899673584;2139.3474990128007;2146.6672665736837;2014.869033512817;2071.9482012949647;2073.917043318273;2075.2632815350557;2082.0630716177707;2072.6372884745183;2077.200277893007;2087.65553683642;2087.9164833406644;2098.926537571193;2029.9797002030086;2049.2008116834445;2059.1454546363243;2068.307117115753;2091.1217288738767;6843.863122737567;6921.134858142732;6930.410915072225;6933.68798404073;6997.895031574531;4011.0774521859844;4114.321137012389;4115.464989551339;4122.9381559276635;4150.128473020669;2568.7816535594498;2591.663083799113;2610.5953577195564;2661.5076210901047;2667.5731882898644;831.1522247307712;840.6679361652174;844.8014716541608;854.6325080215505;878.8769572259889;9279.72160835176;9329.30030247734;9331.72004839856;9339.299552533586;9344.486053267068;3802.6957843372466;3812;3872.302985462644;3925.862594809225;3930.901727456779;8025.518468891885;8025.839483210303;8084.717034903751;8101;8107.635156417975;4136.751794892316;4139.8965025873995;4164.68812324117;4171.228322760299;4205.600467955539;3264.265540253424;3324.86700531976;3760.9435858462143;3764.4729737836724;3771.698264138862;3359.277755282577;3397.779144355609;3423.8801641942414;3428.194374322032;3448.396530607184;1095.835624656308;1112.8831472695413;1119.4514687802919;1122.6014764758393;1132.7904337697553;1168.9240199387013;1183.7336599265097;1184.63563479718;1201.1711918776016;1208.4199584199635;6491.67541622917;6529.673516324165;6682.3317668232785;6707.396334329934;6720.764773232913;442.5817602365798;443.26196882191437;444.3778709806297;447.5703324808155;457.75510102095217;5165.715885626327;5217.165253559412;5218.504242096995;5221.7128057956415;5221.869453263623;8099.757007289791;8187.795305117301;8343.749687509384;8469.3647976402;8527.65889364431;8393.076761556224;8414.242718155396;8451.577421128919;8488.533130677748;8506.532140732319;6609.966950165219;6616.139901812733;6698.933010669928;6714.127163468718;6737.056812046416;6463.254921171351;6466.708998095003;6467.256265529524;6483.254425740912;6487.448566871869;7429.405647548291;7473.775786726407;7698.730544430918;7721.227877212234;7740;7174.246704095995;7338.596377199092;7356.668949897375;7785.727499537489;7823.2959033684965;5249.658772179796;5365.678059316453;6215.254169499689;6313.179286692701;6327.430531252209;6229.3770622937345;6510.7721229756735;6555.246146693191;6586.37429444202;6594.802155935329;6182.752689892354;6365.045243213555;6429.067785171217;6443.9355606445215;6538.705758240986;6138.539609529393;6251.249850018027;6261.373862613702;6261.874762504815;6289.779857704958;6240.438360547572;6259;6321.683915804099;6328.430441260309;6329.841753956188;5693.943060569507;5699.116636921284;5722.685252311163;5723.599348045597;5737.454941780524;5817.592768506164;5823.18475413451;5999.88000239984;6000.8799824004145;6025.337212906665 14:03:02 INFO - 2015-12-10 14:03:02,894 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.18442535069397;309.4553585689187;310.8274907426379;313.6534129786585;317.13738630923876;5485.835424937253;5624.493795558399;5627.071533197018;5628.521575666068;5649.604527683064;5499.4225606311265;5530.640508366953;5532.75102620382;5537.031019571569;5557.472040156189;4150.315197992328;4221.598948099926;4246.872593822182;4257.531671516131;4263.5523270056665;4252.425922500469;4261.105167914741;4262.254105531535;4269.743815371072;4278.294081476568;4214.934682005825;4218.093109981353;4223.324268117102;4230.344296634012;4234.491860976687;4223.640990515794;4225.176090662322;4226.218149642326;4229.217594744982;4236.046889449849;3609.693176080036;3692.7045836333027;3695.4087346024776;3695.5565332160045;3696.5194524711615;5232.084385232569;5366.087765079946;5370.22131790892;5388.272583201257;5397.4062853086125;4799.880002999953;4818.301346304801;4826.686265392738;4829.758512074382;4850.175470170079;5824.825255242349;5831.475167234969;5851.707414629294;5852.092925596539;5857.502112320458;3882.592327805596;3959.604039596017;3965.722399432041;3969.7816620085882;4000.659943904772;6063.54523410746;6132.478739307119;6135.723892424807;6140.201773769426;6146.569740118193;4143.316352801754;4150.6471949884;4155.148194620096;4157.438745769343;4162.001119731242;4169.145325208325;4196.153692375345;4210.526315789449;4228.323468245066;4230.492340919048;4749.1926372516755;4801.807927682923;4836.3712717347225;4850;4855.271709243571;5857.853553661193;5859.150423188699;5859.589828711949;5866.530677545871;5869.325027621878;1464.2239613005124;1469.067142364606;1472.10201776916;1472.2932992163821;1476.6677497563178;994.4331730913455;1000.884898236712;1004.467632154959;1009.9545520451597;1015.5988384588194;5057.873553161126;5074.3657042869645;5077.416097148801;5080.085584594734;5088.338515992971;6060.000099983541;6063.242094738158;6065.6663883486835;6070.271567411939;6079.08813677943;5078.847634570969;5078.923816142761;5083.694978301313;5088.262201980692;5088.898222035538;3204.2630195055267;3253.788503747249;3279.934401312008;3289.851956661956;3293.5883014623173;5629.831105066773;5699.259096317535;5700.800471983461;5706.229658995982;5771.105478650816;6287.49700023997;6311.873762524816;6313.905291420632;6314.684265786692;6316.30520642729;5712.457316554921;5745.339285982082;5746.626469279484;5749.355296563627;5757.827265182052;5928.614640048383;6075.422834830684;6103.328633850362;6106.908396374147;6107.144999700135;6004.729787159501;6010.789622363196;6014.879702406015;6027.156198132177;6029.306629737636;5724.284464441945;5768.451997060272;5769.653820770767;5775.624584402;5786.1899334094105;4143.109231515239;4185.497740271187;4190.287651099259;4193.475815523059;4195.286801243735;5952.226210592596;6104.145419641342;6108.267007958895;6109.602875813058;6113.266408031065;5861.0915308127305;5863.882722345444;5865.208196893535;5868.911966320594;5872.119182122716;5860.853478663067;5864.765409383747;5868.471837534642;5868.735906884286;5872.618279811799;5605.439456054525;5725.971370143123;5731.942680573141;5745.798897038583;5770.365259821332;5896.941030589639;5901.29184497863;5921.940780592139;5930.229070220844;5939.851503712269;5699.914501282401;5758.337791153904;5765.798197063083;5769.423057694365;5771.567132465166 14:03:02 INFO - 2015-12-10 14:03:02,895 DEBUG : BROWSER_OUTPUT: |5;yui.html;730.8720973829581;735.649118266297;790.4348390900504;798.5647821937043;817.9836403271931;11273.210875238736;11294.152938529613;12591.370431478435;12662.683432914182;12736.872631273707;10955.123590112791;11039;11076.778464430707;11083.390413527253;11096.278741881772;805.8912046873655;811.5293129984594;827.8592639251342;827.8882350882614;828.6229765456703;826.017039722731;827.2761333832897;829.4152622401193;830.3564737328559;831.4470876866876;854.7008547008528;858.8282343531288;859.2824991132412;861.3109512390095;862.3230763850379;846.3144852669358;854.4403415762654;855.2388374346774;855.2473823035689;861.8017855893148;631.564220687724;635.3678090300181;635.4789072960175;636.8758092171983;638.6870433487558;11379;11532.538698452052;11535.192536522447;11546.942265288704;11547.942260288728;10560.894391056068;11210.551577936872;11218.663440096729;11424.600138995178;11840.348780817052;8926.642934282621;8999.145081217273;9157.725268241897;9193.678221262291;9397.201237894787;3132.4361614909308;3146.685331466858;3161.920951976196;3185.267388500658;3186.9362612747846;41822.163556728694;41944.58055419437;42040.78979605113;42198.15603687909;42268.57731422708;8741.34439916996;8810.533318769953;8834.779130521789;8969.686060987835;9334.71995840126;15789.684206316038;15895.046297221972;15909.761353579706;15920.840791592167;16432.589185270463;6455.386738259858;6494.285628580852;6571.769988050395;6628.270890202074;6639.402453779183;3523.8766643167364;3539.964600354015;3549.4498352755363;3580.1765593913547;3592.856285748541;2609.830361026527;2630.500204961051;2639.722829102955;2655.243255672124;2655.681318241823;476.3830839063421;482.1754799293248;483.58653351384766;488.75562218890553;492.89402778402814;381.7861997281531;388.32431569069615;403.9171969746195;419.4986990546268;432.4443090628527;6742.730290788313;7194.820129496805;7248.130224373003;7356.154042285206;7396.741114061089;391.04779861038463;392.8766307852583;487.90485855258595;507.90603738307794;510.7956817273046;3238.6923242291946;3472.6527347265073;3510.1575621851084;3526.2947410518;3533.6643018913164;46601;53115.46884531105;53221.733891330296;53388;53404.19893701598;43678.563214368085;44263.114737705066;44686.553134468886;45125.323120153225;45149;39612.80193599014;41335.93320334031;41393.37909931293;41789.79105104455;41893.16213675709;7163.283671633004;7562.886556701544;7581.166071731995;7720.150783413932;7912.960435197787;32565.34869302648;32624.83687581547;33059.33881322312;33088.66911330856;33349.83325083359;39348;40463;40723.796381017906;40979.180416392104;41293.58706412897;9257.120573545502;9388.06119388083;9504.572294246636;9581.185599223865;10135.341202821794;11214.383208923588;11245;11404.144689148514;11515.424228788695;11527.654170374903;10742.24804263694;10784.514696838503;11043.668689939315;11242.94378528102;11398.487068081791;10216.693499195037;10365.637202698172;10430.94784526103;10434.791304173723;10737.355758654505;10097.293189476666;10274.486275686335;10430.843537346795;10475.685729428129;10608.257421980386;8825.470471771714;8926.73219803407;9206.907930920604;9254.768630784014;9495.857562136436;8441.577921104043;9104.317176211678;9110;9129.178373946377;9200.816298018706 14:03:02 INFO - 2015-12-10 14:03:02,895 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:03:02 INFO - 2015-12-10 14:03:02,895 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:03:02 INFO - 2015-12-10 14:03:02,895 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,336 14:03:02 INFO - 2015-12-10 14:03:02,895 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: __startTimestamp1449784982887__endTimestamp 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4640.42 Median:4764.29 stddev:491.68 (10.3%) stddev-sans-first:467.54 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: Values: 2642.4 2714.0 2729.9 2737.7 2742.5 4520.1 4727.4 4743.2 4745.7 4761.1 4599.7 4647.4 4647.5 4691.0 4692.6 4314.3 4326.8 4346.4 4401.3 4411.5 4193.3 4301.0 4308.7 4375.5 4431.3 4229.8 4277.9 4279.4 4292.8 4299.1 4304.9 4353.3 4375.8 4396.7 4412.1 4145.2 4237.4 4345.5 4380.4 4406.2 4584.0 4636.2 4684.3 4684.3 4686.7 5058.9 5072.1 5107.3 5110.8 5115.7 4891.8 4991.0 5030.7 5112.2 5174.7 4654.1 4670.8 4679.5 4720.3 4728.3 5142.7 5143.8 5144.5 5151.8 5153.3 4764.3 4869.6 4879.3 4959.6 5013.0 5109.3 5125.0 5135.6 5145.4 5182.8 5074.9 5076.9 5077.3 5099.6 5101.1 4758.5 4868.8 4918.1 4966.5 5035.4 4114.2 4159.0 4159.3 4162.1 4169.2 3602.0 3625.3 3649.9 3667.4 3672.0 4199.5 4293.6 4306.8 4307.5 4338.6 4998.3 5034.9 5038.5 5054.3 5060.7 4161.7 4243.2 4349.8 4362.7 4371.2 4368.7 4443.0 4447.4 4477.9 4485.0 4732.3 4798.5 4811.4 4812.6 4859.7 4842.8 4903.0 4971.9 5078.0 5093.4 4738.1 4786.2 4787.1 4816.6 4868.0 5008.6 5020.2 5021.2 5027.0 5034.4 4873.4 4994.2 5021.1 5117.8 5128.1 4851.5 4880.5 4882.8 4897.6 4939.2 4890.0 4903.5 4906.3 4921.5 4962.4 4589.6 4720.2 4730.6 4810.8 4840.0 4885.6 4893.9 4930.3 4935.9 4993.9 4639.0 4833.1 4846.8 4857.6 4877.2 14:03:02 INFO - 2015-12-10 14:03:02,896 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,897 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40557.83 Median:33100.92 stddev:65559.74 (198.1%) stddev-sans-first:65674.85 14:03:02 INFO - 2015-12-10 14:03:02,898 DEBUG : BROWSER_OUTPUT: Values: 554.8 564.2 585.0 588.2 601.4 36515.0 37275.6 37280.3 37342.8 37371.4 40709.8 40830.6 40876.0 41150.4 41218.0 7896.3 8052.2 8053.2 8063.4 8074.8 7754.9 7848.1 7849.6 7850.1 7855.5 7944.9 7999.3 8016.6 8054.9 8060.0 7733.3 7749.8 7800.3 7814.6 7818.9 7862.5 7915.8 7958.3 7977.7 8020.0 37259.8 37798.4 37929.0 37993.8 38001.4 2809.7 2878.6 3079.6 3090.5 3393.9 28041.4 28230.7 28399.4 28447.4 28527.7 3388.4 3414.5 3424.6 3533.1 3535.2 219682.0 219849.0 220532.0 220752.0 221342.0 50375.7 51469.2 53157.5 53711.2 54471.2 49993.8 50048.0 50051.7 50193.0 50254.2 13042.5 13189.3 13290.7 13307.5 13390.5 10118.5 10212.3 10220.5 10241.7 10271.9 17679.3 18520.6 18903.6 18944.0 18996.8 7271.2 7385.2 7432.9 7497.3 7497.5 816.0 840.8 853.7 966.2 994.8 25985.5 26877.2 27073.7 27093.3 27198.5 854.4 913.4 1009.5 1062.7 1096.2 12650.3 12818.4 12824.3 12993.6 13028.2 271450.0 274722.0 276554.0 276955.0 278166.0 44109.1 44113.0 44213.8 44497.0 44618.8 1185.0 1186.1 1193.7 1197.3 1199.8 24773.5 24999.0 25180.4 25432.0 25521.0 39440.4 39503.0 39829.0 39843.2 39845.4 253213.0 254068.0 256449.0 256828.0 257240.0 28072.9 28810.6 29135.9 29283.3 29389.3 33821.5 33829.5 34796.7 34961.7 36306.5 31652.8 31985.7 32188.2 32215.7 33162.2 31732.8 32478.8 32691.0 32801.3 33039.7 32101.8 32270.7 32440.4 32526.8 32527.0 27923.6 28654.3 29389.3 29436.9 29458.0 23081.3 23347.3 23687.9 23866.4 23903.8 14:03:02 INFO - 2015-12-10 14:03:02,898 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,898 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28693.93 Median:399.96 stddev:87048.44 (21764.2%) stddev-sans-first:87266.59 14:03:02 INFO - 2015-12-10 14:03:02,898 DEBUG : BROWSER_OUTPUT: Values: 332.6 348.8 350.1 350.4 352.4 15337.7 15726.4 16278.2 16742.4 16839.7 14983.6 15427.8 15839.4 16123.4 16153.1 4614.2 4713.0 4721.7 4725.5 4730.9 4680.6 4698.4 4717.0 4724.8 4735.8 4719.0 5033.8 6198.7 6397.6 6415.4 6322.2 6353.9 6392.1 6707.6 6726.2 6471.0 6497.6 6501.2 6517.2 6519.7 19399.0 19752.0 20102.7 20252.6 20330.7 1919.6 1932.5 1933.4 2003.5 2090.6 13021.2 13686.0 13774.8 13973.2 14332.6 1808.2 1888.9 1909.5 1944.9 1962.0 51209.7 53310.0 61017.7 61038.4 61067.4 15142.8 15593.7 15603.0 15699.8 15726.6 23238.7 23287.2 23343.3 23589.9 23628.4 8181.5 8217.8 8323.4 8559.8 8714.2 6687.0 6732.2 6752.2 6753.5 7306.6 7675.7 7712.2 7794.3 7797.0 7867.4 1786.9 1833.0 3173.0 3199.1 3248.1 398.7 401.3 406.1 417.9 771.9 9474.9 9744.2 9928.5 10014.3 10131.1 805.6 834.8 860.0 898.9 915.1 8512.1 8662.2 9045.6 9476.2 9513.3 524783.0 524921.0 525528.0 540013.0 551082.0 73828.6 74401.0 75552.2 76867.6 77582.6 1048.8 1052.8 1066.9 1082.3 1082.4 14542.0 14917.8 15022.2 15077.5 15383.7 34104.5 34706.0 35723.0 36073.8 37021.0 47810.5 48986.0 49217.5 50677.2 51187.0 8547.5 9213.4 9246.3 9289.3 9401.7 11000.4 11014.1 11093.3 11182.0 12574.2 12603.4 13673.8 13729.6 13890.9 13949.4 12378.5 12662.1 12832.3 12947.6 13775.5 14261.6 14281.9 14403.9 14617.9 14718.6 9084.8 9142.6 9185.2 9207.8 9208.1 9877.9 9946.2 11016.8 14168.3 14374.4 14:03:02 INFO - 2015-12-10 14:03:02,898 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,898 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4862.63 Median:6012.20 stddev:2510.37 (41.8%) stddev-sans-first:2504.46 14:03:02 INFO - 2015-12-10 14:03:02,899 DEBUG : BROWSER_OUTPUT: Values: 1468.5 1654.0 1705.9 1707.4 1712.9 6023.5 6132.9 7013.5 7153.1 7161.5 6547.6 6810.9 6853.0 6870.5 6891.3 2081.7 2095.3 2113.0 2113.4 2114.8 2059.4 2062.5 2091.2 2139.3 2146.7 2014.9 2071.9 2073.9 2075.3 2082.1 2072.6 2077.2 2087.7 2087.9 2098.9 2030.0 2049.2 2059.1 2068.3 2091.1 6843.9 6921.1 6930.4 6933.7 6997.9 4011.1 4114.3 4115.5 4122.9 4150.1 2568.8 2591.7 2610.6 2661.5 2667.6 831.2 840.7 844.8 854.6 878.9 9279.7 9329.3 9331.7 9339.3 9344.5 3802.7 3812.0 3872.3 3925.9 3930.9 8025.5 8025.8 8084.7 8101.0 8107.6 4136.8 4139.9 4164.7 4171.2 4205.6 3264.3 3324.9 3760.9 3764.5 3771.7 3359.3 3397.8 3423.9 3428.2 3448.4 1095.8 1112.9 1119.5 1122.6 1132.8 1168.9 1183.7 1184.6 1201.2 1208.4 6491.7 6529.7 6682.3 6707.4 6720.8 442.6 443.3 444.4 447.6 457.8 5165.7 5217.2 5218.5 5221.7 5221.9 8099.8 8187.8 8343.7 8469.4 8527.7 8393.1 8414.2 8451.6 8488.5 8506.5 6610.0 6616.1 6698.9 6714.1 6737.1 6463.3 6466.7 6467.3 6483.3 6487.4 7429.4 7473.8 7698.7 7721.2 7740.0 7174.2 7338.6 7356.7 7785.7 7823.3 5249.7 5365.7 6215.3 6313.2 6327.4 6229.4 6510.8 6555.2 6586.4 6594.8 6182.8 6365.0 6429.1 6443.9 6538.7 6138.5 6251.2 6261.4 6261.9 6289.8 6240.4 6259.0 6321.7 6328.4 6329.8 5693.9 5699.1 5722.7 5723.6 5737.5 5817.6 5823.2 5999.9 6000.9 6025.3 14:03:02 INFO - 2015-12-10 14:03:02,899 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,899 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4837.65 Median:5515.03 stddev:1442.35 (26.2%) stddev-sans-first:1405.74 14:03:02 INFO - 2015-12-10 14:03:02,900 DEBUG : BROWSER_OUTPUT: Values: 307.2 309.5 310.8 313.7 317.1 5485.8 5624.5 5627.1 5628.5 5649.6 5499.4 5530.6 5532.8 5537.0 5557.5 4150.3 4221.6 4246.9 4257.5 4263.6 4252.4 4261.1 4262.3 4269.7 4278.3 4214.9 4218.1 4223.3 4230.3 4234.5 4223.6 4225.2 4226.2 4229.2 4236.0 3609.7 3692.7 3695.4 3695.6 3696.5 5232.1 5366.1 5370.2 5388.3 5397.4 4799.9 4818.3 4826.7 4829.8 4850.2 5824.8 5831.5 5851.7 5852.1 5857.5 3882.6 3959.6 3965.7 3969.8 4000.7 6063.5 6132.5 6135.7 6140.2 6146.6 4143.3 4150.6 4155.1 4157.4 4162.0 4169.1 4196.2 4210.5 4228.3 4230.5 4749.2 4801.8 4836.4 4850.0 4855.3 5857.9 5859.2 5859.6 5866.5 5869.3 1464.2 1469.1 1472.1 1472.3 1476.7 994.4 1000.9 1004.5 1010.0 1015.6 5057.9 5074.4 5077.4 5080.1 5088.3 6060.0 6063.2 6065.7 6070.3 6079.1 5078.8 5078.9 5083.7 5088.3 5088.9 3204.3 3253.8 3279.9 3289.9 3293.6 5629.8 5699.3 5700.8 5706.2 5771.1 6287.5 6311.9 6313.9 6314.7 6316.3 5712.5 5745.3 5746.6 5749.4 5757.8 5928.6 6075.4 6103.3 6106.9 6107.1 6004.7 6010.8 6014.9 6027.2 6029.3 5724.3 5768.5 5769.7 5775.6 5786.2 4143.1 4185.5 4190.3 4193.5 4195.3 5952.2 6104.1 6108.3 6109.6 6113.3 5861.1 5863.9 5865.2 5868.9 5872.1 5860.9 5864.8 5868.5 5868.7 5872.6 5605.4 5726.0 5731.9 5745.8 5770.4 5896.9 5901.3 5921.9 5930.2 5939.9 5699.9 5758.3 5765.8 5769.4 5771.6 14:03:02 INFO - 2015-12-10 14:03:02,901 DEBUG : BROWSER_OUTPUT: 14:03:02 INFO - 2015-12-10 14:03:02,901 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12346.93 Median:42233.37 stddev:14253.92 (33.8%) stddev-sans-first:14267.21 14:03:02 INFO - 2015-12-10 14:03:02,902 DEBUG : BROWSER_OUTPUT: Values: 730.9 735.6 790.4 798.6 818.0 11273.2 11294.2 12591.4 12662.7 12736.9 10955.1 11039.0 11076.8 11083.4 11096.3 805.9 811.5 827.9 827.9 828.6 826.0 827.3 829.4 830.4 831.4 854.7 858.8 859.3 861.3 862.3 846.3 854.4 855.2 855.2 861.8 631.6 635.4 635.5 636.9 638.7 11379.0 11532.5 11535.2 11546.9 11547.9 10560.9 11210.6 11218.7 11424.6 11840.3 8926.6 8999.1 9157.7 9193.7 9397.2 3132.4 3146.7 3161.9 3185.3 3186.9 41822.2 41944.6 42040.8 42198.2 42268.6 8741.3 8810.5 8834.8 8969.7 9334.7 15789.7 15895.0 15909.8 15920.8 16432.6 6455.4 6494.3 6571.8 6628.3 6639.4 3523.9 3540.0 3549.4 3580.2 3592.9 2609.8 2630.5 2639.7 2655.2 2655.7 476.4 482.2 483.6 488.8 492.9 381.8 388.3 403.9 419.5 432.4 6742.7 7194.8 7248.1 7356.2 7396.7 391.0 392.9 487.9 507.9 510.8 3238.7 3472.7 3510.2 3526.3 3533.7 46601.0 53115.5 53221.7 53388.0 53404.2 43678.6 44263.1 44686.6 45125.3 45149.0 39612.8 41335.9 41393.4 41789.8 41893.2 7163.3 7562.9 7581.2 7720.2 7913.0 32565.3 32624.8 33059.3 33088.7 33349.8 39348.0 40463.0 40723.8 40979.2 41293.6 9257.1 9388.1 9504.6 9581.2 10135.3 11214.4 11245.0 11404.1 11515.4 11527.7 10742.2 10784.5 11043.7 11242.9 11398.5 10216.7 10365.6 10430.9 10434.8 10737.4 10097.3 10274.5 10430.8 10475.7 10608.3 8825.5 8926.7 9206.9 9254.8 9495.9 8441.6 9104.3 9110.0 9129.2 9200.8 14:03:02 INFO - 2015-12-10 14:03:02,902 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:03:02 INFO - 2015-12-10 14:03:02,902 DEBUG : BROWSER_OUTPUT: 14:03:03 INFO - 2015-12-10 14:03:03,603 INFO : Browser exited with error code: 0 14:03:03 INFO - 2015-12-10 14:03:03,619 INFO : Completed test dromaeo_css (00:18:34) 14:03:03 INFO - 2015-12-10 14:03:03,619 INFO : Starting test kraken 14:03:03 INFO - 2015-12-10 14:03:03,619 DEBUG : operating with platform_type : linux_ 14:03:03 INFO - 2015-12-10 14:03:03,619 INFO : Initialising browser for kraken test... 14:03:03 INFO - 2015-12-10 14:03:03,626 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD6KAcb/profile http://localhost:48437/getInfo.html 14:03:07 INFO - 2015-12-10 14:03:07,908 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:03:07 INFO - 2015-12-10 14:03:07,908 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:03:07 INFO - 2015-12-10 14:03:07,908 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:03:07 INFO - 2015-12-10 14:03:07,909 DEBUG : BROWSER_OUTPUT: __metrics 14:03:08 INFO - 2015-12-10 14:03:08,030 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] 14:03:08 INFO - 2015-12-10 14:03:08,903 INFO : Browser initialized. 14:03:08 INFO - 2015-12-10 14:03:08,903 INFO : Running cycle 1/1 for kraken test... 14:03:08 INFO - 2015-12-10 14:03:08,904 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD6KAcb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:20 INFO - 2015-12-10 14:03:20,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 142893056 14:03:20 INFO - 2015-12-10 14:03:20,917 DEBUG : BROWSER_OUTPUT: 14:03:23 INFO - 2015-12-10 14:03:23,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48437/tests/kraken/driver.html?testName=audio-beat-detection) 14:03:24 INFO - 2015-12-10 14:03:24,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 142528512 14:03:24 INFO - 2015-12-10 14:03:24,155 DEBUG : BROWSER_OUTPUT: 14:03:26 INFO - 2015-12-10 14:03:26,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48437/tests/kraken/driver.html?testName=audio-dft) 14:03:27 INFO - 2015-12-10 14:03:27,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 143011840 14:03:27 INFO - 2015-12-10 14:03:27,507 DEBUG : BROWSER_OUTPUT: 14:03:30 INFO - 2015-12-10 14:03:30,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48437/tests/kraken/driver.html?testName=audio-fft) 14:03:31 INFO - 2015-12-10 14:03:31,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 138829824 14:03:31 INFO - 2015-12-10 14:03:31,009 DEBUG : BROWSER_OUTPUT: 14:03:33 INFO - 2015-12-10 14:03:33,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48437/tests/kraken/driver.html?testName=audio-oscillator) 14:03:33 INFO - 2015-12-10 14:03:33,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 138964992 14:03:33 INFO - 2015-12-10 14:03:33,628 DEBUG : BROWSER_OUTPUT: 14:03:35 INFO - 2015-12-10 14:03:35,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:36 INFO - 2015-12-10 14:03:36,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 140161024 14:03:36 INFO - 2015-12-10 14:03:36,463 DEBUG : BROWSER_OUTPUT: 14:03:39 INFO - 2015-12-10 14:03:39,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48437/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:40 INFO - 2015-12-10 14:03:40,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 139153408 14:03:40 INFO - 2015-12-10 14:03:40,170 DEBUG : BROWSER_OUTPUT: 14:03:43 INFO - 2015-12-10 14:03:43,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48437/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:44 INFO - 2015-12-10 14:03:44,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 137551872 14:03:44 INFO - 2015-12-10 14:03:44,226 DEBUG : BROWSER_OUTPUT: 14:03:47 INFO - 2015-12-10 14:03:47,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48437/tests/kraken/driver.html?testName=json-parse-financial) 14:03:47 INFO - 2015-12-10 14:03:47,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 137457664 14:03:47 INFO - 2015-12-10 14:03:47,799 DEBUG : BROWSER_OUTPUT: 14:03:49 INFO - 2015-12-10 14:03:49,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:50 INFO - 2015-12-10 14:03:50,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 140267520 14:03:50 INFO - 2015-12-10 14:03:50,162 DEBUG : BROWSER_OUTPUT: 14:03:52 INFO - 2015-12-10 14:03:52,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:52 INFO - 2015-12-10 14:03:52,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 140242944 14:03:52 INFO - 2015-12-10 14:03:52,671 DEBUG : BROWSER_OUTPUT: 14:03:54 INFO - 2015-12-10 14:03:54,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:55 INFO - 2015-12-10 14:03:55,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 140406784 14:03:55 INFO - 2015-12-10 14:03:55,510 DEBUG : BROWSER_OUTPUT: 14:03:58 INFO - 2015-12-10 14:03:58,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:58 INFO - 2015-12-10 14:03:58,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 138764288 14:03:58 INFO - 2015-12-10 14:03:58,671 DEBUG : BROWSER_OUTPUT: 14:04:01 INFO - 2015-12-10 14:04:01,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:01 INFO - 2015-12-10 14:04:01,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 14:04:01 INFO - 2015-12-10 14:04:01,852 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48437/tests/kraken/driver.html?testName=ai-astar) 14:04:03 INFO - 2015-12-10 14:04:03,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 140574720 14:04:03 INFO - 2015-12-10 14:04:03,876 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,878 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:03 INFO - 2015-12-10 14:04:03,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:03 INFO - 2015-12-10 14:04:03,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:03 INFO - 2015-12-10 14:04:03,879 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:03 INFO - 2015-12-10 14:04:03,880 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;112;115;113;125;113;114;113;113 14:04:03 INFO - 2015-12-10 14:04:03,880 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;134;164;172;133;153;159;136;169;130 14:04:03 INFO - 2015-12-10 14:04:03,880 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;164;162;163;171;166;163;165;163 14:04:03 INFO - 2015-12-10 14:04:03,880 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;72;72;73;128;73;77;73;79 14:04:03 INFO - 2015-12-10 14:04:03,880 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;128;95;95;94;127;94;94;134 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;110;110;109;110;110;111;110;110 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;147;148;147;148;147 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;99;96;96;96;95;95;95;95 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;72;72;74;71;75;73;72;73 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;68;68;67;70 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;86;86;94;87;95;83;88;95 14:04:03 INFO - 2015-12-10 14:04:03,881 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;119;120;118;121;130;124;127;122;130 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;146;148;148;149;136;147;148;147;138 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;69;69;69;70;71;68;71;70 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,805 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:04:03 INFO - 2015-12-10 14:04:03,882 DEBUG : BROWSER_OUTPUT: __startTimestamp1449785043877__endTimestamp 14:04:03 INFO - 2015-12-10 14:04:03,883 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,890 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:03 INFO - 2015-12-10 14:04:03,890 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:04:03 INFO - 2015-12-10 14:04:03,891 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,891 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.16 (3.7%) stddev-sans-first:4.40 14:04:03 INFO - 2015-12-10 14:04:03,891 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 112.0 115.0 113.0 125.0 113.0 114.0 113.0 113.0 14:04:03 INFO - 2015-12-10 14:04:03,891 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,892 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:158.00 stddev:16.04 (10.2%) stddev-sans-first:16.85 14:04:03 INFO - 2015-12-10 14:04:03,892 DEBUG : BROWSER_OUTPUT: Values: 157.0 134.0 164.0 172.0 133.0 153.0 159.0 136.0 169.0 130.0 14:04:03 INFO - 2015-12-10 14:04:03,892 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,892 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.70 14:04:03 INFO - 2015-12-10 14:04:03,892 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 162.0 163.0 171.0 166.0 163.0 165.0 163.0 14:04:03 INFO - 2015-12-10 14:04:03,892 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:17.36 (23.8%) stddev-sans-first:18.16 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 72.0 73.0 128.0 73.0 77.0 73.0 79.0 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.00 stddev:17.19 (18.3%) stddev-sans-first:17.77 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 128.0 95.0 95.0 94.0 127.0 94.0 94.0 134.0 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 14:04:03 INFO - 2015-12-10 14:04:03,893 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 147.0 148.0 147.0 148.0 147.0 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.27 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 99.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.90 Median:73.00 stddev:1.20 (1.6%) stddev-sans-first:1.20 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 72.0 74.0 71.0 75.0 73.0 72.0 73.0 14:04:03 INFO - 2015-12-10 14:04:03,894 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 67.0 70.0 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:87.50 stddev:4.71 (5.4%) stddev-sans-first:4.74 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 86.0 86.0 94.0 87.0 95.0 83.0 88.0 95.0 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:125.50 stddev:4.56 (3.6%) stddev-sans-first:4.59 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: Values: 128.0 119.0 120.0 118.0 121.0 130.0 124.0 127.0 122.0 130.0 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,895 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:147.50 stddev:4.53 (3.1%) stddev-sans-first:4.76 14:04:03 INFO - 2015-12-10 14:04:03,896 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 148.0 148.0 149.0 136.0 147.0 148.0 147.0 138.0 14:04:03 INFO - 2015-12-10 14:04:03,896 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-10 14:04:03,896 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.01 14:04:03 INFO - 2015-12-10 14:04:03,896 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 69.0 69.0 69.0 70.0 71.0 68.0 71.0 70.0 14:04:03 INFO - 2015-12-10 14:04:03,896 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:03 INFO - 2015-12-10 14:04:03,896 DEBUG : BROWSER_OUTPUT: 14:04:04 INFO - 2015-12-10 14:04:04,795 INFO : Browser exited with error code: 0 14:04:04 INFO - 2015-12-10 14:04:04,849 INFO : Completed test kraken (00:01:01) 14:04:04 INFO - 2015-12-10 14:04:04,849 INFO : Starting test v8_7 14:04:04 INFO - 2015-12-10 14:04:04,849 DEBUG : operating with platform_type : linux_ 14:04:04 INFO - 2015-12-10 14:04:04,849 INFO : Initialising browser for v8_7 test... 14:04:04 INFO - 2015-12-10 14:04:04,855 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQUEMCa/profile http://localhost:48437/getInfo.html 14:04:09 INFO - 2015-12-10 14:04:09,023 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:04:09 INFO - 2015-12-10 14:04:09,023 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:04:09 INFO - 2015-12-10 14:04:09,023 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:04:09 INFO - 2015-12-10 14:04:09,024 DEBUG : BROWSER_OUTPUT: __metrics 14:04:09 INFO - 2015-12-10 14:04:09,160 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] 14:04:10 INFO - 2015-12-10 14:04:10,047 INFO : Browser initialized. 14:04:10 INFO - 2015-12-10 14:04:10,047 INFO : Running cycle 1/1 for v8_7 test... 14:04:10 INFO - 2015-12-10 14:04:10,048 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQUEMCa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:04:22 INFO - 2015-12-10 14:04:22,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 143200256 14:04:22 INFO - 2015-12-10 14:04:22,035 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48437/tests/v8_7/run.html (next: http://localhost:48437/tests/v8_7/run.html) 14:04:43 INFO - 2015-12-10 14:04:43,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 138018816 14:04:43 INFO - 2015-12-10 14:04:43,800 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:43 INFO - 2015-12-10 14:04:43,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |0;Richards;166.14055490945339 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.46781036709095 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1096.3855421686746 14:04:43 INFO - 2015-12-10 14:04:43,801 DEBUG : BROWSER_OUTPUT: |5;Earley;726.7441860465116 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: |8;Splay;608.6427267194157 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: __startTimestamp1449785083794__endTimestamp 14:04:43 INFO - 2015-12-10 14:04:43,802 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: Values: 166.1 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,803 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.47 Median:184.47 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: Values: 184.5 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: Values: 280.9 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,804 DEBUG : BROWSER_OUTPUT: Values: 5202.1 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1096.39 Median:1096.39 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: Values: 1096.4 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: Values: 726.7 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,805 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: Values: 12268.3 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: Values: 26000.0 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.64 Median:608.64 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,806 DEBUG : BROWSER_OUTPUT: Values: 608.6 14:04:43 INFO - 2015-12-10 14:04:43,807 DEBUG : BROWSER_OUTPUT: 14:04:43 INFO - 2015-12-10 14:04:43,807 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:04:43 INFO - 2015-12-10 14:04:43,807 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:04:43 INFO - 2015-12-10 14:04:43,807 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:43 INFO - 2015-12-10 14:04:43,807 DEBUG : BROWSER_OUTPUT: 14:04:44 INFO - 2015-12-10 14:04:44,699 INFO : Browser exited with error code: 0 14:04:44 INFO - 2015-12-10 14:04:44,713 INFO : Completed test v8_7 (00:00:39) 14:04:44 INFO - 2015-12-10 14:04:44,785 INFO : Completed test suite (00:20:15) 14:04:44 INFO - 2015-12-10 14:04:44,785 DEBUG : Working with test: dromaeo_css 14:04:44 INFO - 2015-12-10 14:04:44,785 DEBUG : Generating results file: dromaeo_css 14:04:44 INFO - 2015-12-10 14:04:44,786 DEBUG : Working with test: kraken 14:04:44 INFO - 2015-12-10 14:04:44,787 DEBUG : Generating results file: kraken 14:04:44 INFO - 2015-12-10 14:04:44,787 INFO : javascript benchmark 14:04:44 INFO - 2015-12-10 14:04:44,787 DEBUG : Working with test: v8_7 14:04:44 INFO - 2015-12-10 14:04:44,787 DEBUG : Generating results file: v8_7 14:04:44 INFO - 2015-12-10 14:04:44,787 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:44 INFO - 2015-12-10 14:04:44,838 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 14:04:44 INFO - 2015-12-10 14:04:44,838 DEBUG : process_Request line: dromaeo_css 6364.25 graph.html#tests=[[72,132,43]] 14:04:44 INFO - 2015-12-10 14:04:44,838 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:44 INFO - 2015-12-10 14:04:44,864 DEBUG : process_Request line: kraken 1535.00 graph.html#tests=[[232,132,43]] 14:04:44 INFO - 2015-12-10 14:04:44,865 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:04:44 INFO - 2015-12-10 14:04:44,891 DEBUG : process_Request line: v8_7 21231.78 graph.html#tests=[[230,132,43]] 14:04:44 INFO - 2015-12-10 14:04:44,893 INFO : javascript benchmark 14:04:44 INFO - 2015-12-10 14:04:44,896 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2642.379040925382, 2713.986430067852, 2729.945401091978, 2737.7262273772612, 2742.547479665856, 4520.050789334236, 4727.361806156172, 4743.193657078301, 4745.691530050544, 4761.095391875541, 4599.655025873056, 4647.395838540985, 4647.488776234612, 4691.038337140878, 4692.601128904047, 4314.288142456491, 4326.826926922935, 4346.391505189276, 4401.317795741666, 4411.4706235251815, 4193.287141186006, 4300.956990430087, 4308.655307575402, 4375.540568240337, 4431.26884064129, 4229.809658565372, 4277.871663850089, 4279.379489973952, 4292.828286868522, 4299.097189590189, 4304.935425968613, 4353.303471444554, 4375.8249670013165, 4396.736195828228, 4412.0955204183065, 4145.17096580685, 4237.427947227146, 4345.543717909605, 4380.408644832939, 4406.228909940747, 4583.9541604583865, 4636.188666983265, 4684.250519916831, 4684.344191813149, 4686.671932964694, 5058.861756104847, 5072.061668591323, 5107.3105130807235, 5110.8245103626, 5115.7442127893455, 4891.828785992473, 4990.950090499085, 5030.723310217936, 5112.156494178494, 5174.741262936838, 4654.115718013567, 4670.789814458358, 4679.485256621769, 4720.291956206562, 4728.3143944127905, 5142.742862856842, 5143.8456846294675, 5144.485551444825, 5151.793928242828, 5153.3300670913295, 4764.285357196448, 4869.610431165498, 4879.2925025871045, 4959.553640172402, 5012.974935125301, 5109.284700141983, 5125.0, 5135.589152867761, 5145.434002259748, 5182.844514664566, 5074.873128171826, 5076.873078173076, 5077.339945807022, 5099.64302498829, 5101.132807422747, 4758.547937945958, 4868.78090485929, 4918.0901533216465, 4966.453690094087, 5035.446100928895, 4114.156597897424, 4158.979205104016, 4159.251334759711, 4162.105147393325, 4169.249535083653, 3601.991442396133, 3625.2749450109554, 3649.927001459956, 3667.3765459871884, 3671.9816400918357, 4199.475065616798, 4293.592108749664, 4306.763128027988, 4307.483102027777, 4338.58783415575, 4998.325226094504, 5034.924476132861, 5038.546530812245, 5054.342935418372, 5060.696358218519, 4161.687873409506, 4243.151369726005, 4349.847755328548, 4362.672799540047, 4371.169477799208, 4368.672349573794, 4443.022535042285, 4447.444069491314, 4477.865664030084, 4484.955150448519, 4732.337472753818, 4798.520147985174, 4811.422629284508, 4812.639052071038, 4859.708417494961, 4842.806287748451, 4902.950970490392, 4971.875703107451, 5078.035173317058, 5093.388793344822, 4738.147133515862, 4786.1863483208635, 4787.138315103315, 4816.590589799906, 4868.0, 5008.599312055099, 5020.221865610836, 5021.221710634857, 5026.974865125651, 5034.352166714666, 4873.390826146731, 4994.225894986283, 5021.096202683552, 5117.8464646060675, 5128.076946149728, 4851.490593487633, 4880.487548807466, 4882.829100981448, 4897.632677549269, 4939.16034274167, 4889.951100489092, 4903.460619331942, 4906.288588154769, 4921.532454416824, 4962.404511458648, 4589.58693717567, 4720.221163507983, 4730.645201609824, 4810.783514741775, 4839.95160048395, 4885.609151267961, 4893.90212195747, 4930.260460930889, 4935.901281974268, 4993.850184494471, 4638.953610463852, 4833.10587541306, 4846.757662116951, 4857.611391088775, 4877.170880950176], "unit": "ms", "name": "dojo.html", "value": 4609.6844699012945}, {"lowerIsBetter": false, "replicates": [554.758679974211, 564.1847530318688, 585.0084107437895, 588.1883001457988, 601.3745704467354, 36515.0, 37275.627243727555, 37280.25439491209, 37342.81328593357, 37371.43942840853, 40709.796451017704, 40830.59169408312, 40876.0, 41150.382744258786, 41218.0, 7896.328812050968, 8052.235037671441, 8053.154418786031, 8063.435559510836, 8074.798130046737, 7754.883676744853, 7848.097468791077, 7849.64676589552, 7850.097238817523, 7855.528668279893, 7944.880826787603, 7999.320057795095, 8016.599170041503, 8054.919450805475, 8059.959700201491, 7733.342665873408, 7749.7675069748, 7800.297973182441, 7814.6483408246195, 7818.8827167592535, 7862.488938219055, 7915.841683166304, 7958.283754462068, 7977.680892764282, 8020.0, 37259.81370093132, 37798.43302350467, 37929.0, 37993.81003094994, 38001.429978550346, 2809.7330753578376, 2878.6113874626867, 3079.5534647476215, 3090.5209692497474, 3393.9490907636405, 28041.439171216665, 28230.717692823015, 28399.432011359862, 28447.431051378855, 28527.714722852714, 3388.4070287699556, 3414.5219669246326, 3424.5890493140732, 3533.134382076382, 3535.169235229719, 219682.0, 219849.0, 220532.0, 220752.0, 221342.0, 50375.74812125916, 51469.227961580604, 53157.46842531602, 53711.19433208505, 54471.182932256044, 49993.75003125034, 50048.0, 50051.74353205849, 50193.0, 50254.24618630723, 13042.54351097707, 13189.340532973312, 13290.73418531624, 13307.467701292033, 13390.464381424828, 10118.494075296207, 10212.285140040274, 10220.540075696612, 10241.743956401, 10271.897281027244, 17679.292828286983, 18520.629587408177, 18903.621927561373, 18944.0, 18996.810031899506, 7271.200167981518, 7385.150707668687, 7432.85134297311, 7497.2877576630135, 7497.475176737576, 815.9836803263902, 840.7603832907714, 853.6926706385697, 966.2028826218398, 994.8457989011715, 25985.480290394087, 26877.193684189504, 27073.729262707122, 27093.32266693309, 27198.45603087927, 854.372036553133, 913.3828496947991, 1009.5053423822275, 1062.7449412141184, 1096.166913145999, 12650.304233267074, 12818.35350631084, 12824.294663793395, 12993.610191694264, 13028.153170043917, 271450.0, 274722.0, 276554.0, 276955.0, 278166.0, 44109.11781764411, 44113.0, 44213.77893110514, 44496.99999999935, 44618.77690611591, 1185.0387608507933, 1186.0985650905375, 1193.6717402714323, 1197.2935967778878, 1199.7900367435664, 24773.50452990894, 24999.0, 25180.370490737878, 25432.0, 25521.0, 39440.40839387469, 39503.0, 39829.0, 39843.203135936536, 39845.40231896582, 253213.0, 254068.0, 256449.0, 256828.0, 257240.0, 28072.85963570169, 28810.567841482814, 29135.85432072826, 29283.267918302212, 29389.26526836846, 33821.49267760936, 33829.492557612146, 34796.65203347934, 34961.65038349685, 36306.455403168446, 31652.841735792095, 31985.68014319827, 32188.19529511687, 32215.677843221267, 33162.17094572655, 31732.841335793175, 32478.83760581182, 32691.0, 32801.34397312088, 33039.66960330366, 32101.83949080333, 32270.677293226767, 32440.35119297648, 32526.83736581302, 32527.0, 27923.581146282417, 28654.283642909093, 29389.26526836846, 29436.893975520652, 29458.0, 23081.30300578365, 23347.299581012598, 23687.881560592086, 23866.40333991664, 23903.76096239015], "unit": "ms", "name": "ext.html", "value": 16629.573640209004}, {"lowerIsBetter": false, "replicates": [332.62911853283595, 348.82035751587927, 350.1054804973292, 350.4253025038936, 352.4466587457689, 15337.693246135084, 15726.370945162194, 16278.186090695448, 16742.41401550946, 16839.74740378895, 14983.550493485185, 15427.84572154278, 15839.445619403323, 16123.355065797383, 16153.111578863158, 4614.238650622643, 4712.976435117819, 4721.669483136182, 4725.527447255281, 4730.881727956794, 4680.5787479126875, 4698.412698412699, 4717.033008233304, 4724.811007559693, 4735.81056757731, 4719.032598317354, 5033.798648054073, 6198.690065496729, 6397.5521713480075, 6415.422611964922, 6322.178116844827, 6353.936460635381, 6392.105105285264, 6707.5975441473665, 6726.159230096238, 6471.0, 6497.642629655367, 6501.154849869534, 6517.185351831021, 6519.739210431577, 19399.0, 19752.0, 20102.69845952312, 20252.594948100956, 20330.69503957427, 1919.577692907558, 1932.4975506368305, 1933.4006457997925, 2003.4690806936173, 2090.571432856276, 13021.153625014344, 13686.0, 13774.793378099337, 13973.23147226902, 14332.57002289933, 1808.2134271591767, 1888.9055547222583, 1909.493984094216, 1944.912478938437, 1962.0189905047475, 51209.743951280376, 53310.0, 61017.6949115256, 61038.38961610371, 61067.38932610661, 15142.848571514143, 15593.688126237412, 15603.0, 15699.843001570067, 15726.606834828992, 23238.65142022871, 23287.18494852672, 23343.299701008997, 23589.882050589636, 23628.409289767893, 8181.509449039205, 8217.79455513617, 8323.375746818892, 8559.828803423896, 8714.215720585178, 6687.0, 6732.225794033749, 6752.153377323609, 6753.527253092335, 7306.5981371024045, 7675.654595543214, 7712.2287771223555, 7794.337481314038, 7797.0, 7867.449278550446, 1786.8749187557007, 1833.0, 3172.9682703173135, 3199.120241933487, 3248.1256978784704, 398.6631296554407, 401.26167851154014, 406.059971166748, 417.8537511870821, 771.864923638361, 9474.905250947402, 9744.171745401578, 9928.453935033498, 10014.29899907014, 10131.138853197413, 805.6334367862609, 834.8121672623732, 860.0, 898.8606765951288, 915.1260546178383, 8512.106228845882, 8662.22040016389, 9045.638174472948, 9476.194523465445, 9513.334066615409, 524783.0, 524921.0, 525528.0, 540013.0, 551082.0, 73828.63085684537, 74401.0, 75552.24447755562, 76867.61566192133, 77582.6120869392, 1048.8007278617038, 1052.8420736889375, 1066.893310668927, 1082.2910993299402, 1082.350589646206, 14542.0, 14917.776233356291, 15022.248887555359, 15077.472288469851, 15383.692326153638, 34104.48843267403, 34706.0, 35723.0, 36073.81963090168, 37021.0, 47810.521894780606, 48986.0, 49217.50782492129, 50677.23984140315, 51187.0, 8547.487150770974, 9213.447193168431, 9246.306527010367, 9289.34974551775, 9401.670941517013, 11000.449977500934, 11014.118870490182, 11093.33439993603, 11182.0, 12574.182678125893, 12603.432845522157, 13673.794893076412, 13729.588112356645, 13890.930545347208, 13949.3722782473, 12378.48185412336, 12662.113652044269, 12832.29422381778, 12947.611571652866, 13775.517856874962, 14261.572152835432, 14281.928590356982, 14403.855961440251, 14617.853821462075, 14718.63203419923, 9084.772880678036, 9142.63429462814, 9185.173334399937, 9207.76980575491, 9208.12522810332, 9877.901220987698, 9946.154576860758, 11016.834747478633, 14168.291585420482, 14374.353154107881], "unit": "ms", "name": "jquery.html", "value": 8893.81168241357}, {"lowerIsBetter": false, "replicates": [1468.5447511271514, 1653.9917300413497, 1705.8635309175268, 1707.3938751743135, 1712.9486115416535, 6023.518118550516, 6132.938670613293, 7013.473989450792, 7153.14162300524, 7161.498695091339, 6547.57440766351, 6810.897836532456, 6852.965735171317, 6870.519063665545, 6891.276415976326, 2081.6669332906736, 2095.2876022152464, 2112.9788702113015, 2113.3765539165984, 2114.8202402795782, 2059.3615979046544, 2062.484378905274, 2091.1948899673584, 2139.3474990128007, 2146.6672665736837, 2014.869033512817, 2071.9482012949647, 2073.917043318273, 2075.2632815350557, 2082.0630716177707, 2072.6372884745183, 2077.200277893007, 2087.65553683642, 2087.9164833406644, 2098.926537571193, 2029.9797002030086, 2049.2008116834445, 2059.1454546363243, 2068.307117115753, 2091.1217288738767, 6843.863122737567, 6921.134858142732, 6930.410915072225, 6933.68798404073, 6997.895031574531, 4011.0774521859844, 4114.321137012389, 4115.464989551339, 4122.9381559276635, 4150.128473020669, 2568.7816535594498, 2591.663083799113, 2610.5953577195564, 2661.5076210901047, 2667.5731882898644, 831.1522247307712, 840.6679361652174, 844.8014716541608, 854.6325080215505, 878.8769572259889, 9279.72160835176, 9329.30030247734, 9331.72004839856, 9339.299552533586, 9344.486053267068, 3802.6957843372466, 3812.0, 3872.302985462644, 3925.862594809225, 3930.901727456779, 8025.518468891885, 8025.839483210303, 8084.717034903751, 8101.0, 8107.635156417975, 4136.751794892316, 4139.8965025873995, 4164.68812324117, 4171.228322760299, 4205.600467955539, 3264.265540253424, 3324.86700531976, 3760.9435858462143, 3764.4729737836724, 3771.698264138862, 3359.277755282577, 3397.779144355609, 3423.8801641942414, 3428.194374322032, 3448.396530607184, 1095.835624656308, 1112.8831472695413, 1119.4514687802919, 1122.6014764758393, 1132.7904337697553, 1168.9240199387013, 1183.7336599265097, 1184.63563479718, 1201.1711918776016, 1208.4199584199635, 6491.67541622917, 6529.673516324165, 6682.3317668232785, 6707.396334329934, 6720.764773232913, 442.5817602365798, 443.26196882191437, 444.3778709806297, 447.5703324808155, 457.75510102095217, 5165.715885626327, 5217.165253559412, 5218.504242096995, 5221.7128057956415, 5221.869453263623, 8099.757007289791, 8187.795305117301, 8343.749687509384, 8469.3647976402, 8527.65889364431, 8393.076761556224, 8414.242718155396, 8451.577421128919, 8488.533130677748, 8506.532140732319, 6609.966950165219, 6616.139901812733, 6698.933010669928, 6714.127163468718, 6737.056812046416, 6463.254921171351, 6466.708998095003, 6467.256265529524, 6483.254425740912, 6487.448566871869, 7429.405647548291, 7473.775786726407, 7698.730544430918, 7721.227877212234, 7740.0, 7174.246704095995, 7338.596377199092, 7356.668949897375, 7785.727499537489, 7823.2959033684965, 5249.658772179796, 5365.678059316453, 6215.254169499689, 6313.179286692701, 6327.430531252209, 6229.3770622937345, 6510.7721229756735, 6555.246146693191, 6586.37429444202, 6594.802155935329, 6182.752689892354, 6365.045243213555, 6429.067785171217, 6443.9355606445215, 6538.705758240986, 6138.539609529393, 6251.249850018027, 6261.373862613702, 6261.874762504815, 6289.779857704958, 6240.438360547572, 6259.0, 6321.683915804099, 6328.430441260309, 6329.841753956188, 5693.943060569507, 5699.116636921284, 5722.685252311163, 5723.599348045597, 5737.454941780524, 5817.592768506164, 5823.18475413451, 5999.88000239984, 6000.8799824004145, 6025.337212906665], "unit": "ms", "name": "mootools.html", "value": 3957.012106077642}, {"lowerIsBetter": false, "replicates": [307.18442535069397, 309.4553585689187, 310.8274907426379, 313.6534129786585, 317.13738630923876, 5485.835424937253, 5624.493795558399, 5627.071533197018, 5628.521575666068, 5649.604527683064, 5499.4225606311265, 5530.640508366953, 5532.75102620382, 5537.031019571569, 5557.472040156189, 4150.315197992328, 4221.598948099926, 4246.872593822182, 4257.531671516131, 4263.5523270056665, 4252.425922500469, 4261.105167914741, 4262.254105531535, 4269.743815371072, 4278.294081476568, 4214.934682005825, 4218.093109981353, 4223.324268117102, 4230.344296634012, 4234.491860976687, 4223.640990515794, 4225.176090662322, 4226.218149642326, 4229.217594744982, 4236.046889449849, 3609.693176080036, 3692.7045836333027, 3695.4087346024776, 3695.5565332160045, 3696.5194524711615, 5232.084385232569, 5366.087765079946, 5370.22131790892, 5388.272583201257, 5397.4062853086125, 4799.880002999953, 4818.301346304801, 4826.686265392738, 4829.758512074382, 4850.175470170079, 5824.825255242349, 5831.475167234969, 5851.707414629294, 5852.092925596539, 5857.502112320458, 3882.592327805596, 3959.604039596017, 3965.722399432041, 3969.7816620085882, 4000.659943904772, 6063.54523410746, 6132.478739307119, 6135.723892424807, 6140.201773769426, 6146.569740118193, 4143.316352801754, 4150.6471949884, 4155.148194620096, 4157.438745769343, 4162.001119731242, 4169.145325208325, 4196.153692375345, 4210.526315789449, 4228.323468245066, 4230.492340919048, 4749.1926372516755, 4801.807927682923, 4836.3712717347225, 4850.0, 4855.271709243571, 5857.853553661193, 5859.150423188699, 5859.589828711949, 5866.530677545871, 5869.325027621878, 1464.2239613005124, 1469.067142364606, 1472.10201776916, 1472.2932992163821, 1476.6677497563178, 994.4331730913455, 1000.884898236712, 1004.467632154959, 1009.9545520451597, 1015.5988384588194, 5057.873553161126, 5074.3657042869645, 5077.416097148801, 5080.085584594734, 5088.338515992971, 6060.000099983541, 6063.242094738158, 6065.6663883486835, 6070.271567411939, 6079.08813677943, 5078.847634570969, 5078.923816142761, 5083.694978301313, 5088.262201980692, 5088.898222035538, 3204.2630195055267, 3253.788503747249, 3279.934401312008, 3289.851956661956, 3293.5883014623173, 5629.831105066773, 5699.259096317535, 5700.800471983461, 5706.229658995982, 5771.105478650816, 6287.49700023997, 6311.873762524816, 6313.905291420632, 6314.684265786692, 6316.30520642729, 5712.457316554921, 5745.339285982082, 5746.626469279484, 5749.355296563627, 5757.827265182052, 5928.614640048383, 6075.422834830684, 6103.328633850362, 6106.908396374147, 6107.144999700135, 6004.729787159501, 6010.789622363196, 6014.879702406015, 6027.156198132177, 6029.306629737636, 5724.284464441945, 5768.451997060272, 5769.653820770767, 5775.624584402, 5786.1899334094105, 4143.109231515239, 4185.497740271187, 4190.287651099259, 4193.475815523059, 4195.286801243735, 5952.226210592596, 6104.145419641342, 6108.267007958895, 6109.602875813058, 6113.266408031065, 5861.0915308127305, 5863.882722345444, 5865.208196893535, 5868.911966320594, 5872.119182122716, 5860.853478663067, 5864.765409383747, 5868.471837534642, 5868.735906884286, 5872.618279811799, 5605.439456054525, 5725.971370143123, 5731.942680573141, 5745.798897038583, 5770.365259821332, 5896.941030589639, 5901.29184497863, 5921.940780592139, 5930.229070220844, 5939.851503712269, 5699.914501282401, 5758.337791153904, 5765.798197063083, 5769.423057694365, 5771.567132465166], "unit": "ms", "name": "prototype.html", "value": 4371.6742658330595}, {"lowerIsBetter": false, "replicates": [730.8720973829581, 735.649118266297, 790.4348390900504, 798.5647821937043, 817.9836403271931, 11273.210875238736, 11294.152938529613, 12591.370431478435, 12662.683432914182, 12736.872631273707, 10955.123590112791, 11039.0, 11076.778464430707, 11083.390413527253, 11096.278741881772, 805.8912046873655, 811.5293129984594, 827.8592639251342, 827.8882350882614, 828.6229765456703, 826.017039722731, 827.2761333832897, 829.4152622401193, 830.3564737328559, 831.4470876866876, 854.7008547008528, 858.8282343531288, 859.2824991132412, 861.3109512390095, 862.3230763850379, 846.3144852669358, 854.4403415762654, 855.2388374346774, 855.2473823035689, 861.8017855893148, 631.564220687724, 635.3678090300181, 635.4789072960175, 636.8758092171983, 638.6870433487558, 11379.0, 11532.538698452052, 11535.192536522447, 11546.942265288704, 11547.942260288728, 10560.894391056068, 11210.551577936872, 11218.663440096729, 11424.600138995178, 11840.348780817052, 8926.642934282621, 8999.145081217273, 9157.725268241897, 9193.678221262291, 9397.201237894787, 3132.4361614909308, 3146.685331466858, 3161.920951976196, 3185.267388500658, 3186.9362612747846, 41822.163556728694, 41944.58055419437, 42040.78979605113, 42198.15603687909, 42268.57731422708, 8741.34439916996, 8810.533318769953, 8834.779130521789, 8969.686060987835, 9334.71995840126, 15789.684206316038, 15895.046297221972, 15909.761353579706, 15920.840791592167, 16432.589185270463, 6455.386738259858, 6494.285628580852, 6571.769988050395, 6628.270890202074, 6639.402453779183, 3523.8766643167364, 3539.964600354015, 3549.4498352755363, 3580.1765593913547, 3592.856285748541, 2609.830361026527, 2630.500204961051, 2639.722829102955, 2655.243255672124, 2655.681318241823, 476.3830839063421, 482.1754799293248, 483.58653351384766, 488.75562218890553, 492.89402778402814, 381.7861997281531, 388.32431569069615, 403.9171969746195, 419.4986990546268, 432.4443090628527, 6742.730290788313, 7194.820129496805, 7248.130224373003, 7356.154042285206, 7396.741114061089, 391.04779861038463, 392.8766307852583, 487.90485855258595, 507.90603738307794, 510.7956817273046, 3238.6923242291946, 3472.6527347265073, 3510.1575621851084, 3526.2947410518, 3533.6643018913164, 46601.0, 53115.46884531105, 53221.733891330296, 53388.0, 53404.19893701598, 43678.563214368085, 44263.114737705066, 44686.553134468886, 45125.323120153225, 45149.0, 39612.80193599014, 41335.93320334031, 41393.37909931293, 41789.79105104455, 41893.16213675709, 7163.283671633004, 7562.886556701544, 7581.166071731995, 7720.150783413932, 7912.960435197787, 32565.34869302648, 32624.83687581547, 33059.33881322312, 33088.66911330856, 33349.83325083359, 39348.0, 40463.0, 40723.796381017906, 40979.180416392104, 41293.58706412897, 9257.120573545502, 9388.06119388083, 9504.572294246636, 9581.185599223865, 10135.341202821794, 11214.383208923588, 11245.0, 11404.144689148514, 11515.424228788695, 11527.654170374903, 10742.24804263694, 10784.514696838503, 11043.668689939315, 11242.94378528102, 11398.487068081791, 10216.693499195037, 10365.637202698172, 10430.94784526103, 10434.791304173723, 10737.355758654505, 10097.293189476666, 10274.486275686335, 10430.843537346795, 10475.685729428129, 10608.257421980386, 8825.470471771714, 8926.73219803407, 9206.907930920604, 9254.768630784014, 9495.857562136436, 8441.577921104043, 9104.317176211678, 9110.0, 9129.178373946377, 9200.816298018706], "unit": "ms", "name": "yui.html", "value": 5633.575658825309}], "name": "dromaeo_css", "value": 6364.255022637881}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 112.0, 115.0, 113.0, 125.0, 113.0, 114.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 164.0, 172.0, 133.0, 153.0, 159.0, 136.0, 169.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 162.0, 163.0, 171.0, 166.0, 163.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 72.0, 73.0, 128.0, 73.0, 77.0, 73.0, 79.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 128.0, 95.0, 95.0, 94.0, 127.0, 94.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 99.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 72.0, 74.0, 71.0, 75.0, 73.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 67.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 86.0, 94.0, 87.0, 95.0, 83.0, 88.0, 95.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [128.0, 119.0, 120.0, 118.0, 121.0, 130.0, 124.0, 127.0, 122.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 148.0, 149.0, 136.0, 147.0, 148.0, 147.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 69.0, 69.0, 70.0, 71.0, 68.0, 71.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1535.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [184.46781036709095], "unit": "score", "name": "DeltaBlue", "value": 358.42567799999995}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1096.3855421686746], "unit": "score", "name": "RayTrace", "value": 674.9350219780222}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [608.6427267194157], "unit": "score", "name": "Splay", "value": 133.88971299999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21231.780188718247}]} 14:04:44 INFO - RETURN: dromaeo_css: 6364.25 14:04:44 INFO - RETURN: kraken: 1535.00 14:04:44 INFO - RETURN: v8_7: 21231.78 14:04:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21231.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1535.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6364.25"}}} 14:04:44 INFO - Return code: 0 14:04:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:04:45 INFO - # TBPL SUCCESS # 14:04:45 INFO - Running post-action listener: _resource_record_post_action 14:04:45 INFO - Running post-run listener: _resource_record_post_run 14:04:46 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 513675264; Read time: 0; Write time: 434264 14:04:46 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 236130304; Read time: 0; Write time: 288412 14:04:46 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 277544960; Read time: 0; Write time: 145852 14:04:46 INFO - Running post-run listener: _upload_blobber_files 14:04:46 INFO - Blob upload gear active. 14:04:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:04:46 INFO - Copying logs to upload dir... 14:04:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.219432 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-10 14:04:44.684314) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 14:04:44.687692) ========= 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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009929 build_url: 'https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 14:04:44.738201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:04:44.738530) ========= 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=919420d7ee4ef147bef0346300000385-1449783817.41195-403611689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:04:44.788181) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 14:04:44.788506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 14:04:44.788781) ========= ========= Total master_lag: 0.21 =========