builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1449101377.71 results: success (0) buildid: 20151202152525 builduid: ee38da47bcd74e9d8cf021af7a861883 revision: 675689351241e48a85bf474ee08a6bc75787027b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.712278) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.712653) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.712938) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006383 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.739582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.739892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.782660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.782945) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.831603) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.831872) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.832277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.832564) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 16:09:38-- 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% 76.6M=0s 2015-12-02 16:09:38 (76.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.963098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:37.963393) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022909 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:38.012377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 16:09:38.012675) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 675689351241e48a85bf474ee08a6bc75787027b --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 675689351241e48a85bf474ee08a6bc75787027b --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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 16:09:38,261 truncating revision to first 12 chars 2015-12-02 16:09:38,261 Setting DEBUG logging. 2015-12-02 16:09:38,261 attempt 1/10 2015-12-02 16:09:38,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/675689351241?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 16:09:39,503 unpacking tar archive at: fx-team-675689351241/testing/mozharness/ program finished with exit code 0 elapsedTime=1.537600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 16:09:39.564957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:39.565460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:39.575967) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:39.576346) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 16:09:39.576788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-02 16:09:39.577111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:09:39 INFO - MultiFileLogger online at 20151202 16:09:39 in /builds/slave/test 16:09:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:09:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:39 INFO - {'append_to_log': False, 16:09:39 INFO - 'base_work_dir': '/builds/slave/test', 16:09:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:09:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:39 INFO - 'branch': 'Fx-Team-Non-PGO', 16:09:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:39 INFO - 'config_files': ('talos/linux_config.py',), 16:09:39 INFO - 'default_actions': ('clobber', 16:09:39 INFO - 'read-buildbot-config', 16:09:39 INFO - 'download-and-extract', 16:09:39 INFO - 'populate-webroot', 16:09:39 INFO - 'create-virtualenv', 16:09:39 INFO - 'install', 16:09:39 INFO - 'run-tests'), 16:09:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:39 INFO - 'download_minidump_stackwalk': True, 16:09:39 INFO - 'download_symbols': 'ondemand', 16:09:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:39 INFO - 'installer_path': 'installer.exe', 16:09:39 INFO - 'log_level': 'info', 16:09:39 INFO - 'log_name': 'talos', 16:09:39 INFO - 'log_to_console': True, 16:09:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:09:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:09:39 INFO - 'opt_config_files': (), 16:09:39 INFO - 'pip_index': False, 16:09:39 INFO - 'sps_profile': False, 16:09:39 INFO - 'sps_profile_interval': 0, 16:09:39 INFO - 'suite': 'dromaeojs', 16:09:39 INFO - 'system_bits': '64', 16:09:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:39 INFO - 'title': 'talos-linux64-ix-038', 16:09:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:39 INFO - 'use_talos_json': True, 16:09:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:39 INFO - 'work_dir': 'build'} 16:09:39 INFO - ##### 16:09:39 INFO - ##### Running clobber step. 16:09:39 INFO - ##### 16:09:39 INFO - Running pre-action listener: _resource_record_pre_action 16:09:39 INFO - Running main action method: clobber 16:09:39 INFO - rmtree: /builds/slave/test/build 16:09:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:40 INFO - Running post-action listener: _resource_record_post_action 16:09:40 INFO - ##### 16:09:40 INFO - ##### Running read-buildbot-config step. 16:09:40 INFO - ##### 16:09:40 INFO - Running pre-action listener: _resource_record_pre_action 16:09:40 INFO - Running main action method: read_buildbot_config 16:09:40 INFO - Using buildbot properties: 16:09:40 INFO - { 16:09:40 INFO - "properties": { 16:09:40 INFO - "buildnumber": 2168, 16:09:40 INFO - "product": "firefox", 16:09:40 INFO - "script_repo_revision": "production", 16:09:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:09:40 INFO - "repository": "", 16:09:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:09:40 INFO - "buildid": "20151202152525", 16:09:40 INFO - "slavename": "talos-linux64-ix-038", 16:09:40 INFO - "pgo_build": "False", 16:09:40 INFO - "basedir": "/builds/slave/test", 16:09:40 INFO - "project": "", 16:09:40 INFO - "platform": "ubuntu64_hw", 16:09:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:09:40 INFO - "slavebuilddir": "test", 16:09:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:09:40 INFO - "branch": "fx-team", 16:09:40 INFO - "repo_path": "integration/fx-team", 16:09:40 INFO - "stage_platform": "linux64", 16:09:40 INFO - "builduid": "ee38da47bcd74e9d8cf021af7a861883", 16:09:40 INFO - "revision": "675689351241e48a85bf474ee08a6bc75787027b" 16:09:40 INFO - }, 16:09:40 INFO - "sourcestamp": { 16:09:40 INFO - "repository": "", 16:09:40 INFO - "hasPatch": false, 16:09:40 INFO - "project": "", 16:09:40 INFO - "branch": "fx-team-linux64-talos", 16:09:40 INFO - "changes": [ 16:09:40 INFO - { 16:09:40 INFO - "category": null, 16:09:40 INFO - "files": [ 16:09:40 INFO - { 16:09:40 INFO - "url": null, 16:09:40 INFO - "name": "https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:09:40 INFO - } 16:09:40 INFO - ], 16:09:40 INFO - "repository": "", 16:09:40 INFO - "rev": "675689351241e48a85bf474ee08a6bc75787027b", 16:09:40 INFO - "who": "nalexander@mozilla.com", 16:09:40 INFO - "when": 1449101364, 16:09:40 INFO - "number": 6736088, 16:09:40 INFO - "comments": "Bug 1220892 - Part 6: Remove non-string resources. r=mcomella\n\nI'm reluctant to mass-delete strings, since that could cause our l10n\nteam some grief in the event of a rollback. And it's not obviously\neasy to get them all back smoothly. I'll delete strings separately.", 16:09:40 INFO - "project": "", 16:09:40 INFO - "at": "Wed 02 Dec 2015 16:09:24", 16:09:40 INFO - "branch": "fx-team-linux64-talos", 16:09:40 INFO - "revlink": "", 16:09:40 INFO - "properties": [ 16:09:40 INFO - [ 16:09:40 INFO - "buildid", 16:09:40 INFO - "20151202152525", 16:09:40 INFO - "Change" 16:09:40 INFO - ], 16:09:40 INFO - [ 16:09:40 INFO - "builduid", 16:09:40 INFO - "ee38da47bcd74e9d8cf021af7a861883", 16:09:40 INFO - "Change" 16:09:40 INFO - ], 16:09:40 INFO - [ 16:09:40 INFO - "pgo_build", 16:09:40 INFO - "False", 16:09:40 INFO - "Change" 16:09:40 INFO - ] 16:09:40 INFO - ], 16:09:40 INFO - "revision": "675689351241e48a85bf474ee08a6bc75787027b" 16:09:40 INFO - } 16:09:40 INFO - ], 16:09:40 INFO - "revision": "675689351241e48a85bf474ee08a6bc75787027b" 16:09:40 INFO - } 16:09:40 INFO - } 16:09:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:09:40 INFO - Running post-action listener: _resource_record_post_action 16:09:40 INFO - ##### 16:09:40 INFO - ##### Running download-and-extract step. 16:09:40 INFO - ##### 16:09:40 INFO - Running pre-action listener: _resource_record_pre_action 16:09:40 INFO - Running main action method: download_and_extract 16:09:40 INFO - mkdir: /builds/slave/test/build/tests 16:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:40 INFO - https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/test_packages.json 16:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/test_packages.json 16:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:09:41 INFO - Downloaded 1302 bytes. 16:09:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:09:41 INFO - Using the following test package requirements: 16:09:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:09:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:09:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'jsshell-linux-x86_64.zip'], 16:09:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:09:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:09:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:09:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:09:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:09:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:09:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:09:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:41 INFO - https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:09:53 INFO - Downloaded 21774978 bytes. 16:09:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:09:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:09:54 INFO - Return code: 0 16:09:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:54 INFO - https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:09:56 INFO - Downloaded 21774978 bytes. 16:09:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:09:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:09:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:09:58 INFO - Return code: 0 16:09: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')]} 16:09:58 INFO - https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:09:59 INFO - Downloaded 11132001 bytes. 16:09:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 16:09:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:09:59 INFO - Return code: 0 16:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:59 INFO - https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:10:00 INFO - Downloaded 57677169 bytes. 16:10:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:10:00 INFO - mkdir: /builds/slave/test/properties 16:10:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:00 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:00 INFO - Contents: 16:10:00 INFO - build_url:https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:10:00 INFO - Running post-action listener: _resource_record_post_action 16:10:00 INFO - Running post-action listener: set_extra_try_arguments 16:10:00 INFO - ##### 16:10:00 INFO - ##### Running populate-webroot step. 16:10:00 INFO - ##### 16:10:00 INFO - Running pre-action listener: _resource_record_pre_action 16:10:00 INFO - Running main action method: populate_webroot 16:10:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:10:00 INFO - '../fennec_ids.txt'], 16:10:00 INFO - 'tests': ['tcheck2']}, 16:10:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:00 INFO - '--tppagecycles', 16:10:00 INFO - '7'], 16:10:00 INFO - 'tests': ['tsvgm']}}, 16:10:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:10:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:10:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:10:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'tests': ['damp', 'tps']}, 16:10:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['damp', 'tps']}, 16:10:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:10:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:00 INFO - 'other': {'tests': ['a11yr', 16:10:00 INFO - 'ts_paint', 16:10:00 INFO - 'tpaint', 16:10:00 INFO - 'sessionrestore', 16:10:00 INFO - 'sessionrestore_no_auto_restore']}, 16:10:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['a11yr', 16:10:00 INFO - 'ts_paint', 16:10:00 INFO - 'tpaint', 16:10:00 INFO - 'sessionrestore', 16:10:00 INFO - 'sessionrestore_no_auto_restore']}, 16:10:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['a11yr', 16:10:00 INFO - 'ts_paint', 16:10:00 INFO - 'tpaint', 16:10:00 INFO - 'sessionrestore', 16:10:00 INFO - 'sessionrestore_no_auto_restore']}, 16:10:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['a11yr', 16:10:00 INFO - 'ts_paint', 16:10:00 INFO - 'tpaint', 16:10:00 INFO - 'sessionrestore', 16:10:00 INFO - 'sessionrestore_no_auto_restore']}, 16:10:00 INFO - 'other_l64': {'tests': ['a11yr', 16:10:00 INFO - 'ts_paint', 16:10:00 INFO - 'tpaint', 16:10:00 INFO - 'sessionrestore', 16:10:00 INFO - 'sessionrestore_no_auto_restore']}, 16:10:00 INFO - 'other_nol64': {'tests': ['a11yr', 16:10:00 INFO - 'ts_paint', 16:10:00 INFO - 'tpaint', 16:10:00 INFO - 'sessionrestore', 16:10:00 INFO - 'sessionrestore_no_auto_restore']}, 16:10:00 INFO - 'svgr': {'tests': ['tsvgx', 16:10:00 INFO - 'tsvgr_opacity', 16:10:00 INFO - 'tart', 16:10:00 INFO - 'tscrollx', 16:10:00 INFO - 'cart']}, 16:10:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['tsvgx', 16:10:00 INFO - 'tsvgr_opacity', 16:10:00 INFO - 'tart', 16:10:00 INFO - 'tscrollx', 16:10:00 INFO - 'cart']}, 16:10:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'tests': ['tp5o']}, 16:10:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'talos_options': ['--e10s'], 16:10:00 INFO - 'tests': ['tp5o']}, 16:10:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'talos_options': ['--xperf_path', 16:10:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:00 INFO - 'tests': ['tp5n']}, 16:10:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:00 INFO - 'talos_options': ['--e10s', 16:10:00 INFO - '--xperf_path', 16:10:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:00 INFO - 'tests': ['tp5n']}}, 16:10:00 INFO - 'talos.zip': {'path': '', 16:10:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:00 INFO - Running post-action listener: _resource_record_post_action 16:10:00 INFO - ##### 16:10:00 INFO - ##### Running create-virtualenv step. 16:10:00 INFO - ##### 16:10:00 INFO - Running pre-action listener: _resource_record_pre_action 16:10:00 INFO - Running main action method: create_virtualenv 16:10:00 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:10:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:01 INFO - Using real prefix '/usr' 16:10:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:03 INFO - Installing pip.................done. 16:10:03 INFO - Return code: 0 16:10:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:03 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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:10:03 INFO - Using env: {'DISPLAY': ':0', 16:10:03 INFO - 'HOME': '/home/cltbld', 16:10:03 INFO - 'LANG': 'en_US.UTF-8', 16:10:03 INFO - 'LANGUAGE': 'en_US:en', 16:10:03 INFO - 'LOGNAME': 'cltbld', 16:10:03 INFO - 'MAIL': '/var/mail/cltbld', 16:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:03 INFO - 'MOZ_NO_REMOTE': '1', 16:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:03 INFO - 'NO_EM_RESTART': '1', 16:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:03 INFO - 'PWD': '/builds/slave/test', 16:10:03 INFO - 'SHELL': '/bin/bash', 16:10:03 INFO - 'SHLVL': '1', 16:10:03 INFO - 'TERM': 'linux', 16:10:03 INFO - 'TMOUT': '86400', 16:10:03 INFO - 'USER': 'cltbld', 16:10:03 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:03 INFO - '_': '/tools/buildbot/bin/python'} 16:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:10:03 INFO - Cleaning up... 16:10:03 INFO - Return code: 0 16:10:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:03 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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:10:03 INFO - Using env: {'DISPLAY': ':0', 16:10:03 INFO - 'HOME': '/home/cltbld', 16:10:03 INFO - 'LANG': 'en_US.UTF-8', 16:10:03 INFO - 'LANGUAGE': 'en_US:en', 16:10:03 INFO - 'LOGNAME': 'cltbld', 16:10:03 INFO - 'MAIL': '/var/mail/cltbld', 16:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:03 INFO - 'MOZ_NO_REMOTE': '1', 16:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:03 INFO - 'NO_EM_RESTART': '1', 16:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:03 INFO - 'PWD': '/builds/slave/test', 16:10:03 INFO - 'SHELL': '/bin/bash', 16:10:03 INFO - 'SHLVL': '1', 16:10:03 INFO - 'TERM': 'linux', 16:10:03 INFO - 'TMOUT': '86400', 16:10:03 INFO - 'USER': 'cltbld', 16:10:03 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:03 INFO - '_': '/tools/buildbot/bin/python'} 16:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:03 INFO - Downloading/unpacking psutil>=0.7.1 16:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:10:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:05 INFO - Installing collected packages: psutil 16:10:05 INFO - Running setup.py install for psutil 16:10:05 INFO - building 'psutil._psutil_linux' extension 16:10:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:10:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:10:06 INFO - building 'psutil._psutil_posix' extension 16:10:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:10:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:10:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:06 INFO - Successfully installed psutil 16:10:06 INFO - Cleaning up... 16:10:06 INFO - Return code: 0 16:10:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:06 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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:10:06 INFO - Using env: {'DISPLAY': ':0', 16:10:06 INFO - 'HOME': '/home/cltbld', 16:10:06 INFO - 'LANG': 'en_US.UTF-8', 16:10:06 INFO - 'LANGUAGE': 'en_US:en', 16:10:06 INFO - 'LOGNAME': 'cltbld', 16:10:06 INFO - 'MAIL': '/var/mail/cltbld', 16:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:06 INFO - 'MOZ_NO_REMOTE': '1', 16:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:06 INFO - 'NO_EM_RESTART': '1', 16:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:06 INFO - 'PWD': '/builds/slave/test', 16:10:06 INFO - 'SHELL': '/bin/bash', 16:10:06 INFO - 'SHLVL': '1', 16:10:06 INFO - 'TERM': 'linux', 16:10:06 INFO - 'TMOUT': '86400', 16:10:06 INFO - 'USER': 'cltbld', 16:10:06 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:06 INFO - '_': '/tools/buildbot/bin/python'} 16:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:10:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:10:08 INFO - Installing collected packages: mozsystemmonitor 16:10:08 INFO - Running setup.py install for mozsystemmonitor 16:10:08 INFO - Successfully installed mozsystemmonitor 16:10:08 INFO - Cleaning up... 16:10:08 INFO - Return code: 0 16:10:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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', '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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:10: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 blobuploader==1.2.4 16:10:08 INFO - Using env: {'DISPLAY': ':0', 16:10:08 INFO - 'HOME': '/home/cltbld', 16:10:08 INFO - 'LANG': 'en_US.UTF-8', 16:10:08 INFO - 'LANGUAGE': 'en_US:en', 16:10:08 INFO - 'LOGNAME': 'cltbld', 16:10:08 INFO - 'MAIL': '/var/mail/cltbld', 16:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:08 INFO - 'MOZ_NO_REMOTE': '1', 16:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:08 INFO - 'NO_EM_RESTART': '1', 16:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:08 INFO - 'PWD': '/builds/slave/test', 16:10:08 INFO - 'SHELL': '/bin/bash', 16:10:08 INFO - 'SHLVL': '1', 16:10:08 INFO - 'TERM': 'linux', 16:10:08 INFO - 'TMOUT': '86400', 16:10:08 INFO - 'USER': 'cltbld', 16:10:08 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:08 INFO - '_': '/tools/buildbot/bin/python'} 16:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:10 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:10 INFO - Downloading docopt-0.6.1.tar.gz 16:10:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:10 INFO - Running setup.py install for blobuploader 16:10:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:11 INFO - Running setup.py install for requests 16:10:11 INFO - Running setup.py install for docopt 16:10:11 INFO - Successfully installed blobuploader requests docopt 16:10:11 INFO - Cleaning up... 16:10:11 INFO - Return code: 0 16:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:11 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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:11 INFO - Using env: {'DISPLAY': ':0', 16:10:11 INFO - 'HOME': '/home/cltbld', 16:10:11 INFO - 'LANG': 'en_US.UTF-8', 16:10:11 INFO - 'LANGUAGE': 'en_US:en', 16:10:11 INFO - 'LOGNAME': 'cltbld', 16:10:11 INFO - 'MAIL': '/var/mail/cltbld', 16:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:11 INFO - 'MOZ_NO_REMOTE': '1', 16:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:11 INFO - 'NO_EM_RESTART': '1', 16:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:11 INFO - 'PWD': '/builds/slave/test', 16:10:11 INFO - 'SHELL': '/bin/bash', 16:10:11 INFO - 'SHLVL': '1', 16:10:11 INFO - 'TERM': 'linux', 16:10:11 INFO - 'TMOUT': '86400', 16:10:11 INFO - 'USER': 'cltbld', 16:10:11 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:11 INFO - '_': '/tools/buildbot/bin/python'} 16:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:11 INFO - Running setup.py (path:/tmp/pip-WLBkBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:11 INFO - Running setup.py (path:/tmp/pip-E2eMfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:11 INFO - Running setup.py (path:/tmp/pip-wBfyP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:11 INFO - Running setup.py (path:/tmp/pip-fyoHQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:12 INFO - Running setup.py (path:/tmp/pip-JsKMNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:12 INFO - Running setup.py (path:/tmp/pip-1PpMn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:12 INFO - Running setup.py (path:/tmp/pip-yPv_FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:12 INFO - Running setup.py (path:/tmp/pip-oiDx3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:12 INFO - Running setup.py (path:/tmp/pip-_uyQaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:12 INFO - Running setup.py (path:/tmp/pip-Xlmll1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:12 INFO - Running setup.py (path:/tmp/pip-Hyqf6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:12 INFO - Running setup.py (path:/tmp/pip-iCxm34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:12 INFO - Running setup.py (path:/tmp/pip-jKLSi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:12 INFO - Running setup.py (path:/tmp/pip-3pvOri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:12 INFO - Running setup.py (path:/tmp/pip-8GPHij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:12 INFO - Running setup.py (path:/tmp/pip-yGyMiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:12 INFO - Running setup.py (path:/tmp/pip-EY6iH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:12 INFO - Running setup.py install for manifestparser 16:10:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Running setup.py install for mozcrash 16:10:13 INFO - Running setup.py install for mozdebug 16:10:13 INFO - Running setup.py install for mozdevice 16:10:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Running setup.py install for mozfile 16:10:13 INFO - Running setup.py install for mozhttpd 16:10:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Running setup.py install for mozinfo 16:10:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Running setup.py install for mozInstall 16:10:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:13 INFO - Running setup.py install for mozleak 16:10:13 INFO - Running setup.py install for mozlog 16:10:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Running setup.py install for moznetwork 16:10:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Running setup.py install for mozprocess 16:10:14 INFO - Running setup.py install for mozprofile 16:10:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Running setup.py install for mozrunner 16:10:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Running setup.py install for mozscreenshot 16:10:14 INFO - Running setup.py install for moztest 16:10:14 INFO - Running setup.py install for mozversion 16:10:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:14 INFO - Cleaning up... 16:10:14 INFO - Return code: 0 16:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:14 INFO - Using env: {'DISPLAY': ':0', 16:10:14 INFO - 'HOME': '/home/cltbld', 16:10:14 INFO - 'LANG': 'en_US.UTF-8', 16:10:14 INFO - 'LANGUAGE': 'en_US:en', 16:10:14 INFO - 'LOGNAME': 'cltbld', 16:10:14 INFO - 'MAIL': '/var/mail/cltbld', 16:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:14 INFO - 'MOZ_NO_REMOTE': '1', 16:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:14 INFO - 'NO_EM_RESTART': '1', 16:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:14 INFO - 'PWD': '/builds/slave/test', 16:10:14 INFO - 'SHELL': '/bin/bash', 16:10:14 INFO - 'SHLVL': '1', 16:10:14 INFO - 'TERM': 'linux', 16:10:14 INFO - 'TMOUT': '86400', 16:10:14 INFO - 'USER': 'cltbld', 16:10:14 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:14 INFO - '_': '/tools/buildbot/bin/python'} 16:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:14 INFO - Running setup.py (path:/tmp/pip-rh5wKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:15 INFO - Running setup.py (path:/tmp/pip-Obe8Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:15 INFO - Running setup.py (path:/tmp/pip-DXmYpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:15 INFO - Running setup.py (path:/tmp/pip-gyXlkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:15 INFO - Running setup.py (path:/tmp/pip-b8UzWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:15 INFO - Running setup.py (path:/tmp/pip-N5JE6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:15 INFO - Running setup.py (path:/tmp/pip-X1b4fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:15 INFO - Running setup.py (path:/tmp/pip-a0OijJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:15 INFO - Running setup.py (path:/tmp/pip-UHBqfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:15 INFO - Running setup.py (path:/tmp/pip-2Vp5Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:15 INFO - Running setup.py (path:/tmp/pip-yhQI59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:15 INFO - Running setup.py (path:/tmp/pip-TgNk6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:15 INFO - Running setup.py (path:/tmp/pip-Dsxhlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:15 INFO - Running setup.py (path:/tmp/pip-H46dQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:15 INFO - Running setup.py (path:/tmp/pip-JGOxar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:16 INFO - Running setup.py (path:/tmp/pip-OFchc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:16 INFO - Running setup.py (path:/tmp/pip-nin9Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:17 INFO - Downloading blessings-1.5.1.tar.gz 16:10:17 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:18 INFO - Installing collected packages: blessings 16:10:18 INFO - Running setup.py install for blessings 16:10:18 INFO - Successfully installed blessings 16:10:18 INFO - Cleaning up... 16:10:18 INFO - Return code: 0 16:10:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:18 INFO - Reading from file tmpfile_stdout 16:10:18 INFO - Current package versions: 16:10:18 INFO - argparse == 1.2.1 16:10:18 INFO - blessings == 1.5.1 16:10:18 INFO - blobuploader == 1.2.4 16:10:18 INFO - docopt == 0.6.1 16:10:18 INFO - manifestparser == 1.1 16:10:18 INFO - mozInstall == 1.12 16:10:18 INFO - mozcrash == 0.16 16:10:18 INFO - mozdebug == 0.1 16:10:18 INFO - mozdevice == 0.47 16:10:18 INFO - mozfile == 1.2 16:10:18 INFO - mozhttpd == 0.7 16:10:18 INFO - mozinfo == 0.9 16:10:18 INFO - mozleak == 0.1 16:10:18 INFO - mozlog == 3.1 16:10:18 INFO - moznetwork == 0.27 16:10:18 INFO - mozprocess == 0.22 16:10:18 INFO - mozprofile == 0.27 16:10:18 INFO - mozrunner == 6.11 16:10:18 INFO - mozscreenshot == 0.1 16:10:18 INFO - mozsystemmonitor == 0.0 16:10:18 INFO - moztest == 0.7 16:10:18 INFO - mozversion == 1.4 16:10:18 INFO - psutil == 3.1.1 16:10:18 INFO - requests == 1.2.3 16:10:18 INFO - wsgiref == 0.1.2 16:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:18 INFO - Using env: {'DISPLAY': ':0', 16:10:18 INFO - 'HOME': '/home/cltbld', 16:10:18 INFO - 'LANG': 'en_US.UTF-8', 16:10:18 INFO - 'LANGUAGE': 'en_US:en', 16:10:18 INFO - 'LOGNAME': 'cltbld', 16:10:18 INFO - 'MAIL': '/var/mail/cltbld', 16:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:18 INFO - 'MOZ_NO_REMOTE': '1', 16:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:18 INFO - 'NO_EM_RESTART': '1', 16:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:18 INFO - 'PWD': '/builds/slave/test', 16:10:18 INFO - 'SHELL': '/bin/bash', 16:10:18 INFO - 'SHLVL': '1', 16:10:18 INFO - 'TERM': 'linux', 16:10:18 INFO - 'TMOUT': '86400', 16:10:18 INFO - 'USER': 'cltbld', 16:10:18 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:18 INFO - '_': '/tools/buildbot/bin/python'} 16:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:10:18 INFO - Cleaning up... 16:10:18 INFO - Return code: 0 16:10:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:10:18 INFO - Using env: {'DISPLAY': ':0', 16:10:18 INFO - 'HOME': '/home/cltbld', 16:10:18 INFO - 'LANG': 'en_US.UTF-8', 16:10:18 INFO - 'LANGUAGE': 'en_US:en', 16:10:18 INFO - 'LOGNAME': 'cltbld', 16:10:18 INFO - 'MAIL': '/var/mail/cltbld', 16:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:18 INFO - 'MOZ_NO_REMOTE': '1', 16:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:18 INFO - 'NO_EM_RESTART': '1', 16:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:18 INFO - 'PWD': '/builds/slave/test', 16:10:18 INFO - 'SHELL': '/bin/bash', 16:10:18 INFO - 'SHLVL': '1', 16:10:18 INFO - 'TERM': 'linux', 16:10:18 INFO - 'TMOUT': '86400', 16:10:18 INFO - 'USER': 'cltbld', 16:10:18 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:18 INFO - '_': '/tools/buildbot/bin/python'} 16:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:18 INFO - Downloading/unpacking jsonschema 16:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:10:20 INFO - Downloading/unpacking functools32 (from jsonschema) 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:20 INFO - warning: no files found matching '*.txt' 16:10:20 INFO - no previously-included directories found matching 'build' 16:10:20 INFO - no previously-included directories found matching 'dist' 16:10:20 INFO - no previously-included directories found matching '.git*' 16:10:20 INFO - Installing collected packages: jsonschema, functools32 16:10:20 INFO - Running setup.py install for functools32 16:10:20 INFO - warning: no files found matching '*.txt' 16:10:20 INFO - no previously-included directories found matching 'build' 16:10:20 INFO - no previously-included directories found matching 'dist' 16:10:20 INFO - no previously-included directories found matching '.git*' 16:10:20 INFO - Successfully installed jsonschema functools32 16:10:20 INFO - Cleaning up... 16:10:20 INFO - Return code: 0 16:10:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:20 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 0x7f1160158f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:10:20 INFO - Using env: {'DISPLAY': ':0', 16:10:20 INFO - 'HOME': '/home/cltbld', 16:10:20 INFO - 'LANG': 'en_US.UTF-8', 16:10:20 INFO - 'LANGUAGE': 'en_US:en', 16:10:20 INFO - 'LOGNAME': 'cltbld', 16:10:20 INFO - 'MAIL': '/var/mail/cltbld', 16:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:20 INFO - 'MOZ_NO_REMOTE': '1', 16:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:20 INFO - 'NO_EM_RESTART': '1', 16:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:20 INFO - 'PWD': '/builds/slave/test', 16:10:20 INFO - 'SHELL': '/bin/bash', 16:10:20 INFO - 'SHLVL': '1', 16:10:20 INFO - 'TERM': 'linux', 16:10:20 INFO - 'TMOUT': '86400', 16:10:20 INFO - 'USER': 'cltbld', 16:10:20 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:20 INFO - '_': '/tools/buildbot/bin/python'} 16:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:21 INFO - Downloading/unpacking flake8 16:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:10:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:10:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:10:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:10:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:10:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:10:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:23 INFO - no previously-included directories found matching 'docs/_build' 16:10:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:10:23 INFO - Running setup.py install for pep8 16:10:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:23 INFO - no previously-included directories found matching 'docs/_build' 16:10:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:10:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:10:23 INFO - Cleaning up... 16:10:23 INFO - Return code: 0 16:10:23 INFO - Running post-action listener: _resource_record_post_action 16:10:23 INFO - Running post-action listener: _start_resource_monitoring 16:10:23 INFO - Starting resource monitoring. 16:10:23 INFO - ##### 16:10:23 INFO - ##### Running install step. 16:10:23 INFO - ##### 16:10:23 INFO - Running pre-action listener: _resource_record_pre_action 16:10:23 INFO - Running main action method: install 16:10:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:23 INFO - Reading from file tmpfile_stdout 16:10:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:23 INFO - Reading from file tmpfile_stdout 16:10:23 INFO - Output received: 16:10:23 INFO - Usage: mozinstall [options] installer 16:10:23 INFO - Options: 16:10:23 INFO - -h, --help show this help message and exit 16:10:23 INFO - -d DEST, --destination=DEST 16:10:23 INFO - Directory to install application into. [default: 16:10:23 INFO - "/builds/slave/test"] 16:10:23 INFO - --app=APP Application being installed. [default: firefox] 16:10:23 INFO - mkdir: /builds/slave/test/build/application 16:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:10:38 INFO - Reading from file tmpfile_stdout 16:10:38 INFO - Output received: 16:10:38 INFO - /builds/slave/test/build/application/firefox/firefox 16:10:38 INFO - Running post-action listener: _resource_record_post_action 16:10:38 INFO - ##### 16:10:38 INFO - ##### Running run-tests step. 16:10:38 INFO - ##### 16:10:38 INFO - Running pre-action listener: _resource_record_pre_action 16:10:38 INFO - Running main action method: run_tests 16:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:10:38 INFO - Python 2.7.3 16:10:38 INFO - Return code: 0 16:10:38 INFO - grabbing minidump binary from tooltool 16:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:38 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 0x27610b0>, '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 0x2761fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:10:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:10:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:10:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:10:38 INFO - Return code: 0 16:10:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:10:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:10:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:10:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:10:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:10:39 INFO - Return code: 0 16:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test/build 16:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 16:10:39 INFO - Using env: {'DISPLAY': ':0', 16:10:39 INFO - 'HOME': '/home/cltbld', 16:10:39 INFO - 'LANG': 'en_US.UTF-8', 16:10:39 INFO - 'LANGUAGE': 'en_US:en', 16:10:39 INFO - 'LOGNAME': 'cltbld', 16:10:39 INFO - 'MAIL': '/var/mail/cltbld', 16:10:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:39 INFO - 'MOZ_NO_REMOTE': '1', 16:10:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:39 INFO - 'NO_EM_RESTART': '1', 16:10:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:39 INFO - 'PWD': '/builds/slave/test', 16:10:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:39 INFO - 'SHELL': '/bin/bash', 16:10:39 INFO - 'SHLVL': '1', 16:10:39 INFO - 'TERM': 'linux', 16:10:39 INFO - 'TMOUT': '86400', 16:10:39 INFO - 'USER': 'cltbld', 16:10:39 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696', 16:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:39 INFO - '_': '/tools/buildbot/bin/python'} 16:10:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 16:10:39 INFO - mozversion INFO | application_buildid: 20151202152525 16:10:39 INFO - mozversion INFO | application_changeset: 675689351241e48a85bf474ee08a6bc75787027b 16:10:39 INFO - mozversion INFO | application_display_name: Nightly 16:10:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:10:39 INFO - mozversion INFO | application_name: Firefox 16:10:39 INFO - mozversion INFO | application_remotingname: firefox 16:10:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:10:39 INFO - mozversion INFO | application_vendor: Mozilla 16:10:39 INFO - mozversion INFO | application_version: 45.0a1 16:10:39 INFO - mozversion INFO | platform_buildid: 20151202152525 16:10:39 INFO - mozversion INFO | platform_changeset: 675689351241e48a85bf474ee08a6bc75787027b 16:10:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:10:39 INFO - mozversion INFO | platform_version: 45.0a1 16:10:39 INFO - 2015-12-02 16:10:39,736 DEBUG : using testdate: 1449101439 16:10:39 INFO - 2015-12-02 16:10:39,736 DEBUG : actual date: 1449101439 16:10:39 INFO - 2015-12-02 16:10:39,782 INFO : starting webserver on 'localhost:54346' 16:10:39 INFO - 2015-12-02 16:10:39,784 INFO : Starting test suite talos-linux64-ix-038 16:10:39 INFO - 2015-12-02 16:10:39,784 INFO : Starting test dromaeo_css 16:10:39 INFO - 2015-12-02 16:10:39,784 DEBUG : operating with platform_type : linux_ 16:10:39 INFO - 2015-12-02 16:10:39,784 INFO : Initialising browser for dromaeo_css test... 16:10:39 INFO - 2015-12-02 16:10:39,801 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNwH0oJ/profile http://localhost:54346/getInfo.html 16:10:44 INFO - 2015-12-02 16:10:44,672 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:10:44 INFO - 2015-12-02 16:10:44,672 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:10:44 INFO - 2015-12-02 16:10:44,672 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:10:44 INFO - 2015-12-02 16:10:44,672 DEBUG : BROWSER_OUTPUT: __metrics 16:10:44 INFO - 2015-12-02 16:10:44,768 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:10:44 INFO - 2015-12-02 16:10:44,769 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:10:46 INFO - 2015-12-02 16:10:46,070 INFO : Browser initialized. 16:10:46 INFO - 2015-12-02 16:10:46,070 INFO : Running cycle 1/1 for dromaeo_css test... 16:10:46 INFO - 2015-12-02 16:10:46,070 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNwH0oJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:10:58 INFO - 2015-12-02 16:10:58,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 143552512 16:10:58 INFO - 2015-12-02 16:10:58,054 DEBUG : BROWSER_OUTPUT: 16:11:49 INFO - 2015-12-02 16:11:49,313 DEBUG : BROWSER_OUTPUT: 1449101509310 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:14:01 INFO - 2015-12-02 16:14:01,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54346/tests/dromaeo/cssquery-ext.html) 16:14:02 INFO - 2015-12-02 16:14:02,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 231235584 16:14:02 INFO - 2015-12-02 16:14:02,476 DEBUG : BROWSER_OUTPUT: 16:17:04 INFO - 2015-12-02 16:17:04,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-ext.html (next: http://localhost:54346/tests/dromaeo/cssquery-jquery.html) 16:17:05 INFO - 2015-12-02 16:17:05,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 217124864 16:17:05 INFO - 2015-12-02 16:17:05,317 DEBUG : BROWSER_OUTPUT: 16:20:07 INFO - 2015-12-02 16:20:07,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54346/tests/dromaeo/cssquery-mootools.html) 16:20:07 INFO - 2015-12-02 16:20:07,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 214564864 16:20:07 INFO - 2015-12-02 16:20:07,883 DEBUG : BROWSER_OUTPUT: 16:23:09 INFO - 2015-12-02 16:23:09,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54346/tests/dromaeo/cssquery-prototype.html) 16:23:10 INFO - 2015-12-02 16:23:10,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 204115968 16:23:10 INFO - 2015-12-02 16:23:10,386 DEBUG : BROWSER_OUTPUT: 16:26:13 INFO - 2015-12-02 16:26:13,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54346/tests/dromaeo/cssquery-yui.html) 16:26:13 INFO - 2015-12-02 16:26:13,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 203132928 16:26:13 INFO - 2015-12-02 16:26:13,647 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-yui.html (next: http://localhost:54346/tests/dromaeo/cssquery-dojo.html) 16:29:16 INFO - 2015-12-02 16:29:16,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 249307136 16:29:16 INFO - 2015-12-02 16:29:16,524 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,524 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:29:16 INFO - 2015-12-02 16:29:16,524 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:29:16 INFO - 2015-12-02 16:29:16,524 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:29:16 INFO - 2015-12-02 16:29:16,525 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:29:16 INFO - 2015-12-02 16:29:16,528 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2589.3138318345636;2670.0387860370265;2688.1397952655147;2698.0421950207688;2701.2301494074186;4587.839425620104;4640.698354606948;4706.917408995929;4731.834385796497;4736.12381709384;4571.51999040101;4602.5857672809525;4651.813927442899;4656.394668693065;4674.789634466449;4294.398784170203;4318.503372112208;4352.042550638855;4353.434053573031;4380.145871555048;4127.339625659895;4403.933940990888;4408;4458.576435238663;4463.70985885918;4217.915641687149;4298.16185843759;4319.870403887889;4320.351947207912;4327.307630779092;4321.65426765858;4330.480342358906;4340.327249276367;4345.326474396474;4369.519352871182;4315.8057887394825;4317.028668549583;4325.740455572675;4351.912961740779;4370.4318438603095;4381.189479946188;4473.731576105444;4490.730556166608;4536.387587675687;4666.323383109464;4992.400911890596;5071.1632580624155;5073.137566613685;5073.34046573943;5110.821121260775;5083.79664813407;5085.694858308476;5085.720285384303;5088.363954505687;5090.465501122366;4560.475545312298;4661.580457758818;4680.134175177569;4684;4685.1800934836265;5134.794608215704;5145.408278048072;5149.433562308143;5152.896942061137;5190.195519694454;4942.258661200777;4944.505549445099;4944.950550494521;4952.801887924443;4997.100521906019;4771.856844294677;4863.708177509361;4877.609791216694;5031.371078615173;5040.017196646619;4858.198397264412;4913.87715307113;4922.409310882717;4943.307936888838;4952.059108769322;4938.209886418228;4960.280759289955;4982.676126051795;4990.051890140934;5032.521910418504;4021.155557332993;4199.517055538591;4205.642520385802;4205.9789701051295;4237.618614324726;3559.964400356015;3603.4594810778594;3623.0942264433893;3628.111112777334;3657.908552286214;4322.308430651081;4357.847475338348;4363.738175709467;4365.192439398721;4404.317330813729;4848.539388758062;5062.7468626568525;5066.36670416198;5067.923981140286;5094.566961808214;4210.7473551587;4222.514410842731;4244.575542445792;4246.087091275391;4252.87241382759;4482.417285752831;4484.798184081724;4492.505824359318;4501.054778496552;4518.638508919278;4843.806247750051;4844.249141383091;4844.539768721966;4850.902981940341;4874.000829829805;4761.428628564595;4878.317035615088;4880.145974454527;5043.9747801260755;5056.216286475602;4682.321063445713;4765.571098601143;4766;4771.856844294677;4810.254410566367;4959.62802789785;4964.131277026579;4965.1311020571975;4966;5006.449290577961;4813.5186481352985;4882.36529251195;4938.703677779345;5043.697378157322;5081.745912704424;4753.714777113384;4818.156822555969;4829.6860704054125;4840.951590484191;4877.195262781602;4855.927161092516;4878.756062196947;4880.560749532559;4882.170031094652;4888.92666609994;4606.861794146181;4692.389989301369;4695.154872123051;4793.9041219176115;4815.374001379798;4824.903501930012;4894.437139728977;4899.069176856386;4910.680805747615;4949;4798.3762110926755;4819.2530157825595;4840.1287768200655;4848.903021939612;4890.193118135468 16:29:16 INFO - 2015-12-02 16:29:16,529 DEBUG : BROWSER_OUTPUT: |1;ext.html;528.8492779557824;549.5466240351711;561.1022364217253;574.72413241644;586.5659412035095;27712.584311235347;28318.150455486342;33575.16062098452;33793.324133517315;34198.829005855;35985.280294394164;36402.27195456089;36571.26857462849;36607.90176294709;36710;7039.155301363843;7934.365250779938;8104.1085480597085;8107.189281071905;8111.229433203836;7123.8219044523785;10271;10539;10544.314619549705;10548;10115.19078473724;10189.235807314444;10235.641752538662;10237.283390162691;10245.97540245977;10118.898811011906;10146.391216527032;10228.232882533764;10239.641612543524;10241.641542546013;10038;10181.236407269484;10183.796324073477;10186.796264074752;10189.898101019044;34529.13677158066;34536.30927381438;34763.30473390543;34772.65227347719;34797.30405391903;2885.841278729669;3004.1438190115714;3265.9346813063607;3532.4701294805727;3538.6638269364626;27593;27646.170614881383;28305.531341627793;28310;28636.427271454664;3203.823789691566;3235.4014507316224;3268.7711860169798;3304.5208444775612;3347.56481657383;209368;210856;211191;211421;211713.99999999846;49839.25241121386;51151.23273150906;54331.72834135804;54644.18033729497;54659.72670136624;57291.71354143203;58075.70962145162;58110;58111.70944145252;58160;13410.798838017437;13703.314834258446;13706.931465342808;13711.862881371058;13717.657058573415;9970.202383809277;10058.094771470456;10095.293329467013;10099.596016159418;10101.292909496411;18648.906755466134;18918.621627567372;18945.147468363957;18965.62068758617;18995.715064274045;7268.527545709618;7457.888131678029;7459.142198647117;7474.7757567273065;7535.886961695579;863.8574635185249;866.5537248317122;898.9460632362079;930.0095398400816;935.0742764662934;26808.59787103195;27666.308342291602;27981;28054.579181312296;28076.85961570179;911.2300106410073;925.2181906289175;940.2759874896292;1014.3102690170755;1045.8744950605824;13078.346082695827;13175.209487430784;13216.471341146438;13259.403326850315;14230.28848557568;201689;204354;205722;206065;207345;41081.178376432305;41164.58835411607;41370.1725965479;41445.58554414478;41449.58550414517;1236.9876301237052;1240.1443004327166;1246.1962034487524;1252.511520507003;1265.6203139058246;25294.494110118063;26079.608805868305;27194.184174474798;27627.86186069057;27703.861480693275;37364.43953340757;37631;37660.43509347417;37683;37756;171313;172605.13697431432;172866;172926.13536932738;173085.13457433137;24273.63589546123;25018.249452516455;26828;28450.715492844807;29474.263143421587;33422.66577334293;33622.49566256557;33797.83101084577;34022;34511.65488345185;29216.7078329214;29656.55515167231;29830.403391932476;30097;31324.216894577818;24687.506249874543;29737;31794.205144870637;31868.203294917814;32361.676383235867;29825.25436864096;30130.24674383158;30150.69849301479;30464.69535304707;30501.389972199988;27219.59170612482;28009;29424.852875735483;29516.262093447836;29815;23176.652350214423;23185.261105416823;23227.419314517272;23374.181903633293;23510.41223969346 16:29:16 INFO - 2015-12-02 16:29:16,530 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.51598665947716;332.0205394087442;332.03874782504636;332.77371387456526;333.69300243775723;12448.875511244907;12680.302583357934;14778.113313201215;15219.162946037963;15517.379304827808;9530.380525265853;9535;9558.044195580438;13200.27398493085;15846.76229856553;4441;4543.727376357413;4544.795484203219;4559.156556037127;4565.201089809287;3337.0823023668563;3440.4839274108836;4612.331211974261;4977.5022497750115;5069.847904562869;5110.872228194287;5112.718800465973;5141.280220769096;5148.74256287186;5150.1759718445055;5047.614767319344;5094.5160209780015;5106.183010718286;5109.4379618241965;5130.948690513122;4884.340614017097;4909.852704418873;4935.851924442272;4938.061768264019;4952.281919121707;11194.160437967104;12814.679633009157;18760.34338798149;19450.27696122544;19474.123664435134;1783.0193393633579;1890.1494327552657;1890.6029733755927;1894.8010458901892;1898.3450709505198;9023.187913087853;12044.939775301067;12489.250644961241;12638;12895.484180632764;1718.707819670659;1755.1079093888347;1756.4203812741891;1758.9824101758948;1796.6855800234907;55536.44463555353;58242.7087864558;58444;58654.120188196786;58851.41148588502;9357.766055848522;9679.274054445945;9693.806123877624;9757.316987810786;9770.804583908282;12395.256284622952;12474.064445166649;12476;12509.249445033327;12530.185537940004;6951.061606683134;6958.79123626292;7071.257517960643;7118.537295075804;7142.607156606333;6625.337466253336;6652.268250492442;6660.533762636665;6700.028495868072;6736.730530778812;4096;4156.147989662112;4171.395147703566;4210.547361160456;4211.43145675336;1597.456864666019;1663.6256842210405;1687.3885439405337;1723.9051852148252;1733.0884114687447;753.7211231844253;777.1723114882632;862.9395942283979;874.7200895713311;884.920357167858;14578;15261;15338.769918451233;15407.075575465507;15444.150571718663;824.5392426970063;868.1101870582577;878.5826732302105;906.4425378392373;930.0559931669361;8034.839303213903;8336.62485188168;8400.075991640915;8971.32715046361;9660.806783864284;465543;477814;482312;483116;484008;37898.62101379006;37915;44922;52334;53339;1053.5259133389852;1060.2790102730216;1108.9223754337281;1120.2886167283834;1128.1651577832508;14494.710105798036;14600;14626.926865365605;14698.41206351734;15000.2499875008;32864;32949.83525082359;33682.49476257809;33702.662973370934;34287.14282142966;43133;44357.33463997978;44480.77759611181;44889.32666009947;45622;8280.50316980983;8414.831703365777;8420.578971051546;8430.747077587683;8547.871781923152;15007.249637517862;15363.088009674802;15418.537443876701;15579.610509737347;15920.681586368439;12477.188982716458;12979.870201297867;13106;13419.597412077654;14374;13240.735185296433;13267.137636053625;13336.733265334446;13706.109102908278;14022.525027808611;13476.595702128952;13521;13845.030847840555;13876.653083672989;13919.164850109026;8563.914360856312;8698.652053918026;8750;8838.381313308008;8846.15961483658;12011.75976480483;12937.09440339205;13593.66015849572;13938.93030534841;14008.509702160376 16:29:16 INFO - 2015-12-02 16:29:16,531 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1236.7959286717692;1650.9834901650984;1684.941027064053;1717.6221231329107;1718.6219031813005;6311.621302721835;7106.2538433464515;7233.891491627616;7251.782446526599;7252;7099.503034787554;7223.566586004843;7244.891326630105;7279.053723016001;7284;2010.7285516455274;2041.5508588110665;2043.7240972468749;2046.7850875658064;2051.9589608207825;2083.8645488043303;2103.0956688623887;2108.652072408051;2123.57528494301;2132.1471411435396;2025.0684685044896;2072.7823578524262;2081.354780018199;2100.1494394770143;2101.8108370246673;2071.5028393185676;2095.6646936490165;2097.496600815793;2099.6640537513927;2100.7899210078945;2038.7553493580865;2086.5722526881955;2089.40451971189;2092.110852887532;2092.5082605587677;6023.277206735176;6173.81478555644;7190.712371505134;7290.963545182293;7295.744648937315;3831.9233615327817;4021.577734337882;4034.253663072341;4034.616711412411;4036.7174297799165;2632.802539809503;2680.1825443239804;2735.0700761740904;2736.179146256135;2737.8220415672918;815.8939337886096;825.8205907257072;830.7341650671788;830.7466222802043;841.3311417423163;9494.762630934212;9657.661981830603;9691.612335506501;9701.223902087817;9711.320207585472;3822.369309063973;3849.615038496128;3894.6494815466745;3900.9804950975063;3901.5903330150495;8497.192766687154;8499.235068843835;8499.872501912476;8502.574871256413;8514.14858514156;4195.643370313496;4206.41110244566;4226.978865105655;4227.154569086134;4231.619154276068;3831.1571454280015;3838.05967537955;3840.0399900024995;3850.383938569815;3855.2867719471988;3295.752818538619;3314.2377253231894;3336.232666486673;3336.9332613347597;3342.1143396999814;1025.3591505309182;1038.9428581428094;1042;1046.1212581431482;1053.1890444357955;1192.3382522699985;1212.6483319837148;1213.4539457244275;1218.3725381428571;1232.6240496648609;6659.733610655519;6857.622830744357;6886.793396198122;6889.724411023603;6897.655117244118;402.3722992132283;406.92878746219293;410.45614560707185;411.2453647556767;412.57298695849653;4930.556249937523;5282.234076059027;5291.312129423227;5347.358317001985;5352.678839269656;7763.883541746878;8113;8272.669093236324;8283.08886022537;8288.92244008275;8228.670853165806;8317.750467485985;8334.249917507454;8335.749927502186;8338.332933365316;6230.345813689588;6469.935300647027;6481.384268494486;6501.1548498694865;6503.674816259168;6772.424343930821;6801.829954251183;6842.281560436082;6844.691988860413;6866.141732283465;7587.203343648837;7679.69281228767;7709.807254818675;7714.344280735976;7834.804129896798;7853.136155023057;7958.522488650699;8024.879626805719;8052.074011488754;8063.19368063189;6455.580387274812;6469.45009674183;6517.543771935919;6609.735610575523;6610.140681711347;6924.99587559791;7018.473614478832;7040.0847889774;7041.647917604202;7052.541584796972;6476.255230648348;6633.6019838809825;6655.833604159935;6692.096566963398;6748.055272261985;6464.321246269262;6481.157449531531;6538.051982462422;6589.17635295588;6611.272759996493;6644.534882558368;6737.494687898526;6739.191297044386;6742.696578653874;6746.426553742791;5636.154576813511;6008.819735407945;6014.488768454556;6019.849503762441;6022.45797878193;6127.050307202391;6163.35284795108;6169.50643948474;6174.228221472316;6175 16:29:16 INFO - 2015-12-02 16:29:16,532 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.9005383196629;299.9745021673158;306.82970951122127;307.9645840728317;308.8008234688626;5290.894182116355;5298.284731561238;5347.46525347466;5350.117230656937;5361.812336568221;5258.106121959267;5284.365876094865;5289.047971365153;5295.708736019517;5299.834036511961;3950.8222130004074;4164.12553363794;4167.499900012002;4177.436046133771;4178.56125106864;4055.8377664893515;4079.388091786241;4157.937630935538;4181.895452613679;4193.748375097489;4121.361189015693;4135.793210339471;4139.19285739281;4150.356694712309;4157.334826427772;3891.7470364426504;3987.641112299907;4034.435179074932;4114.506259248894;4126.463559737245;3627.2382799612114;3642.817859107034;3650.4889315495852;3653.926921461556;3655.5430571178604;5104.259882317043;5107.284980102789;5110.259012443212;5125.154349532323;5127.410347810012;4745.1221524018165;4746.525347465225;4755.167845627036;4756.500567440438;4760.880977975544;5450.672959622435;5560.610757246995;5576.386597474275;5589.832305030855;5602.887942241173;3967.6032396760384;3967.960320396788;3971;3974.940375894364;3976.522817261918;5851.736671849777;5853.912191317177;5856.180134781134;5859.707014649251;5869.266341707286;4071.1654110907193;4071.816768245436;4076.735012224196;4082.1223436961195;4087.4686290782006;4041.959580404217;4151.14901445203;4153.646940010072;4157.064660451374;4173.457450531411;4681.110588988081;4706.811727530929;4716.481187069419;4718.103560323596;4719;5555.166724991283;5563.332400112013;5564.805231816867;5565.582581306418;5567.3040869891265;1456.3592019511382;1474.6903150338335;1476.5275111964283;1483.2880217495663;1484.4730120807174;1008.4705529596873;1016.8576399303955;1017.9592816287413;1029.130384824822;1036.7149034015706;4936.062148191904;4936.160852655057;4942.20924652054;4943.085529177114;4953.306537084811;5784.045632470596;5793.971030144822;5795.478406943311;5797.130430435384;5798.304203495608;4936.531029552187;4939.259111133359;4943.110240156806;4943.332650092263;4944.208926571731;3063.387322535502;3084;3119.610048743907;3124.937501249962;3129.7809153359503;5599.468050535193;5607.719614019365;5611.523020543218;5612.607117501736;5615;6041.637501749821;6046.697665116727;6047.697615119315;6050;6055.788047418319;5499.890221752118;5609.298837645294;5615.410381909923;5616.410276920946;5619.072852979294;5810;5857.062869940789;5857.736401862012;5858.209141765807;5859.121131830089;5727.284089488814;5732.16883551891;5734.627249228787;5735.913961290667;5743;5596.048671725735;5596.580256480699;5604.635698679573;5607.046802043581;5608.298962629671;3948.953527315321;3978.661813745864;3996.8001599919307;4039.91920161601;4045.6358927696647;5856.472917437451;5858.648481091148;5866.384029676822;5869.8239052828485;5871.911921321098;5633.464820842178;5644.266245388073;5646.548276137982;5648.491635752802;5652.886942261214;5511.338639363302;5636.2954630671165;5644.266245388073;5646.689432081275;5650.830475085754;5517.917231241454;5526;5527.309086364205;5527.778888844401;5528.364238112668;5448.291722076105;5589.664620122806;5675.120356344773;5687.829365119053;5708.086706127;5348.5988550858065;5419.918701219563;5423.566114710735;5428.91856622143;5431.4840090191365 16:29:16 INFO - 2015-12-02 16:29:16,533 DEBUG : BROWSER_OUTPUT: |5;yui.html;688.7761477519806;712.6864179760905;755.9735409260675;787.6770524085123;792.5561685456148;11693.473793679284;11961.22252053617;11965.940170299136;11967.401629918491;11986.64040078798;10112.797744045114;11869.881301186986;11960.102992275572;11965.76068478632;11980.34108124053;598.8832177725345;800.1198681450417;822.3544517553721;824.1470078468786;824.7278398128633;814.4421071565966;814.5886327404652;820.0487434575894;822.8601137806558;823.1562648285525;649.8342922554742;659.7789740436959;843.0684094076049;850.2475309351238;850.6809946270149;834.05751500804;844.3287586368882;845.5560830564003;846.3018010141597;847.0216899481109;625.8122563231012;626.2547568393597;626.6678660310043;626.962382257066;627.1752645271454;11685.298882067103;11759.764804703858;11778.234414763014;11813.1140164488;11821.763564728657;11045.447727613588;11053.778924421547;11403.942980285046;11422.31466112036;11840.940795295968;8803.735887923373;9704.320697551175;9757.316987810857;9876.111149996535;9892.25808064398;3193.409219294415;3231.7091461768555;3242.91892702682;3251.951220731691;3252.902412927616;42023.57976420258;42130.578694213276;42176.36735448971;42316.57683423188;42607.95224453672;9116.359055370098;9477.668281610111;9549.61801527945;9607.327487075838;9612.711618651452;16419.507414777574;16666.666666666843;16748;16759.497215083567;16770.832291677172;6426.336175045458;6436.806895793134;6477.125588045647;6501.642409667514;6623.801285961333;3825.5600605930676;3840.2127563849344;3849.576546579874;3863.4204869269834;3930.9017274568364;2742.780577553791;2755.1321333779797;2758.724127587225;2768.197222805404;2782.4156927045547;508.92874997500377;517.6169634470465;520.4405264340849;520.8125074973007;527.1118165890487;535.6839464715837;573.5010540829421;573.6070791507831;589.5755056359415;636.4749082007362;7931.365490760725;8245.95877020623;8549.145085491402;8631.43895646781;8645.870311945326;465.8998315362213;493.45226798253907;545.1958361416879;580.7009390164069;586.4253032028636;3649.59854416014;3706.127750993002;3763.284975854579;3802.1065049713297;3812.8093595320124;52683;52775.47224527782;52799.208011879855;52929.2060619091;52954.47045529573;45521.772391137834;45787.084258314644;46031;46539.534604654196;46667.53332466632;41246.38130428046;41709.58290417118;41744.37383439251;42454.57545424506;42721.57278427176;7197.676104575202;7284.125904891447;7303.379212766762;7335.889961650473;7420.5176663516695;31236.843815780776;31331.216719582193;31550.211244718146;32436.513452297764;32972;36613.633863662086;36968;40392;40806;40916.18167636571;9125.13311235458;9131.13254240846;9244.583993720164;9300.441973481613;9332.766680833034;10341.121004714683;10385.22110841705;10421.635242766466;10444.529996150039;10769.838452423377;9981.401115933068;10007.934933544817;10133.645322413975;10172.08451239392;10474.476276186313;8526.317894568543;8887.244584210415;9118.270538356783;9211.953940230256;9758.268129890428;9591.328606997444;9623.663171788954;9744.12302892743;9862.901370986485;10179.7455063624;8365.665373384996;8403.873941890753;8568.314534837073;8613.966324040905;8677.566121693764;8553.61508732121;8703.956480217812;8706.60820263077;8800.603972821367;8890.066543013148 16:29:16 INFO - 2015-12-02 16:29:16,533 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:29:16 INFO - 2015-12-02 16:29:16,533 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,797 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1449102556523__endTimestamp 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4619.26 Median:4766.00 stddev:484.39 (10.2%) stddev-sans-first:458.95 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: Values: 2589.3 2670.0 2688.1 2698.0 2701.2 4587.8 4640.7 4706.9 4731.8 4736.1 4571.5 4602.6 4651.8 4656.4 4674.8 4294.4 4318.5 4352.0 4353.4 4380.1 4127.3 4403.9 4408.0 4458.6 4463.7 4217.9 4298.2 4319.9 4320.4 4327.3 4321.7 4330.5 4340.3 4345.3 4369.5 4315.8 4317.0 4325.7 4351.9 4370.4 4381.2 4473.7 4490.7 4536.4 4666.3 4992.4 5071.2 5073.1 5073.3 5110.8 5083.8 5085.7 5085.7 5088.4 5090.5 4560.5 4661.6 4680.1 4684.0 4685.2 5134.8 5145.4 5149.4 5152.9 5190.2 4942.3 4944.5 4945.0 4952.8 4997.1 4771.9 4863.7 4877.6 5031.4 5040.0 4858.2 4913.9 4922.4 4943.3 4952.1 4938.2 4960.3 4982.7 4990.1 5032.5 4021.2 4199.5 4205.6 4206.0 4237.6 3560.0 3603.5 3623.1 3628.1 3657.9 4322.3 4357.8 4363.7 4365.2 4404.3 4848.5 5062.7 5066.4 5067.9 5094.6 4210.7 4222.5 4244.6 4246.1 4252.9 4482.4 4484.8 4492.5 4501.1 4518.6 4843.8 4844.2 4844.5 4850.9 4874.0 4761.4 4878.3 4880.1 5044.0 5056.2 4682.3 4765.6 4766.0 4771.9 4810.3 4959.6 4964.1 4965.1 4966.0 5006.4 4813.5 4882.4 4938.7 5043.7 5081.7 4753.7 4818.2 4829.7 4841.0 4877.2 4855.9 4878.8 4880.6 4882.2 4888.9 4606.9 4692.4 4695.2 4793.9 4815.4 4824.9 4894.4 4899.1 4910.7 4949.0 4798.4 4819.3 4840.1 4848.9 4890.2 16:29:16 INFO - 2015-12-02 16:29:16,534 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:35791.92 Median:29320.78 stddev:50866.02 (173.5%) stddev-sans-first:50939.80 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: Values: 528.8 549.5 561.1 574.7 586.6 27712.6 28318.2 33575.2 33793.3 34198.8 35985.3 36402.3 36571.3 36607.9 36710.0 7039.2 7934.4 8104.1 8107.2 8111.2 7123.8 10271.0 10539.0 10544.3 10548.0 10115.2 10189.2 10235.6 10237.3 10246.0 10118.9 10146.4 10228.2 10239.6 10241.6 10038.0 10181.2 10183.8 10186.8 10189.9 34529.1 34536.3 34763.3 34772.7 34797.3 2885.8 3004.1 3265.9 3532.5 3538.7 27593.0 27646.2 28305.5 28310.0 28636.4 3203.8 3235.4 3268.8 3304.5 3347.6 209368.0 210856.0 211191.0 211421.0 211714.0 49839.3 51151.2 54331.7 54644.2 54659.7 57291.7 58075.7 58110.0 58111.7 58160.0 13410.8 13703.3 13706.9 13711.9 13717.7 9970.2 10058.1 10095.3 10099.6 10101.3 18648.9 18918.6 18945.1 18965.6 18995.7 7268.5 7457.9 7459.1 7474.8 7535.9 863.9 866.6 898.9 930.0 935.1 26808.6 27666.3 27981.0 28054.6 28076.9 911.2 925.2 940.3 1014.3 1045.9 13078.3 13175.2 13216.5 13259.4 14230.3 201689.0 204354.0 205722.0 206065.0 207345.0 41081.2 41164.6 41370.2 41445.6 41449.6 1237.0 1240.1 1246.2 1252.5 1265.6 25294.5 26079.6 27194.2 27627.9 27703.9 37364.4 37631.0 37660.4 37683.0 37756.0 171313.0 172605.1 172866.0 172926.1 173085.1 24273.6 25018.2 26828.0 28450.7 29474.3 33422.7 33622.5 33797.8 34022.0 34511.7 29216.7 29656.6 29830.4 30097.0 31324.2 24687.5 29737.0 31794.2 31868.2 32361.7 29825.3 30130.2 30150.7 30464.7 30501.4 27219.6 28009.0 29424.9 29516.3 29815.0 23176.7 23185.3 23227.4 23374.2 23510.4 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25306.68 Median:4126.07 stddev:77936.46 (1888.9%) stddev-sans-first:78132.53 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: Values: 331.5 332.0 332.0 332.8 333.7 12448.9 12680.3 14778.1 15219.2 15517.4 9530.4 9535.0 9558.0 13200.3 15846.8 4441.0 4543.7 4544.8 4559.2 4565.2 3337.1 3440.5 4612.3 4977.5 5069.8 5110.9 5112.7 5141.3 5148.7 5150.2 5047.6 5094.5 5106.2 5109.4 5130.9 4884.3 4909.9 4935.9 4938.1 4952.3 11194.2 12814.7 18760.3 19450.3 19474.1 1783.0 1890.1 1890.6 1894.8 1898.3 9023.2 12044.9 12489.3 12638.0 12895.5 1718.7 1755.1 1756.4 1759.0 1796.7 55536.4 58242.7 58444.0 58654.1 58851.4 9357.8 9679.3 9693.8 9757.3 9770.8 12395.3 12474.1 12476.0 12509.2 12530.2 6951.1 6958.8 7071.3 7118.5 7142.6 6625.3 6652.3 6660.5 6700.0 6736.7 4096.0 4156.1 4171.4 4210.5 4211.4 1597.5 1663.6 1687.4 1723.9 1733.1 753.7 777.2 862.9 874.7 884.9 14578.0 15261.0 15338.8 15407.1 15444.2 824.5 868.1 878.6 906.4 930.1 8034.8 8336.6 8400.1 8971.3 9660.8 465543.0 477814.0 482312.0 483116.0 484008.0 37898.6 37915.0 44922.0 52334.0 53339.0 1053.5 1060.3 1108.9 1120.3 1128.2 14494.7 14600.0 14626.9 14698.4 15000.2 32864.0 32949.8 33682.5 33702.7 34287.1 43133.0 44357.3 44480.8 44889.3 45622.0 8280.5 8414.8 8420.6 8430.7 8547.9 15007.2 15363.1 15418.5 15579.6 15920.7 12477.2 12979.9 13106.0 13419.6 14374.0 13240.7 13267.1 13336.7 13706.1 14022.5 13476.6 13521.0 13845.0 13876.7 13919.2 8563.9 8698.7 8750.0 8838.4 8846.2 12011.8 12937.1 13593.7 13938.9 14008.5 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,535 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4991.60 Median:6174.61 stddev:2613.15 (42.3%) stddev-sans-first:2605.23 16:29:16 INFO - 2015-12-02 16:29:16,536 DEBUG : BROWSER_OUTPUT: Values: 1236.8 1651.0 1684.9 1717.6 1718.6 6311.6 7106.3 7233.9 7251.8 7252.0 7099.5 7223.6 7244.9 7279.1 7284.0 2010.7 2041.6 2043.7 2046.8 2052.0 2083.9 2103.1 2108.7 2123.6 2132.1 2025.1 2072.8 2081.4 2100.1 2101.8 2071.5 2095.7 2097.5 2099.7 2100.8 2038.8 2086.6 2089.4 2092.1 2092.5 6023.3 6173.8 7190.7 7291.0 7295.7 3831.9 4021.6 4034.3 4034.6 4036.7 2632.8 2680.2 2735.1 2736.2 2737.8 815.9 825.8 830.7 830.7 841.3 9494.8 9657.7 9691.6 9701.2 9711.3 3822.4 3849.6 3894.6 3901.0 3901.6 8497.2 8499.2 8499.9 8502.6 8514.1 4195.6 4206.4 4227.0 4227.2 4231.6 3831.2 3838.1 3840.0 3850.4 3855.3 3295.8 3314.2 3336.2 3336.9 3342.1 1025.4 1038.9 1042.0 1046.1 1053.2 1192.3 1212.6 1213.5 1218.4 1232.6 6659.7 6857.6 6886.8 6889.7 6897.7 402.4 406.9 410.5 411.2 412.6 4930.6 5282.2 5291.3 5347.4 5352.7 7763.9 8113.0 8272.7 8283.1 8288.9 8228.7 8317.8 8334.2 8335.7 8338.3 6230.3 6469.9 6481.4 6501.2 6503.7 6772.4 6801.8 6842.3 6844.7 6866.1 7587.2 7679.7 7709.8 7714.3 7834.8 7853.1 7958.5 8024.9 8052.1 8063.2 6455.6 6469.5 6517.5 6609.7 6610.1 6925.0 7018.5 7040.1 7041.6 7052.5 6476.3 6633.6 6655.8 6692.1 6748.1 6464.3 6481.2 6538.1 6589.2 6611.3 6644.5 6737.5 6739.2 6742.7 6746.4 5636.2 6008.8 6014.5 6019.8 6022.5 6127.1 6163.4 6169.5 6174.2 6175.0 16:29:16 INFO - 2015-12-02 16:29:16,537 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,537 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4670.50 Median:5271.24 stddev:1366.74 (25.9%) stddev-sans-first:1330.57 16:29:16 INFO - 2015-12-02 16:29:16,538 DEBUG : BROWSER_OUTPUT: Values: 296.9 300.0 306.8 308.0 308.8 5290.9 5298.3 5347.5 5350.1 5361.8 5258.1 5284.4 5289.0 5295.7 5299.8 3950.8 4164.1 4167.5 4177.4 4178.6 4055.8 4079.4 4157.9 4181.9 4193.7 4121.4 4135.8 4139.2 4150.4 4157.3 3891.7 3987.6 4034.4 4114.5 4126.5 3627.2 3642.8 3650.5 3653.9 3655.5 5104.3 5107.3 5110.3 5125.2 5127.4 4745.1 4746.5 4755.2 4756.5 4760.9 5450.7 5560.6 5576.4 5589.8 5602.9 3967.6 3968.0 3971.0 3974.9 3976.5 5851.7 5853.9 5856.2 5859.7 5869.3 4071.2 4071.8 4076.7 4082.1 4087.5 4042.0 4151.1 4153.6 4157.1 4173.5 4681.1 4706.8 4716.5 4718.1 4719.0 5555.2 5563.3 5564.8 5565.6 5567.3 1456.4 1474.7 1476.5 1483.3 1484.5 1008.5 1016.9 1018.0 1029.1 1036.7 4936.1 4936.2 4942.2 4943.1 4953.3 5784.0 5794.0 5795.5 5797.1 5798.3 4936.5 4939.3 4943.1 4943.3 4944.2 3063.4 3084.0 3119.6 3124.9 3129.8 5599.5 5607.7 5611.5 5612.6 5615.0 6041.6 6046.7 6047.7 6050.0 6055.8 5499.9 5609.3 5615.4 5616.4 5619.1 5810.0 5857.1 5857.7 5858.2 5859.1 5727.3 5732.2 5734.6 5735.9 5743.0 5596.0 5596.6 5604.6 5607.0 5608.3 3949.0 3978.7 3996.8 4039.9 4045.6 5856.5 5858.6 5866.4 5869.8 5871.9 5633.5 5644.3 5646.5 5648.5 5652.9 5511.3 5636.3 5644.3 5646.7 5650.8 5517.9 5526.0 5527.3 5527.8 5528.4 5448.3 5589.7 5675.1 5687.8 5708.1 5348.6 5419.9 5423.6 5428.9 5431.5 16:29:16 INFO - 2015-12-02 16:29:16,538 DEBUG : BROWSER_OUTPUT: 16:29:16 INFO - 2015-12-02 16:29:16,538 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12350.35 Median:52941.84 stddev:14353.33 (27.1%) stddev-sans-first:14366.88 16:29:16 INFO - 2015-12-02 16:29:16,538 DEBUG : BROWSER_OUTPUT: Values: 688.8 712.7 756.0 787.7 792.6 11693.5 11961.2 11965.9 11967.4 11986.6 10112.8 11869.9 11960.1 11965.8 11980.3 598.9 800.1 822.4 824.1 824.7 814.4 814.6 820.0 822.9 823.2 649.8 659.8 843.1 850.2 850.7 834.1 844.3 845.6 846.3 847.0 625.8 626.3 626.7 627.0 627.2 11685.3 11759.8 11778.2 11813.1 11821.8 11045.4 11053.8 11403.9 11422.3 11840.9 8803.7 9704.3 9757.3 9876.1 9892.3 3193.4 3231.7 3242.9 3252.0 3252.9 42023.6 42130.6 42176.4 42316.6 42608.0 9116.4 9477.7 9549.6 9607.3 9612.7 16419.5 16666.7 16748.0 16759.5 16770.8 6426.3 6436.8 6477.1 6501.6 6623.8 3825.6 3840.2 3849.6 3863.4 3930.9 2742.8 2755.1 2758.7 2768.2 2782.4 508.9 517.6 520.4 520.8 527.1 535.7 573.5 573.6 589.6 636.5 7931.4 8246.0 8549.1 8631.4 8645.9 465.9 493.5 545.2 580.7 586.4 3649.6 3706.1 3763.3 3802.1 3812.8 52683.0 52775.5 52799.2 52929.2 52954.5 45521.8 45787.1 46031.0 46539.5 46667.5 41246.4 41709.6 41744.4 42454.6 42721.6 7197.7 7284.1 7303.4 7335.9 7420.5 31236.8 31331.2 31550.2 32436.5 32972.0 36613.6 36968.0 40392.0 40806.0 40916.2 9125.1 9131.1 9244.6 9300.4 9332.8 10341.1 10385.2 10421.6 10444.5 10769.8 9981.4 10007.9 10133.6 10172.1 10474.5 8526.3 8887.2 9118.3 9212.0 9758.3 9591.3 9623.7 9744.1 9862.9 10179.7 8365.7 8403.9 8568.3 8614.0 8677.6 8553.6 8704.0 8706.6 8800.6 8890.1 16:29:16 INFO - 2015-12-02 16:29:16,538 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:29:16 INFO - 2015-12-02 16:29:16,538 DEBUG : BROWSER_OUTPUT: 16:29:17 INFO - 2015-12-02 16:29:17,261 INFO : Browser exited with error code: 0 16:29:17 INFO - 2015-12-02 16:29:17,280 INFO : Completed test dromaeo_css (00:18:37) 16:29:17 INFO - 2015-12-02 16:29:17,280 INFO : Starting test kraken 16:29:17 INFO - 2015-12-02 16:29:17,280 DEBUG : operating with platform_type : linux_ 16:29:17 INFO - 2015-12-02 16:29:17,280 INFO : Initialising browser for kraken test... 16:29:17 INFO - 2015-12-02 16:29:17,286 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1byT_C/profile http://localhost:54346/getInfo.html 16:29:22 INFO - 2015-12-02 16:29:22,054 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:29:22 INFO - 2015-12-02 16:29:22,054 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:29:22 INFO - 2015-12-02 16:29:22,055 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:29:22 INFO - 2015-12-02 16:29:22,055 DEBUG : BROWSER_OUTPUT: __metrics 16:29:22 INFO - 2015-12-02 16:29:22,179 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:29:22 INFO - 2015-12-02 16:29:22,181 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:23 INFO - 2015-12-02 16:29:23,156 INFO : Browser initialized. 16:29:23 INFO - 2015-12-02 16:29:23,157 INFO : Running cycle 1/1 for kraken test... 16:29:23 INFO - 2015-12-02 16:29:23,157 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1byT_C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:29:35 INFO - 2015-12-02 16:29:35,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 143273984 16:29:35 INFO - 2015-12-02 16:29:35,160 DEBUG : BROWSER_OUTPUT: 16:29:37 INFO - 2015-12-02 16:29:37,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-beat-detection) 16:29:38 INFO - 2015-12-02 16:29:38,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 182628352 16:29:38 INFO - 2015-12-02 16:29:38,336 DEBUG : BROWSER_OUTPUT: 16:29:41 INFO - 2015-12-02 16:29:41,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-dft) 16:29:41 INFO - 2015-12-02 16:29:41,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 170487808 16:29:41 INFO - 2015-12-02 16:29:41,638 DEBUG : BROWSER_OUTPUT: 16:29:44 INFO - 2015-12-02 16:29:44,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-fft) 16:29:45 INFO - 2015-12-02 16:29:45,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 153067520 16:29:45 INFO - 2015-12-02 16:29:45,216 DEBUG : BROWSER_OUTPUT: 16:29:47 INFO - 2015-12-02 16:29:47,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-oscillator) 16:29:47 INFO - 2015-12-02 16:29:47,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 156684288 16:29:47 INFO - 2015-12-02 16:29:47,829 DEBUG : BROWSER_OUTPUT: 16:29:50 INFO - 2015-12-02 16:29:50,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:29:50 INFO - 2015-12-02 16:29:50,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 156401664 16:29:50 INFO - 2015-12-02 16:29:50,641 DEBUG : BROWSER_OUTPUT: 16:29:53 INFO - 2015-12-02 16:29:53,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54346/tests/kraken/driver.html?testName=imaging-darkroom) 16:29:54 INFO - 2015-12-02 16:29:54,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 156684288 16:29:54 INFO - 2015-12-02 16:29:54,212 DEBUG : BROWSER_OUTPUT: 16:29:57 INFO - 2015-12-02 16:29:57,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54346/tests/kraken/driver.html?testName=imaging-desaturate) 16:29:58 INFO - 2015-12-02 16:29:58,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 157532160 16:29:58 INFO - 2015-12-02 16:29:58,219 DEBUG : BROWSER_OUTPUT: 16:30:01 INFO - 2015-12-02 16:30:01,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54346/tests/kraken/driver.html?testName=json-parse-financial) 16:30:01 INFO - 2015-12-02 16:30:01,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 158990336 16:30:01 INFO - 2015-12-02 16:30:01,602 DEBUG : BROWSER_OUTPUT: 16:30:03 INFO - 2015-12-02 16:30:03,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:03 INFO - 2015-12-02 16:30:03,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 165986304 16:30:03 INFO - 2015-12-02 16:30:03,940 DEBUG : BROWSER_OUTPUT: 16:30:05 INFO - 2015-12-02 16:30:05,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:06 INFO - 2015-12-02 16:30:06,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 165720064 16:30:06 INFO - 2015-12-02 16:30:06,440 DEBUG : BROWSER_OUTPUT: 16:30:08 INFO - 2015-12-02 16:30:08,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:09 INFO - 2015-12-02 16:30:09,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 177336320 16:30:09 INFO - 2015-12-02 16:30:09,174 DEBUG : BROWSER_OUTPUT: 16:30:11 INFO - 2015-12-02 16:30:11,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:12 INFO - 2015-12-02 16:30:12,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 179867648 16:30:12 INFO - 2015-12-02 16:30:12,300 DEBUG : BROWSER_OUTPUT: 16:30:14 INFO - 2015-12-02 16:30:14,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:15 INFO - 2015-12-02 16:30:15,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 178741248 16:30:15 INFO - 2015-12-02 16:30:15,460 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54346/tests/kraken/driver.html?testName=ai-astar) 16:30:17 INFO - 2015-12-02 16:30:17,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 237834240 16:30:17 INFO - 2015-12-02 16:30:17,459 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,462 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:30:17 INFO - 2015-12-02 16:30:17,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:30:17 INFO - 2015-12-02 16:30:17,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:30:17 INFO - 2015-12-02 16:30:17,462 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;110;112;110;100;109;110;106 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;132;159;160;129;150;153;129;173;129 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;160;161;160;161;163;163;162 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;81;87;71;72;71;82;89;71 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;135;94;94;93;127;94;94;126 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;110;109;109;109;109 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;147;147;147;147;146;147 16:30:17 INFO - 2015-12-02 16:30:17,463 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;75;71;71;71;72;89;67;67 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;69;69;68;68;68 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;95;84;83;88;84;85;84;86;85 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;122;129;130;127;134;122;123;130;128 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;134;146;144;143;134;145;145;143;138 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;71;70;70;70;68;68;67;67 16:30:17 INFO - 2015-12-02 16:30:17,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:30:17 INFO - 2015-12-02 16:30:17,465 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:30:17 INFO - 2015-12-02 16:30:17,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,991 16:30:17 INFO - 2015-12-02 16:30:17,465 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:30:17 INFO - 2015-12-02 16:30:17,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1449102617461__endTimestamp 16:30:17 INFO - 2015-12-02 16:30:17,465 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,468 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:30:17 INFO - 2015-12-02 16:30:17,468 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:30:17 INFO - 2015-12-02 16:30:17,468 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:3.71 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 110.0 112.0 110.0 100.0 109.0 110.0 106.0 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:154.50 stddev:16.03 (10.4%) stddev-sans-first:16.67 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: Values: 156.0 132.0 159.0 160.0 129.0 150.0 153.0 129.0 173.0 129.0 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 160.0 161.0 160.0 161.0 163.0 163.0 162.0 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.60 Median:76.50 stddev:7.37 (9.6%) stddev-sans-first:7.53 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 81.0 87.0 71.0 72.0 71.0 82.0 89.0 71.0 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.00 stddev:17.11 (18.2%) stddev-sans-first:17.85 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 135.0 94.0 94.0 93.0 127.0 94.0 94.0 126.0 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,469 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:71.50 stddev:6.26 (8.8%) stddev-sans-first:6.64 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 75.0 71.0 71.0 71.0 72.0 89.0 67.0 67.0 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 68.0 68.0 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:3.59 (4.2%) stddev-sans-first:3.67 16:30:17 INFO - 2015-12-02 16:30:17,470 DEBUG : BROWSER_OUTPUT: Values: 83.0 95.0 84.0 83.0 88.0 84.0 85.0 84.0 86.0 85.0 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:128.50 stddev:4.88 (3.8%) stddev-sans-first:4.15 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: Values: 118.0 122.0 129.0 130.0 127.0 134.0 122.0 123.0 130.0 128.0 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:144.50 stddev:4.71 (3.3%) stddev-sans-first:4.74 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: Values: 146.0 134.0 146.0 144.0 143.0 134.0 145.0 145.0 143.0 138.0 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.48 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 71.0 70.0 70.0 70.0 68.0 68.0 67.0 67.0 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:30:17 INFO - 2015-12-02 16:30:17,471 DEBUG : BROWSER_OUTPUT: 16:30:18 INFO - 2015-12-02 16:30:18,321 INFO : Browser exited with error code: 0 16:30:18 INFO - 2015-12-02 16:30:18,377 INFO : Completed test kraken (00:01:01) 16:30:18 INFO - 2015-12-02 16:30:18,377 INFO : Starting test v8_7 16:30:18 INFO - 2015-12-02 16:30:18,377 DEBUG : operating with platform_type : linux_ 16:30:18 INFO - 2015-12-02 16:30:18,377 INFO : Initialising browser for v8_7 test... 16:30:18 INFO - 2015-12-02 16:30:18,384 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFiF0DP/profile http://localhost:54346/getInfo.html 16:30:23 INFO - 2015-12-02 16:30:23,236 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:30:23 INFO - 2015-12-02 16:30:23,236 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:30:23 INFO - 2015-12-02 16:30:23,236 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:30:23 INFO - 2015-12-02 16:30:23,236 DEBUG : BROWSER_OUTPUT: __metrics 16:30:23 INFO - 2015-12-02 16:30:23,385 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:30:23 INFO - 2015-12-02 16:30:23,386 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:30:24 INFO - 2015-12-02 16:30:24,389 INFO : Browser initialized. 16:30:24 INFO - 2015-12-02 16:30:24,389 INFO : Running cycle 1/1 for v8_7 test... 16:30:24 INFO - 2015-12-02 16:30:24,390 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFiF0DP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:30:36 INFO - 2015-12-02 16:30:36,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 143355904 16:30:36 INFO - 2015-12-02 16:30:36,356 DEBUG : BROWSER_OUTPUT: 16:30:57 INFO - 2015-12-02 16:30:57,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54346/tests/v8_7/run.html (next: http://localhost:54346/tests/v8_7/run.html) 16:30:58 INFO - 2015-12-02 16:30:58,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 447291392 16:30:58 INFO - 2015-12-02 16:30:58,005 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:30:58 INFO - 2015-12-02 16:30:58,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:30:58 INFO - 2015-12-02 16:30:58,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:30:58 INFO - 2015-12-02 16:30:58,006 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:30:58 INFO - 2015-12-02 16:30:58,007 DEBUG : BROWSER_OUTPUT: |0;Richards;166.9727834362999 16:30:58 INFO - 2015-12-02 16:30:58,007 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.9796522382538 16:30:58 INFO - 2015-12-02 16:30:58,007 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 16:30:58 INFO - 2015-12-02 16:30:58,007 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 16:30:58 INFO - 2015-12-02 16:30:58,008 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 16:30:58 INFO - 2015-12-02 16:30:58,008 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 16:30:58 INFO - 2015-12-02 16:30:58,008 DEBUG : BROWSER_OUTPUT: |6;Boyer;11976.190476190477 16:30:58 INFO - 2015-12-02 16:30:58,008 DEBUG : BROWSER_OUTPUT: |7;RegExp;26789.473684210527 16:30:58 INFO - 2015-12-02 16:30:58,008 DEBUG : BROWSER_OUTPUT: |8;Splay;616.9031462060457 16:30:58 INFO - 2015-12-02 16:30:58,008 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:30:58 INFO - 2015-12-02 16:30:58,009 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:30:58 INFO - 2015-12-02 16:30:58,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1449102658004__endTimestamp 16:30:58 INFO - 2015-12-02 16:30:58,009 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,009 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:30:58 INFO - 2015-12-02 16:30:58,009 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:30:58 INFO - 2015-12-02 16:30:58,010 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,010 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,010 DEBUG : BROWSER_OUTPUT: Values: 167.0 16:30:58 INFO - 2015-12-02 16:30:58,010 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,010 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.98 Median:184.98 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,010 DEBUG : BROWSER_OUTPUT: Values: 185.0 16:30:58 INFO - 2015-12-02 16:30:58,011 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,011 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,011 DEBUG : BROWSER_OUTPUT: Values: 277.8 16:30:58 INFO - 2015-12-02 16:30:58,011 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,011 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: Values: 5175.3 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: Values: 1990.1 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,012 DEBUG : BROWSER_OUTPUT: Values: 783.1 16:30:58 INFO - 2015-12-02 16:30:58,013 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,013 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,013 DEBUG : BROWSER_OUTPUT: Values: 11976.2 16:30:58 INFO - 2015-12-02 16:30:58,013 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,013 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26789.47 Median:26789.47 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,013 DEBUG : BROWSER_OUTPUT: Values: 26789.5 16:30:58 INFO - 2015-12-02 16:30:58,014 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,014 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.90 Median:616.90 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,014 DEBUG : BROWSER_OUTPUT: Values: 616.9 16:30:58 INFO - 2015-12-02 16:30:58,014 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,014 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:30:58 INFO - 2015-12-02 16:30:58,014 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:30:58 INFO - 2015-12-02 16:30:58,015 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:30:58 INFO - 2015-12-02 16:30:58,015 DEBUG : BROWSER_OUTPUT: 16:30:58 INFO - 2015-12-02 16:30:58,917 INFO : Browser exited with error code: 0 16:30:58 INFO - 2015-12-02 16:30:58,930 INFO : Completed test v8_7 (00:00:40) 16:30:59 INFO - 2015-12-02 16:30:59,048 INFO : Completed test suite (00:20:19) 16:30:59 INFO - 2015-12-02 16:30:59,048 DEBUG : Working with test: dromaeo_css 16:30:59 INFO - 2015-12-02 16:30:59,049 DEBUG : Generating results file: dromaeo_css 16:30:59 INFO - 2015-12-02 16:30:59,050 DEBUG : Working with test: kraken 16:30:59 INFO - 2015-12-02 16:30:59,050 DEBUG : Generating results file: kraken 16:30:59 INFO - 2015-12-02 16:30:59,050 INFO : javascript benchmark 16:30:59 INFO - 2015-12-02 16:30:59,050 DEBUG : Working with test: v8_7 16:30:59 INFO - 2015-12-02 16:30:59,050 DEBUG : Generating results file: v8_7 16:30:59 INFO - 2015-12-02 16:30:59,051 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:30:59 INFO - 2015-12-02 16:30:59,120 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 16:30:59 INFO - 2015-12-02 16:30:59,121 DEBUG : process_Request line: dromaeo_css 6237.76 graph.html#tests=[[72,132,35]] 16:30:59 INFO - 2015-12-02 16:30:59,121 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:30:59 INFO - 2015-12-02 16:30:59,157 DEBUG : process_Request line: kraken 1511.80 graph.html#tests=[[232,132,35]] 16:30:59 INFO - 2015-12-02 16:30:59,157 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:30:59 INFO - 2015-12-02 16:30:59,192 DEBUG : process_Request line: v8_7 19829.81 graph.html#tests=[[230,132,35]] 16:30:59 INFO - 2015-12-02 16:30:59,194 INFO : javascript benchmark 16:30:59 INFO - 2015-12-02 16:30:59,197 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2589.3138318345636, 2670.0387860370265, 2688.1397952655147, 2698.0421950207688, 2701.2301494074186, 4587.839425620104, 4640.698354606948, 4706.917408995929, 4731.834385796497, 4736.12381709384, 4571.51999040101, 4602.5857672809525, 4651.813927442899, 4656.394668693065, 4674.789634466449, 4294.398784170203, 4318.503372112208, 4352.042550638855, 4353.434053573031, 4380.145871555048, 4127.339625659895, 4403.933940990888, 4408.0, 4458.576435238663, 4463.70985885918, 4217.915641687149, 4298.16185843759, 4319.870403887889, 4320.351947207912, 4327.307630779092, 4321.65426765858, 4330.480342358906, 4340.327249276367, 4345.326474396474, 4369.519352871182, 4315.8057887394825, 4317.028668549583, 4325.740455572675, 4351.912961740779, 4370.4318438603095, 4381.189479946188, 4473.731576105444, 4490.730556166608, 4536.387587675687, 4666.323383109464, 4992.400911890596, 5071.1632580624155, 5073.137566613685, 5073.34046573943, 5110.821121260775, 5083.79664813407, 5085.694858308476, 5085.720285384303, 5088.363954505687, 5090.465501122366, 4560.475545312298, 4661.580457758818, 4680.134175177569, 4684.0, 4685.1800934836265, 5134.794608215704, 5145.408278048072, 5149.433562308143, 5152.896942061137, 5190.195519694454, 4942.258661200777, 4944.505549445099, 4944.950550494521, 4952.801887924443, 4997.100521906019, 4771.856844294677, 4863.708177509361, 4877.609791216694, 5031.371078615173, 5040.017196646619, 4858.198397264412, 4913.87715307113, 4922.409310882717, 4943.307936888838, 4952.059108769322, 4938.209886418228, 4960.280759289955, 4982.676126051795, 4990.051890140934, 5032.521910418504, 4021.155557332993, 4199.517055538591, 4205.642520385802, 4205.9789701051295, 4237.618614324726, 3559.964400356015, 3603.4594810778594, 3623.0942264433893, 3628.111112777334, 3657.908552286214, 4322.308430651081, 4357.847475338348, 4363.738175709467, 4365.192439398721, 4404.317330813729, 4848.539388758062, 5062.7468626568525, 5066.36670416198, 5067.923981140286, 5094.566961808214, 4210.7473551587, 4222.514410842731, 4244.575542445792, 4246.087091275391, 4252.87241382759, 4482.417285752831, 4484.798184081724, 4492.505824359318, 4501.054778496552, 4518.638508919278, 4843.806247750051, 4844.249141383091, 4844.539768721966, 4850.902981940341, 4874.000829829805, 4761.428628564595, 4878.317035615088, 4880.145974454527, 5043.9747801260755, 5056.216286475602, 4682.321063445713, 4765.571098601143, 4766.0, 4771.856844294677, 4810.254410566367, 4959.62802789785, 4964.131277026579, 4965.1311020571975, 4966.0, 5006.449290577961, 4813.5186481352985, 4882.36529251195, 4938.703677779345, 5043.697378157322, 5081.745912704424, 4753.714777113384, 4818.156822555969, 4829.6860704054125, 4840.951590484191, 4877.195262781602, 4855.927161092516, 4878.756062196947, 4880.560749532559, 4882.170031094652, 4888.92666609994, 4606.861794146181, 4692.389989301369, 4695.154872123051, 4793.9041219176115, 4815.374001379798, 4824.903501930012, 4894.437139728977, 4899.069176856386, 4910.680805747615, 4949.0, 4798.3762110926755, 4819.2530157825595, 4840.1287768200655, 4848.903021939612, 4890.193118135468], "unit": "ms", "name": "dojo.html", "value": 4588.869331535244}, {"lowerIsBetter": false, "replicates": [528.8492779557824, 549.5466240351711, 561.1022364217253, 574.72413241644, 586.5659412035095, 27712.584311235347, 28318.150455486342, 33575.16062098452, 33793.324133517315, 34198.829005855, 35985.280294394164, 36402.27195456089, 36571.26857462849, 36607.90176294709, 36710.0, 7039.155301363843, 7934.365250779938, 8104.1085480597085, 8107.189281071905, 8111.229433203836, 7123.8219044523785, 10271.0, 10539.0, 10544.314619549705, 10548.0, 10115.19078473724, 10189.235807314444, 10235.641752538662, 10237.283390162691, 10245.97540245977, 10118.898811011906, 10146.391216527032, 10228.232882533764, 10239.641612543524, 10241.641542546013, 10038.0, 10181.236407269484, 10183.796324073477, 10186.796264074752, 10189.898101019044, 34529.13677158066, 34536.30927381438, 34763.30473390543, 34772.65227347719, 34797.30405391903, 2885.841278729669, 3004.1438190115714, 3265.9346813063607, 3532.4701294805727, 3538.6638269364626, 27593.0, 27646.170614881383, 28305.531341627793, 28310.0, 28636.427271454664, 3203.823789691566, 3235.4014507316224, 3268.7711860169798, 3304.5208444775612, 3347.56481657383, 209368.0, 210856.0, 211191.0, 211421.0, 211713.99999999846, 49839.25241121386, 51151.23273150906, 54331.72834135804, 54644.18033729497, 54659.72670136624, 57291.71354143203, 58075.70962145162, 58110.0, 58111.70944145252, 58160.0, 13410.798838017437, 13703.314834258446, 13706.931465342808, 13711.862881371058, 13717.657058573415, 9970.202383809277, 10058.094771470456, 10095.293329467013, 10099.596016159418, 10101.292909496411, 18648.906755466134, 18918.621627567372, 18945.147468363957, 18965.62068758617, 18995.715064274045, 7268.527545709618, 7457.888131678029, 7459.142198647117, 7474.7757567273065, 7535.886961695579, 863.8574635185249, 866.5537248317122, 898.9460632362079, 930.0095398400816, 935.0742764662934, 26808.59787103195, 27666.308342291602, 27981.0, 28054.579181312296, 28076.85961570179, 911.2300106410073, 925.2181906289175, 940.2759874896292, 1014.3102690170755, 1045.8744950605824, 13078.346082695827, 13175.209487430784, 13216.471341146438, 13259.403326850315, 14230.28848557568, 201689.0, 204354.0, 205722.0, 206065.0, 207345.0, 41081.178376432305, 41164.58835411607, 41370.1725965479, 41445.58554414478, 41449.58550414517, 1236.9876301237052, 1240.1443004327166, 1246.1962034487524, 1252.511520507003, 1265.6203139058246, 25294.494110118063, 26079.608805868305, 27194.184174474798, 27627.86186069057, 27703.861480693275, 37364.43953340757, 37631.0, 37660.43509347417, 37683.0, 37756.0, 171313.0, 172605.13697431432, 172866.0, 172926.13536932738, 173085.13457433137, 24273.63589546123, 25018.249452516455, 26828.0, 28450.715492844807, 29474.263143421587, 33422.66577334293, 33622.49566256557, 33797.83101084577, 34022.0, 34511.65488345185, 29216.7078329214, 29656.55515167231, 29830.403391932476, 30097.0, 31324.216894577818, 24687.506249874543, 29737.0, 31794.205144870637, 31868.203294917814, 32361.676383235867, 29825.25436864096, 30130.24674383158, 30150.69849301479, 30464.69535304707, 30501.389972199988, 27219.59170612482, 28009.0, 29424.852875735483, 29516.262093447836, 29815.0, 23176.652350214423, 23185.261105416823, 23227.419314517272, 23374.181903633293, 23510.41223969346], "unit": "ms", "name": "ext.html", "value": 16497.386459142337}, {"lowerIsBetter": false, "replicates": [331.51598665947716, 332.0205394087442, 332.03874782504636, 332.77371387456526, 333.69300243775723, 12448.875511244907, 12680.302583357934, 14778.113313201215, 15219.162946037963, 15517.379304827808, 9530.380525265853, 9535.0, 9558.044195580438, 13200.27398493085, 15846.76229856553, 4441.0, 4543.727376357413, 4544.795484203219, 4559.156556037127, 4565.201089809287, 3337.0823023668563, 3440.4839274108836, 4612.331211974261, 4977.5022497750115, 5069.847904562869, 5110.872228194287, 5112.718800465973, 5141.280220769096, 5148.74256287186, 5150.1759718445055, 5047.614767319344, 5094.5160209780015, 5106.183010718286, 5109.4379618241965, 5130.948690513122, 4884.340614017097, 4909.852704418873, 4935.851924442272, 4938.061768264019, 4952.281919121707, 11194.160437967104, 12814.679633009157, 18760.34338798149, 19450.27696122544, 19474.123664435134, 1783.0193393633579, 1890.1494327552657, 1890.6029733755927, 1894.8010458901892, 1898.3450709505198, 9023.187913087853, 12044.939775301067, 12489.250644961241, 12638.0, 12895.484180632764, 1718.707819670659, 1755.1079093888347, 1756.4203812741891, 1758.9824101758948, 1796.6855800234907, 55536.44463555353, 58242.7087864558, 58444.0, 58654.120188196786, 58851.41148588502, 9357.766055848522, 9679.274054445945, 9693.806123877624, 9757.316987810786, 9770.804583908282, 12395.256284622952, 12474.064445166649, 12476.0, 12509.249445033327, 12530.185537940004, 6951.061606683134, 6958.79123626292, 7071.257517960643, 7118.537295075804, 7142.607156606333, 6625.337466253336, 6652.268250492442, 6660.533762636665, 6700.028495868072, 6736.730530778812, 4096.0, 4156.147989662112, 4171.395147703566, 4210.547361160456, 4211.43145675336, 1597.456864666019, 1663.6256842210405, 1687.3885439405337, 1723.9051852148252, 1733.0884114687447, 753.7211231844253, 777.1723114882632, 862.9395942283979, 874.7200895713311, 884.920357167858, 14578.0, 15261.0, 15338.769918451233, 15407.075575465507, 15444.150571718663, 824.5392426970063, 868.1101870582577, 878.5826732302105, 906.4425378392373, 930.0559931669361, 8034.839303213903, 8336.62485188168, 8400.075991640915, 8971.32715046361, 9660.806783864284, 465543.0, 477814.0, 482312.0, 483116.0, 484008.0, 37898.62101379006, 37915.0, 44922.0, 52334.0, 53339.0, 1053.5259133389852, 1060.2790102730216, 1108.9223754337281, 1120.2886167283834, 1128.1651577832508, 14494.710105798036, 14600.0, 14626.926865365605, 14698.41206351734, 15000.2499875008, 32864.0, 32949.83525082359, 33682.49476257809, 33702.662973370934, 34287.14282142966, 43133.0, 44357.33463997978, 44480.77759611181, 44889.32666009947, 45622.0, 8280.50316980983, 8414.831703365777, 8420.578971051546, 8430.747077587683, 8547.871781923152, 15007.249637517862, 15363.088009674802, 15418.537443876701, 15579.610509737347, 15920.681586368439, 12477.188982716458, 12979.870201297867, 13106.0, 13419.597412077654, 14374.0, 13240.735185296433, 13267.137636053625, 13336.733265334446, 13706.109102908278, 14022.525027808611, 13476.595702128952, 13521.0, 13845.030847840555, 13876.653083672989, 13919.164850109026, 8563.914360856312, 8698.652053918026, 8750.0, 8838.381313308008, 8846.15961483658, 12011.75976480483, 12937.09440339205, 13593.66015849572, 13938.93030534841, 14008.509702160376], "unit": "ms", "name": "jquery.html", "value": 8030.6636420021105}, {"lowerIsBetter": false, "replicates": [1236.7959286717692, 1650.9834901650984, 1684.941027064053, 1717.6221231329107, 1718.6219031813005, 6311.621302721835, 7106.2538433464515, 7233.891491627616, 7251.782446526599, 7252.0, 7099.503034787554, 7223.566586004843, 7244.891326630105, 7279.053723016001, 7284.0, 2010.7285516455274, 2041.5508588110665, 2043.7240972468749, 2046.7850875658064, 2051.9589608207825, 2083.8645488043303, 2103.0956688623887, 2108.652072408051, 2123.57528494301, 2132.1471411435396, 2025.0684685044896, 2072.7823578524262, 2081.354780018199, 2100.1494394770143, 2101.8108370246673, 2071.5028393185676, 2095.6646936490165, 2097.496600815793, 2099.6640537513927, 2100.7899210078945, 2038.7553493580865, 2086.5722526881955, 2089.40451971189, 2092.110852887532, 2092.5082605587677, 6023.277206735176, 6173.81478555644, 7190.712371505134, 7290.963545182293, 7295.744648937315, 3831.9233615327817, 4021.577734337882, 4034.253663072341, 4034.616711412411, 4036.7174297799165, 2632.802539809503, 2680.1825443239804, 2735.0700761740904, 2736.179146256135, 2737.8220415672918, 815.8939337886096, 825.8205907257072, 830.7341650671788, 830.7466222802043, 841.3311417423163, 9494.762630934212, 9657.661981830603, 9691.612335506501, 9701.223902087817, 9711.320207585472, 3822.369309063973, 3849.615038496128, 3894.6494815466745, 3900.9804950975063, 3901.5903330150495, 8497.192766687154, 8499.235068843835, 8499.872501912476, 8502.574871256413, 8514.14858514156, 4195.643370313496, 4206.41110244566, 4226.978865105655, 4227.154569086134, 4231.619154276068, 3831.1571454280015, 3838.05967537955, 3840.0399900024995, 3850.383938569815, 3855.2867719471988, 3295.752818538619, 3314.2377253231894, 3336.232666486673, 3336.9332613347597, 3342.1143396999814, 1025.3591505309182, 1038.9428581428094, 1042.0, 1046.1212581431482, 1053.1890444357955, 1192.3382522699985, 1212.6483319837148, 1213.4539457244275, 1218.3725381428571, 1232.6240496648609, 6659.733610655519, 6857.622830744357, 6886.793396198122, 6889.724411023603, 6897.655117244118, 402.3722992132283, 406.92878746219293, 410.45614560707185, 411.2453647556767, 412.57298695849653, 4930.556249937523, 5282.234076059027, 5291.312129423227, 5347.358317001985, 5352.678839269656, 7763.883541746878, 8113.0, 8272.669093236324, 8283.08886022537, 8288.92244008275, 8228.670853165806, 8317.750467485985, 8334.249917507454, 8335.749927502186, 8338.332933365316, 6230.345813689588, 6469.935300647027, 6481.384268494486, 6501.1548498694865, 6503.674816259168, 6772.424343930821, 6801.829954251183, 6842.281560436082, 6844.691988860413, 6866.141732283465, 7587.203343648837, 7679.69281228767, 7709.807254818675, 7714.344280735976, 7834.804129896798, 7853.136155023057, 7958.522488650699, 8024.879626805719, 8052.074011488754, 8063.19368063189, 6455.580387274812, 6469.45009674183, 6517.543771935919, 6609.735610575523, 6610.140681711347, 6924.99587559791, 7018.473614478832, 7040.0847889774, 7041.647917604202, 7052.541584796972, 6476.255230648348, 6633.6019838809825, 6655.833604159935, 6692.096566963398, 6748.055272261985, 6464.321246269262, 6481.157449531531, 6538.051982462422, 6589.17635295588, 6611.272759996493, 6644.534882558368, 6737.494687898526, 6739.191297044386, 6742.696578653874, 6746.426553742791, 5636.154576813511, 6008.819735407945, 6014.488768454556, 6019.849503762441, 6022.45797878193, 6127.050307202391, 6163.35284795108, 6169.50643948474, 6174.228221472316, 6175.0], "unit": "ms", "name": "mootools.html", "value": 4016.823911438237}, {"lowerIsBetter": false, "replicates": [296.9005383196629, 299.9745021673158, 306.82970951122127, 307.9645840728317, 308.8008234688626, 5290.894182116355, 5298.284731561238, 5347.46525347466, 5350.117230656937, 5361.812336568221, 5258.106121959267, 5284.365876094865, 5289.047971365153, 5295.708736019517, 5299.834036511961, 3950.8222130004074, 4164.12553363794, 4167.499900012002, 4177.436046133771, 4178.56125106864, 4055.8377664893515, 4079.388091786241, 4157.937630935538, 4181.895452613679, 4193.748375097489, 4121.361189015693, 4135.793210339471, 4139.19285739281, 4150.356694712309, 4157.334826427772, 3891.7470364426504, 3987.641112299907, 4034.435179074932, 4114.506259248894, 4126.463559737245, 3627.2382799612114, 3642.817859107034, 3650.4889315495852, 3653.926921461556, 3655.5430571178604, 5104.259882317043, 5107.284980102789, 5110.259012443212, 5125.154349532323, 5127.410347810012, 4745.1221524018165, 4746.525347465225, 4755.167845627036, 4756.500567440438, 4760.880977975544, 5450.672959622435, 5560.610757246995, 5576.386597474275, 5589.832305030855, 5602.887942241173, 3967.6032396760384, 3967.960320396788, 3971.0, 3974.940375894364, 3976.522817261918, 5851.736671849777, 5853.912191317177, 5856.180134781134, 5859.707014649251, 5869.266341707286, 4071.1654110907193, 4071.816768245436, 4076.735012224196, 4082.1223436961195, 4087.4686290782006, 4041.959580404217, 4151.14901445203, 4153.646940010072, 4157.064660451374, 4173.457450531411, 4681.110588988081, 4706.811727530929, 4716.481187069419, 4718.103560323596, 4719.0, 5555.166724991283, 5563.332400112013, 5564.805231816867, 5565.582581306418, 5567.3040869891265, 1456.3592019511382, 1474.6903150338335, 1476.5275111964283, 1483.2880217495663, 1484.4730120807174, 1008.4705529596873, 1016.8576399303955, 1017.9592816287413, 1029.130384824822, 1036.7149034015706, 4936.062148191904, 4936.160852655057, 4942.20924652054, 4943.085529177114, 4953.306537084811, 5784.045632470596, 5793.971030144822, 5795.478406943311, 5797.130430435384, 5798.304203495608, 4936.531029552187, 4939.259111133359, 4943.110240156806, 4943.332650092263, 4944.208926571731, 3063.387322535502, 3084.0, 3119.610048743907, 3124.937501249962, 3129.7809153359503, 5599.468050535193, 5607.719614019365, 5611.523020543218, 5612.607117501736, 5615.0, 6041.637501749821, 6046.697665116727, 6047.697615119315, 6050.0, 6055.788047418319, 5499.890221752118, 5609.298837645294, 5615.410381909923, 5616.410276920946, 5619.072852979294, 5810.0, 5857.062869940789, 5857.736401862012, 5858.209141765807, 5859.121131830089, 5727.284089488814, 5732.16883551891, 5734.627249228787, 5735.913961290667, 5743.0, 5596.048671725735, 5596.580256480699, 5604.635698679573, 5607.046802043581, 5608.298962629671, 3948.953527315321, 3978.661813745864, 3996.8001599919307, 4039.91920161601, 4045.6358927696647, 5856.472917437451, 5858.648481091148, 5866.384029676822, 5869.8239052828485, 5871.911921321098, 5633.464820842178, 5644.266245388073, 5646.548276137982, 5648.491635752802, 5652.886942261214, 5511.338639363302, 5636.2954630671165, 5644.266245388073, 5646.689432081275, 5650.830475085754, 5517.917231241454, 5526.0, 5527.309086364205, 5527.778888844401, 5528.364238112668, 5448.291722076105, 5589.664620122806, 5675.120356344773, 5687.829365119053, 5708.086706127, 5348.5988550858065, 5419.918701219563, 5423.566114710735, 5428.91856622143, 5431.4840090191365], "unit": "ms", "name": "prototype.html", "value": 4234.030864067037}, {"lowerIsBetter": false, "replicates": [688.7761477519806, 712.6864179760905, 755.9735409260675, 787.6770524085123, 792.5561685456148, 11693.473793679284, 11961.22252053617, 11965.940170299136, 11967.401629918491, 11986.64040078798, 10112.797744045114, 11869.881301186986, 11960.102992275572, 11965.76068478632, 11980.34108124053, 598.8832177725345, 800.1198681450417, 822.3544517553721, 824.1470078468786, 824.7278398128633, 814.4421071565966, 814.5886327404652, 820.0487434575894, 822.8601137806558, 823.1562648285525, 649.8342922554742, 659.7789740436959, 843.0684094076049, 850.2475309351238, 850.6809946270149, 834.05751500804, 844.3287586368882, 845.5560830564003, 846.3018010141597, 847.0216899481109, 625.8122563231012, 626.2547568393597, 626.6678660310043, 626.962382257066, 627.1752645271454, 11685.298882067103, 11759.764804703858, 11778.234414763014, 11813.1140164488, 11821.763564728657, 11045.447727613588, 11053.778924421547, 11403.942980285046, 11422.31466112036, 11840.940795295968, 8803.735887923373, 9704.320697551175, 9757.316987810857, 9876.111149996535, 9892.25808064398, 3193.409219294415, 3231.7091461768555, 3242.91892702682, 3251.951220731691, 3252.902412927616, 42023.57976420258, 42130.578694213276, 42176.36735448971, 42316.57683423188, 42607.95224453672, 9116.359055370098, 9477.668281610111, 9549.61801527945, 9607.327487075838, 9612.711618651452, 16419.507414777574, 16666.666666666843, 16748.0, 16759.497215083567, 16770.832291677172, 6426.336175045458, 6436.806895793134, 6477.125588045647, 6501.642409667514, 6623.801285961333, 3825.5600605930676, 3840.2127563849344, 3849.576546579874, 3863.4204869269834, 3930.9017274568364, 2742.780577553791, 2755.1321333779797, 2758.724127587225, 2768.197222805404, 2782.4156927045547, 508.92874997500377, 517.6169634470465, 520.4405264340849, 520.8125074973007, 527.1118165890487, 535.6839464715837, 573.5010540829421, 573.6070791507831, 589.5755056359415, 636.4749082007362, 7931.365490760725, 8245.95877020623, 8549.145085491402, 8631.43895646781, 8645.870311945326, 465.8998315362213, 493.45226798253907, 545.1958361416879, 580.7009390164069, 586.4253032028636, 3649.59854416014, 3706.127750993002, 3763.284975854579, 3802.1065049713297, 3812.8093595320124, 52683.0, 52775.47224527782, 52799.208011879855, 52929.2060619091, 52954.47045529573, 45521.772391137834, 45787.084258314644, 46031.0, 46539.534604654196, 46667.53332466632, 41246.38130428046, 41709.58290417118, 41744.37383439251, 42454.57545424506, 42721.57278427176, 7197.676104575202, 7284.125904891447, 7303.379212766762, 7335.889961650473, 7420.5176663516695, 31236.843815780776, 31331.216719582193, 31550.211244718146, 32436.513452297764, 32972.0, 36613.633863662086, 36968.0, 40392.0, 40806.0, 40916.18167636571, 9125.13311235458, 9131.13254240846, 9244.583993720164, 9300.441973481613, 9332.766680833034, 10341.121004714683, 10385.22110841705, 10421.635242766466, 10444.529996150039, 10769.838452423377, 9981.401115933068, 10007.934933544817, 10133.645322413975, 10172.08451239392, 10474.476276186313, 8526.317894568543, 8887.244584210415, 9118.270538356783, 9211.953940230256, 9758.268129890428, 9591.328606997444, 9623.663171788954, 9744.12302892743, 9862.901370986485, 10179.7455063624, 8365.665373384996, 8403.873941890753, 8568.314534837073, 8613.966324040905, 8677.566121693764, 8553.61508732121, 8703.956480217812, 8706.60820263077, 8800.603972821367, 8890.066543013148], "unit": "ms", "name": "yui.html", "value": 5696.659421321248}], "name": "dromaeo_css", "value": 6237.76382351708}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 110.0, 112.0, 110.0, 100.0, 109.0, 110.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [156.0, 132.0, 159.0, 160.0, 129.0, 150.0, 153.0, 129.0, 173.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 81.0, 87.0, 71.0, 72.0, 71.0, 82.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 76.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 135.0, 94.0, 94.0, 93.0, 127.0, 94.0, 94.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 75.0, 71.0, 71.0, 71.0, 72.0, 89.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 95.0, 84.0, 83.0, 88.0, 84.0, 85.0, 84.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 129.0, 130.0, 127.0, 134.0, 122.0, 123.0, 130.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [146.0, 134.0, 146.0, 144.0, 143.0, 134.0, 145.0, 145.0, 143.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 71.0, 70.0, 70.0, 70.0, 68.0, 68.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1511.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [184.9796522382538], "unit": "score", "name": "DeltaBlue", "value": 357.43390799999986}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [26789.473684210527], "unit": "score", "name": "RegExp", "value": 34.0053339882122}, {"lowerIsBetter": false, "replicates": [616.9031462060457], "unit": "score", "name": "Splay", "value": 132.096911}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19829.8136569842}]} 16:30:59 INFO - RETURN: dromaeo_css: 6237.76 16:30:59 INFO - RETURN: kraken: 1511.80 16:30:59 INFO - RETURN: v8_7: 19829.81 16:30:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19829.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1511.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6237.76"}}} 16:30:59 INFO - Return code: 0 16:30:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:30:59 INFO - # TBPL SUCCESS # 16:30:59 INFO - Running post-action listener: _resource_record_post_action 16:30:59 INFO - Running post-run listener: _resource_record_post_run 16:31:00 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505733120; Read time: 12; Write time: 749736 16:31:00 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 230404096; Read time: 0; Write time: 517812 16:31:00 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274907136; Read time: 12; Write time: 231880 16:31:00 INFO - Running post-run listener: _upload_blobber_files 16:31:00 INFO - Blob upload gear active. 16:31:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:31:00 INFO - Copying logs to upload dir... 16:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.665298 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-02 16:31:00.267488) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 16:31:00.271516) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009931 build_url: 'https://queue.taskcluster.net/v1/task/K0aR0LrvRvaEySYND_uwrg/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-02 16:31:00.322864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:31:00.323257) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1449100889.143048-1340618696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 16:31:00.373168) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 16:31:00.373512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 16:31:00.373877) ========= ========= Total master_lag: 0.23 =========