builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1449074793.49 results: success (0) buildid: 20151202081125 builduid: 2d4a60abb67d4260b6001ad0556bb3c4 revision: 2ec770d354e53708be3887e8e678ce21866d7a8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.490167) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.490578) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.490858) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.514416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.514688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.533411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.533653) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.584775) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.585037) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.585402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.585672) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 08:46:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-02 08:46:34 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.219354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.826572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.827023) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015532 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.883098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.883432) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec770d354e53708be3887e8e678ce21866d7a8e --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 2ec770d354e53708be3887e8e678ce21866d7a8e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 08:46:34,179 truncating revision to first 12 chars 2015-12-02 08:46:34,179 Setting DEBUG logging. 2015-12-02 08:46:34,179 attempt 1/10 2015-12-02 08:46:34,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2ec770d354e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 08:46:34,667 unpacking tar archive at: fx-team-2ec770d354e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:34.693212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:34.693573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:34.701933) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:34.702180) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:34.702660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-02 08:46:34.702951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:35 INFO - MultiFileLogger online at 20151202 08:46:35 in /builds/slave/test 08:46:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:46:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:35 INFO - {'append_to_log': False, 08:46:35 INFO - 'base_work_dir': '/builds/slave/test', 08:46:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:46:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:35 INFO - 'branch': 'Fx-Team-Non-PGO', 08:46:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:35 INFO - 'config_files': ('talos/linux_config.py',), 08:46:35 INFO - 'default_actions': ('clobber', 08:46:35 INFO - 'read-buildbot-config', 08:46:35 INFO - 'download-and-extract', 08:46:35 INFO - 'populate-webroot', 08:46:35 INFO - 'create-virtualenv', 08:46:35 INFO - 'install', 08:46:35 INFO - 'run-tests'), 08:46:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:35 INFO - 'download_minidump_stackwalk': True, 08:46:35 INFO - 'download_symbols': 'ondemand', 08:46:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:35 INFO - 'installer_path': 'installer.exe', 08:46:35 INFO - 'log_level': 'info', 08:46:35 INFO - 'log_name': 'talos', 08:46:35 INFO - 'log_to_console': True, 08:46:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:35 INFO - 'opt_config_files': (), 08:46:35 INFO - 'pip_index': False, 08:46:35 INFO - 'sps_profile': False, 08:46:35 INFO - 'sps_profile_interval': 0, 08:46:35 INFO - 'suite': 'dromaeojs-e10s', 08:46:35 INFO - 'system_bits': '64', 08:46:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:35 INFO - 'title': 'talos-linux64-ix-019', 08:46:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:35 INFO - 'use_talos_json': True, 08:46:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:35 INFO - 'work_dir': 'build'} 08:46:35 INFO - ##### 08:46:35 INFO - ##### Running clobber step. 08:46:35 INFO - ##### 08:46:35 INFO - Running pre-action listener: _resource_record_pre_action 08:46:35 INFO - Running main action method: clobber 08:46:35 INFO - rmtree: /builds/slave/test/build 08:46:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:36 INFO - Running post-action listener: _resource_record_post_action 08:46:36 INFO - ##### 08:46:36 INFO - ##### Running read-buildbot-config step. 08:46:36 INFO - ##### 08:46:36 INFO - Running pre-action listener: _resource_record_pre_action 08:46:36 INFO - Running main action method: read_buildbot_config 08:46:36 INFO - Using buildbot properties: 08:46:36 INFO - { 08:46:36 INFO - "properties": { 08:46:36 INFO - "buildnumber": 498, 08:46:36 INFO - "product": "firefox", 08:46:36 INFO - "script_repo_revision": "production", 08:46:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:46:36 INFO - "repository": "", 08:46:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:46:36 INFO - "buildid": "20151202081125", 08:46:36 INFO - "slavename": "talos-linux64-ix-019", 08:46:36 INFO - "pgo_build": "False", 08:46:36 INFO - "basedir": "/builds/slave/test", 08:46:36 INFO - "project": "", 08:46:36 INFO - "platform": "ubuntu64_hw", 08:46:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:46:36 INFO - "slavebuilddir": "test", 08:46:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:46:36 INFO - "branch": "fx-team", 08:46:36 INFO - "repo_path": "integration/fx-team", 08:46:36 INFO - "stage_platform": "linux64", 08:46:36 INFO - "builduid": "2d4a60abb67d4260b6001ad0556bb3c4", 08:46:36 INFO - "revision": "2ec770d354e53708be3887e8e678ce21866d7a8e" 08:46:36 INFO - }, 08:46:36 INFO - "sourcestamp": { 08:46:36 INFO - "repository": "", 08:46:36 INFO - "hasPatch": false, 08:46:36 INFO - "project": "", 08:46:36 INFO - "branch": "fx-team-linux64-talos", 08:46:36 INFO - "changes": [ 08:46:36 INFO - { 08:46:36 INFO - "category": null, 08:46:36 INFO - "files": [ 08:46:36 INFO - { 08:46:36 INFO - "url": null, 08:46:36 INFO - "name": "https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:46:36 INFO - } 08:46:36 INFO - ], 08:46:36 INFO - "repository": "", 08:46:36 INFO - "rev": "2ec770d354e53708be3887e8e678ce21866d7a8e", 08:46:36 INFO - "who": "mbanner@mozilla.com", 08:46:36 INFO - "when": 1449074733, 08:46:36 INFO - "number": 6733541, 08:46:36 INFO - "comments": "Bug 1229471 - LoopUI shouldn't try to use toolbar buttons in the hidden window. r=mikedeboer", 08:46:36 INFO - "project": "", 08:46:36 INFO - "at": "Wed 02 Dec 2015 08:45:33", 08:46:36 INFO - "branch": "fx-team-linux64-talos", 08:46:36 INFO - "revlink": "", 08:46:36 INFO - "properties": [ 08:46:36 INFO - [ 08:46:36 INFO - "buildid", 08:46:36 INFO - "20151202081125", 08:46:36 INFO - "Change" 08:46:36 INFO - ], 08:46:36 INFO - [ 08:46:36 INFO - "builduid", 08:46:36 INFO - "2d4a60abb67d4260b6001ad0556bb3c4", 08:46:36 INFO - "Change" 08:46:36 INFO - ], 08:46:36 INFO - [ 08:46:36 INFO - "pgo_build", 08:46:36 INFO - "False", 08:46:36 INFO - "Change" 08:46:36 INFO - ] 08:46:36 INFO - ], 08:46:36 INFO - "revision": "2ec770d354e53708be3887e8e678ce21866d7a8e" 08:46:36 INFO - } 08:46:36 INFO - ], 08:46:36 INFO - "revision": "2ec770d354e53708be3887e8e678ce21866d7a8e" 08:46:36 INFO - } 08:46:36 INFO - } 08:46:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:46:36 INFO - Running post-action listener: _resource_record_post_action 08:46:36 INFO - ##### 08:46:36 INFO - ##### Running download-and-extract step. 08:46:36 INFO - ##### 08:46:36 INFO - Running pre-action listener: _resource_record_pre_action 08:46:36 INFO - Running main action method: download_and_extract 08:46:36 INFO - mkdir: /builds/slave/test/build/tests 08:46:36 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')]} 08:46:36 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json 08:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json 08:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:46:37 INFO - Downloaded 1302 bytes. 08:46:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:46:37 INFO - Using the following test package requirements: 08:46:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'jsshell-linux-x86_64.zip'], 08:46:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46:37 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')]} 08:46:37 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:40 INFO - Downloaded 21774978 bytes. 08:46:40 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 08:46:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:40 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 08:46:41 INFO - Return code: 0 08:46:41 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 08:46: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')]} 08:46:41 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:50 INFO - Downloaded 21774978 bytes. 08:46:50 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 08:46:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:50 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 08:46:51 INFO - Return code: 0 08:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:51 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:52 INFO - Downloaded 11132001 bytes. 08:46:52 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 08:46:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:52 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 08:46:52 INFO - Return code: 0 08:46:52 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')]} 08:46:52 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/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 08:46:53 INFO - Downloaded 57675869 bytes. 08:46:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:53 INFO - mkdir: /builds/slave/test/properties 08:46:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:53 INFO - Contents: 08:46:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:53 INFO - Running post-action listener: _resource_record_post_action 08:46:53 INFO - Running post-action listener: set_extra_try_arguments 08:46:53 INFO - ##### 08:46:53 INFO - ##### Running populate-webroot step. 08:46:53 INFO - ##### 08:46:53 INFO - Running pre-action listener: _resource_record_pre_action 08:46:53 INFO - Running main action method: populate_webroot 08:46:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:46:53 INFO - '../fennec_ids.txt'], 08:46:53 INFO - 'tests': ['tcheck2']}, 08:46:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:53 INFO - '--tppagecycles', 08:46:53 INFO - '7'], 08:46:53 INFO - 'tests': ['tsvgm']}}, 08:46:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:46:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:46:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:46:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'tests': ['damp', 'tps']}, 08:46:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['damp', 'tps']}, 08:46:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:46:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:53 INFO - 'other': {'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore']}, 08:46:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore']}, 08:46:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore']}, 08:46:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore']}, 08:46:53 INFO - 'other_l64': {'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore']}, 08:46:53 INFO - 'other_nol64': {'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore']}, 08:46:53 INFO - 'svgr': {'tests': ['tsvgx', 08:46:53 INFO - 'tsvgr_opacity', 08:46:53 INFO - 'tart', 08:46:53 INFO - 'tscrollx', 08:46:53 INFO - 'cart']}, 08:46:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['tsvgx', 08:46:53 INFO - 'tsvgr_opacity', 08:46:53 INFO - 'tart', 08:46:53 INFO - 'tscrollx', 08:46:53 INFO - 'cart']}, 08:46:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'tests': ['tp5o']}, 08:46:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--e10s'], 08:46:53 INFO - 'tests': ['tp5o']}, 08:46:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--xperf_path', 08:46:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:53 INFO - 'tests': ['tp5n']}, 08:46:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--e10s', 08:46:53 INFO - '--xperf_path', 08:46:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:53 INFO - 'tests': ['tp5n']}}, 08:46:53 INFO - 'talos.zip': {'path': '', 08:46:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:53 INFO - Running post-action listener: _resource_record_post_action 08:46:53 INFO - ##### 08:46:53 INFO - ##### Running create-virtualenv step. 08:46:53 INFO - ##### 08:46:53 INFO - Running pre-action listener: _resource_record_pre_action 08:46:53 INFO - Running main action method: create_virtualenv 08:46:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:53 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 08:46:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:53 INFO - Using real prefix '/usr' 08:46:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:56 INFO - Installing pip.................done. 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:46:56 INFO - Using env: {'DISPLAY': ':0', 08:46:56 INFO - 'HOME': '/home/cltbld', 08:46:56 INFO - 'LANG': 'en_US.UTF-8', 08:46:56 INFO - 'LANGUAGE': 'en_US:en', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MAIL': '/var/mail/cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SHLVL': '1', 08:46:56 INFO - 'TERM': 'linux', 08:46:56 INFO - 'TMOUT': '86400', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 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 08:46:56 INFO - Cleaning up... 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:46:56 INFO - Using env: {'DISPLAY': ':0', 08:46:56 INFO - 'HOME': '/home/cltbld', 08:46:56 INFO - 'LANG': 'en_US.UTF-8', 08:46:56 INFO - 'LANGUAGE': 'en_US:en', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MAIL': '/var/mail/cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SHLVL': '1', 08:46:56 INFO - 'TERM': 'linux', 08:46:56 INFO - 'TMOUT': '86400', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Downloading/unpacking psutil>=0.7.1 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:46:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:58 INFO - Installing collected packages: psutil 08:46:58 INFO - Running setup.py install for psutil 08:46:58 INFO - building 'psutil._psutil_linux' extension 08:46:58 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 08:46:58 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 08:46:59 INFO - building 'psutil._psutil_posix' extension 08:46:59 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 08:46:59 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 08:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:59 INFO - Successfully installed psutil 08:46:59 INFO - Cleaning up... 08:46:59 INFO - Return code: 0 08:46:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:59 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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:46:59 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 08:46:59 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 08:46:59 INFO - Using env: {'DISPLAY': ':0', 08:46:59 INFO - 'HOME': '/home/cltbld', 08:46:59 INFO - 'LANG': 'en_US.UTF-8', 08:46:59 INFO - 'LANGUAGE': 'en_US:en', 08:46:59 INFO - 'LOGNAME': 'cltbld', 08:46:59 INFO - 'MAIL': '/var/mail/cltbld', 08:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:59 INFO - 'MOZ_NO_REMOTE': '1', 08:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:59 INFO - 'NO_EM_RESTART': '1', 08:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:59 INFO - 'PWD': '/builds/slave/test', 08:46:59 INFO - 'SHELL': '/bin/bash', 08:46:59 INFO - 'SHLVL': '1', 08:46:59 INFO - 'TERM': 'linux', 08:46:59 INFO - 'TMOUT': '86400', 08:46:59 INFO - 'USER': 'cltbld', 08:46:59 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:59 INFO - '_': '/tools/buildbot/bin/python'} 08:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:46:59 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 08:46:59 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 08:46:59 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 08:46:59 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 08:46:59 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 08:46:59 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 08:47:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:47:01 INFO - Installing collected packages: mozsystemmonitor 08:47:01 INFO - Running setup.py install for mozsystemmonitor 08:47:01 INFO - Successfully installed mozsystemmonitor 08:47:01 INFO - Cleaning up... 08:47:01 INFO - Return code: 0 08:47:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:47:01 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 08:47:01 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 08:47:01 INFO - Using env: {'DISPLAY': ':0', 08:47:01 INFO - 'HOME': '/home/cltbld', 08:47:01 INFO - 'LANG': 'en_US.UTF-8', 08:47:01 INFO - 'LANGUAGE': 'en_US:en', 08:47:01 INFO - 'LOGNAME': 'cltbld', 08:47:01 INFO - 'MAIL': '/var/mail/cltbld', 08:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:01 INFO - 'MOZ_NO_REMOTE': '1', 08:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:01 INFO - 'NO_EM_RESTART': '1', 08:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:01 INFO - 'PWD': '/builds/slave/test', 08:47:01 INFO - 'SHELL': '/bin/bash', 08:47:01 INFO - 'SHLVL': '1', 08:47:01 INFO - 'TERM': 'linux', 08:47:01 INFO - 'TMOUT': '86400', 08:47:01 INFO - 'USER': 'cltbld', 08:47:01 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:01 INFO - '_': '/tools/buildbot/bin/python'} 08:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:01 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 08:47:01 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 08:47:01 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 08:47:01 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 08:47:01 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 08:47:01 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 08:47:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:03 INFO - Downloading docopt-0.6.1.tar.gz 08:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:03 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:03 INFO - Running setup.py install for blobuploader 08:47:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:04 INFO - Running setup.py install for requests 08:47:04 INFO - Running setup.py install for docopt 08:47:04 INFO - Successfully installed blobuploader requests docopt 08:47:04 INFO - Cleaning up... 08:47:04 INFO - Return code: 0 08:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:04 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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:47:04 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 08:47:04 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 08:47:04 INFO - Using env: {'DISPLAY': ':0', 08:47:04 INFO - 'HOME': '/home/cltbld', 08:47:04 INFO - 'LANG': 'en_US.UTF-8', 08:47:04 INFO - 'LANGUAGE': 'en_US:en', 08:47:04 INFO - 'LOGNAME': 'cltbld', 08:47:04 INFO - 'MAIL': '/var/mail/cltbld', 08:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:04 INFO - 'MOZ_NO_REMOTE': '1', 08:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:04 INFO - 'NO_EM_RESTART': '1', 08:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:04 INFO - 'PWD': '/builds/slave/test', 08:47:04 INFO - 'SHELL': '/bin/bash', 08:47:04 INFO - 'SHLVL': '1', 08:47:04 INFO - 'TERM': 'linux', 08:47:04 INFO - 'TMOUT': '86400', 08:47:04 INFO - 'USER': 'cltbld', 08:47:04 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:04 INFO - '_': '/tools/buildbot/bin/python'} 08:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:04 INFO - Running setup.py (path:/tmp/pip-GxzuuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:04 INFO - Running setup.py (path:/tmp/pip-gC5ygY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:04 INFO - Running setup.py (path:/tmp/pip-ZwjLAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:05 INFO - Running setup.py (path:/tmp/pip-E7qYzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:05 INFO - Running setup.py (path:/tmp/pip-NAB5w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:05 INFO - Running setup.py (path:/tmp/pip-ku61Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:05 INFO - Running setup.py (path:/tmp/pip-1auax5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:05 INFO - Running setup.py (path:/tmp/pip-lOMOHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:05 INFO - Running setup.py (path:/tmp/pip-XcwJh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:05 INFO - Running setup.py (path:/tmp/pip-Nh1Ray-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:05 INFO - Running setup.py (path:/tmp/pip-gzoLo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:05 INFO - Running setup.py (path:/tmp/pip-4PRewo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:05 INFO - Running setup.py (path:/tmp/pip-sMMfgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:05 INFO - Running setup.py (path:/tmp/pip-IGlVm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:05 INFO - Running setup.py (path:/tmp/pip-7WBeDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:05 INFO - Running setup.py (path:/tmp/pip-nHddFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:05 INFO - Running setup.py (path:/tmp/pip-K5eDls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:06 INFO - Running setup.py install for manifestparser 08:47:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Running setup.py install for mozcrash 08:47:06 INFO - Running setup.py install for mozdebug 08:47:06 INFO - Running setup.py install for mozdevice 08:47:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Running setup.py install for mozfile 08:47:06 INFO - Running setup.py install for mozhttpd 08:47:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Running setup.py install for mozinfo 08:47:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Running setup.py install for mozInstall 08:47:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:06 INFO - Running setup.py install for mozleak 08:47:06 INFO - Running setup.py install for mozlog 08:47:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for moznetwork 08:47:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozprocess 08:47:07 INFO - Running setup.py install for mozprofile 08:47:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozrunner 08:47:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Running setup.py install for mozscreenshot 08:47:07 INFO - Running setup.py install for moztest 08:47:07 INFO - Running setup.py install for mozversion 08:47:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:07 INFO - Cleaning up... 08:47:07 INFO - Return code: 0 08:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:07 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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:47:07 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 08:47:07 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 08:47:07 INFO - Using env: {'DISPLAY': ':0', 08:47:07 INFO - 'HOME': '/home/cltbld', 08:47:07 INFO - 'LANG': 'en_US.UTF-8', 08:47:07 INFO - 'LANGUAGE': 'en_US:en', 08:47:07 INFO - 'LOGNAME': 'cltbld', 08:47:07 INFO - 'MAIL': '/var/mail/cltbld', 08:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:07 INFO - 'MOZ_NO_REMOTE': '1', 08:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:07 INFO - 'NO_EM_RESTART': '1', 08:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:07 INFO - 'PWD': '/builds/slave/test', 08:47:07 INFO - 'SHELL': '/bin/bash', 08:47:07 INFO - 'SHLVL': '1', 08:47:07 INFO - 'TERM': 'linux', 08:47:07 INFO - 'TMOUT': '86400', 08:47:07 INFO - 'USER': 'cltbld', 08:47:07 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:07 INFO - '_': '/tools/buildbot/bin/python'} 08:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:07 INFO - Running setup.py (path:/tmp/pip-8KSg4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:08 INFO - Running setup.py (path:/tmp/pip-rvdNUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:08 INFO - Running setup.py (path:/tmp/pip-9dBFzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:08 INFO - Running setup.py (path:/tmp/pip-XekZSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:08 INFO - Running setup.py (path:/tmp/pip-zt583U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:08 INFO - Running setup.py (path:/tmp/pip-7ZD5zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:08 INFO - Running setup.py (path:/tmp/pip-QMFGKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:08 INFO - Running setup.py (path:/tmp/pip-VXqQta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:08 INFO - Running setup.py (path:/tmp/pip-I3fKif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:08 INFO - Running setup.py (path:/tmp/pip-xzHpW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:08 INFO - Running setup.py (path:/tmp/pip-CQG4fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:08 INFO - Running setup.py (path:/tmp/pip-CqxPcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:08 INFO - Running setup.py (path:/tmp/pip-6Ndcyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:08 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)) 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:08 INFO - Running setup.py (path:/tmp/pip-z2FpHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:09 INFO - Running setup.py (path:/tmp/pip-rDMYpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:09 INFO - Running setup.py (path:/tmp/pip-mF8APQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:09 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)) 08:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:09 INFO - Running setup.py (path:/tmp/pip-WltKOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:09 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)) 08:47:09 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)) 08:47:09 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)) 08:47:09 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)) 08:47:09 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)) 08:47:09 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)) 08:47:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:09 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 08:47:09 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 08:47:09 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 08:47:09 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 08:47:09 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 08:47:09 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 08:47:10 INFO - Downloading blessings-1.5.1.tar.gz 08:47:10 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 08:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:10 INFO - Installing collected packages: blessings 08:47:10 INFO - Running setup.py install for blessings 08:47:11 INFO - Successfully installed blessings 08:47:11 INFO - Cleaning up... 08:47:11 INFO - Return code: 0 08:47:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:11 INFO - Reading from file tmpfile_stdout 08:47:11 INFO - Current package versions: 08:47:11 INFO - argparse == 1.2.1 08:47:11 INFO - blessings == 1.5.1 08:47:11 INFO - blobuploader == 1.2.4 08:47:11 INFO - docopt == 0.6.1 08:47:11 INFO - manifestparser == 1.1 08:47:11 INFO - mozInstall == 1.12 08:47:11 INFO - mozcrash == 0.16 08:47:11 INFO - mozdebug == 0.1 08:47:11 INFO - mozdevice == 0.47 08:47:11 INFO - mozfile == 1.2 08:47:11 INFO - mozhttpd == 0.7 08:47:11 INFO - mozinfo == 0.9 08:47:11 INFO - mozleak == 0.1 08:47:11 INFO - mozlog == 3.1 08:47:11 INFO - moznetwork == 0.27 08:47:11 INFO - mozprocess == 0.22 08:47:11 INFO - mozprofile == 0.27 08:47:11 INFO - mozrunner == 6.11 08:47:11 INFO - mozscreenshot == 0.1 08:47:11 INFO - mozsystemmonitor == 0.0 08:47:11 INFO - moztest == 0.7 08:47:11 INFO - mozversion == 1.4 08:47:11 INFO - psutil == 3.1.1 08:47:11 INFO - requests == 1.2.3 08:47:11 INFO - wsgiref == 0.1.2 08:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:11 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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:47:11 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 08:47:11 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 08:47:11 INFO - Using env: {'DISPLAY': ':0', 08:47:11 INFO - 'HOME': '/home/cltbld', 08:47:11 INFO - 'LANG': 'en_US.UTF-8', 08:47:11 INFO - 'LANGUAGE': 'en_US:en', 08:47:11 INFO - 'LOGNAME': 'cltbld', 08:47:11 INFO - 'MAIL': '/var/mail/cltbld', 08:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:11 INFO - 'MOZ_NO_REMOTE': '1', 08:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:11 INFO - 'NO_EM_RESTART': '1', 08:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:11 INFO - 'PWD': '/builds/slave/test', 08:47:11 INFO - 'SHELL': '/bin/bash', 08:47:11 INFO - 'SHLVL': '1', 08:47:11 INFO - 'TERM': 'linux', 08:47:11 INFO - 'TMOUT': '86400', 08:47:11 INFO - 'USER': 'cltbld', 08:47:11 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:11 INFO - '_': '/tools/buildbot/bin/python'} 08:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 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)) 08:47:11 INFO - Cleaning up... 08:47:11 INFO - Return code: 0 08:47:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:11 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 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:47:11 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 08:47:11 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 08:47:11 INFO - Using env: {'DISPLAY': ':0', 08:47:11 INFO - 'HOME': '/home/cltbld', 08:47:11 INFO - 'LANG': 'en_US.UTF-8', 08:47:11 INFO - 'LANGUAGE': 'en_US:en', 08:47:11 INFO - 'LOGNAME': 'cltbld', 08:47:11 INFO - 'MAIL': '/var/mail/cltbld', 08:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:11 INFO - 'MOZ_NO_REMOTE': '1', 08:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:11 INFO - 'NO_EM_RESTART': '1', 08:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:11 INFO - 'PWD': '/builds/slave/test', 08:47:11 INFO - 'SHELL': '/bin/bash', 08:47:11 INFO - 'SHLVL': '1', 08:47:11 INFO - 'TERM': 'linux', 08:47:11 INFO - 'TMOUT': '86400', 08:47:11 INFO - 'USER': 'cltbld', 08:47:11 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:11 INFO - '_': '/tools/buildbot/bin/python'} 08:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:11 INFO - Downloading/unpacking jsonschema 08:47:11 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 08:47:11 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 08:47:11 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 08:47:11 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 08:47:11 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 08:47:11 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 08:47:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:13 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 08:47:13 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:13 INFO - warning: no files found matching '*.txt' 08:47:13 INFO - no previously-included directories found matching 'build' 08:47:13 INFO - no previously-included directories found matching 'dist' 08:47:13 INFO - no previously-included directories found matching '.git*' 08:47:13 INFO - Installing collected packages: jsonschema, functools32 08:47:13 INFO - Running setup.py install for functools32 08:47:13 INFO - warning: no files found matching '*.txt' 08:47:13 INFO - no previously-included directories found matching 'build' 08:47:13 INFO - no previously-included directories found matching 'dist' 08:47:13 INFO - no previously-included directories found matching '.git*' 08:47:13 INFO - Successfully installed jsonschema functools32 08:47:13 INFO - Cleaning up... 08:47:13 INFO - Return code: 0 08:47:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f425758cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', '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 08:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:47:13 INFO - Using env: {'DISPLAY': ':0', 08:47:13 INFO - 'HOME': '/home/cltbld', 08:47:13 INFO - 'LANG': 'en_US.UTF-8', 08:47:13 INFO - 'LANGUAGE': 'en_US:en', 08:47:13 INFO - 'LOGNAME': 'cltbld', 08:47:13 INFO - 'MAIL': '/var/mail/cltbld', 08:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:13 INFO - 'MOZ_NO_REMOTE': '1', 08:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:13 INFO - 'NO_EM_RESTART': '1', 08:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:13 INFO - 'PWD': '/builds/slave/test', 08:47:13 INFO - 'SHELL': '/bin/bash', 08:47:13 INFO - 'SHLVL': '1', 08:47:13 INFO - 'TERM': 'linux', 08:47:13 INFO - 'TMOUT': '86400', 08:47:13 INFO - 'USER': 'cltbld', 08:47:13 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:13 INFO - '_': '/tools/buildbot/bin/python'} 08:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:14 INFO - Downloading/unpacking flake8 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:15 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 08:47:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:15 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 08:47:15 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 08:47:15 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 08:47:15 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 08:47:15 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 08:47:15 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 08:47:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:16 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 08:47:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:16 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 08:47:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:16 INFO - no previously-included directories found matching 'docs/_build' 08:47:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:16 INFO - Running setup.py install for pep8 08:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:16 INFO - no previously-included directories found matching 'docs/_build' 08:47:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:16 INFO - Cleaning up... 08:47:16 INFO - Return code: 0 08:47:16 INFO - Running post-action listener: _resource_record_post_action 08:47:16 INFO - Running post-action listener: _start_resource_monitoring 08:47:16 INFO - Starting resource monitoring. 08:47:16 INFO - ##### 08:47:16 INFO - ##### Running install step. 08:47:16 INFO - ##### 08:47:16 INFO - Running pre-action listener: _resource_record_pre_action 08:47:16 INFO - Running main action method: install 08:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:16 INFO - Reading from file tmpfile_stdout 08:47:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:17 INFO - Reading from file tmpfile_stdout 08:47:17 INFO - Output received: 08:47:17 INFO - Usage: mozinstall [options] installer 08:47:17 INFO - Options: 08:47:17 INFO - -h, --help show this help message and exit 08:47:17 INFO - -d DEST, --destination=DEST 08:47:17 INFO - Directory to install application into. [default: 08:47:17 INFO - "/builds/slave/test"] 08:47:17 INFO - --app=APP Application being installed. [default: firefox] 08:47:17 INFO - mkdir: /builds/slave/test/build/application 08:47:17 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'] 08:47:17 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 08:47:31 INFO - Reading from file tmpfile_stdout 08:47:31 INFO - Output received: 08:47:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:31 INFO - Running post-action listener: _resource_record_post_action 08:47:31 INFO - ##### 08:47:31 INFO - ##### Running run-tests step. 08:47:31 INFO - ##### 08:47:31 INFO - Running pre-action listener: _resource_record_pre_action 08:47:31 INFO - Running main action method: run_tests 08:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:31 INFO - Python 2.7.3 08:47:31 INFO - Return code: 0 08:47:31 INFO - grabbing minidump binary from tooltool 08:47:31 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')]} 08:47:31 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 0x234b0b0>, '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 0x234bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:31 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 08:47:31 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 08:47:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:31 INFO - Return code: 0 08:47:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:32 INFO - Return code: 0 08:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 08:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 08:47:32 INFO - Using env: {'DISPLAY': ':0', 08:47:32 INFO - 'HOME': '/home/cltbld', 08:47:32 INFO - 'LANG': 'en_US.UTF-8', 08:47:32 INFO - 'LANGUAGE': 'en_US:en', 08:47:32 INFO - 'LOGNAME': 'cltbld', 08:47:32 INFO - 'MAIL': '/var/mail/cltbld', 08:47:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:32 INFO - 'MOZ_NO_REMOTE': '1', 08:47:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:32 INFO - 'NO_EM_RESTART': '1', 08:47:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:32 INFO - 'PWD': '/builds/slave/test', 08:47:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:32 INFO - 'SHELL': '/bin/bash', 08:47:32 INFO - 'SHLVL': '1', 08:47:32 INFO - 'TERM': 'linux', 08:47:32 INFO - 'TMOUT': '86400', 08:47:32 INFO - 'USER': 'cltbld', 08:47:32 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060', 08:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:32 INFO - '_': '/tools/buildbot/bin/python'} 08:47:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 08:47:32 INFO - mozversion INFO | application_buildid: 20151202081125 08:47:32 INFO - mozversion INFO | application_changeset: 2ec770d354e53708be3887e8e678ce21866d7a8e 08:47:32 INFO - mozversion INFO | application_display_name: Nightly 08:47:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:32 INFO - mozversion INFO | application_name: Firefox 08:47:32 INFO - mozversion INFO | application_remotingname: firefox 08:47:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:47:32 INFO - mozversion INFO | application_vendor: Mozilla 08:47:32 INFO - mozversion INFO | application_version: 45.0a1 08:47:32 INFO - mozversion INFO | platform_buildid: 20151202081125 08:47:32 INFO - mozversion INFO | platform_changeset: 2ec770d354e53708be3887e8e678ce21866d7a8e 08:47:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:47:32 INFO - mozversion INFO | platform_version: 45.0a1 08:47:32 INFO - 2015-12-02 08:47:32,804 DEBUG : using testdate: 1449074852 08:47:32 INFO - 2015-12-02 08:47:32,804 DEBUG : actual date: 1449074852 08:47:32 INFO - 2015-12-02 08:47:32,815 INFO : starting webserver on 'localhost:57305' 08:47:32 INFO - 2015-12-02 08:47:32,816 INFO : Starting test suite talos-linux64-ix-019.e 08:47:32 INFO - 2015-12-02 08:47:32,816 INFO : Starting test dromaeo_css 08:47:32 INFO - 2015-12-02 08:47:32,816 DEBUG : operating with platform_type : linux_ 08:47:32 INFO - 2015-12-02 08:47:32,816 INFO : Initialising browser for dromaeo_css test... 08:47:32 INFO - 2015-12-02 08:47:32,833 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLobzxn/profile http://localhost:57305/getInfo.html 08:47:37 INFO - 2015-12-02 08:47:37,823 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:47:37 INFO - 2015-12-02 08:47:37,823 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:47:37 INFO - 2015-12-02 08:47:37,823 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:47:37 INFO - 2015-12-02 08:47:37,823 DEBUG : BROWSER_OUTPUT: __metrics 08:47:37 INFO - 2015-12-02 08:47:37,944 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] 08:47:38 INFO - 2015-12-02 08:47:38,871 INFO : Browser initialized. 08:47:38 INFO - 2015-12-02 08:47:38,871 INFO : Running cycle 1/1 for dromaeo_css test... 08:47:38 INFO - 2015-12-02 08:47:38,871 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLobzxn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:47:50 INFO - 2015-12-02 08:47:50,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 143482880 08:47:50 INFO - 2015-12-02 08:47:50,903 DEBUG : BROWSER_OUTPUT: 08:48:40 INFO - 2015-12-02 08:48:40,533 DEBUG : BROWSER_OUTPUT: 1449074920532 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] 08:50:52 INFO - 2015-12-02 08:50:52,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57305/tests/dromaeo/cssquery-ext.html) 08:50:53 INFO - 2015-12-02 08:50:53,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 146468864 08:50:53 INFO - 2015-12-02 08:50:53,185 DEBUG : BROWSER_OUTPUT: 08:53:55 INFO - 2015-12-02 08:53:55,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/dromaeo/cssquery-ext.html (next: http://localhost:57305/tests/dromaeo/cssquery-jquery.html) 08:53:55 INFO - 2015-12-02 08:53:55,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 144166912 08:53:55 INFO - 2015-12-02 08:53:55,865 DEBUG : BROWSER_OUTPUT: 08:56:57 INFO - 2015-12-02 08:56:57,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57305/tests/dromaeo/cssquery-mootools.html) 08:56:58 INFO - 2015-12-02 08:56:58,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 145862656 08:56:58 INFO - 2015-12-02 08:56:58,259 DEBUG : BROWSER_OUTPUT: 08:59:59 INFO - 2015-12-02 08:59:59,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57305/tests/dromaeo/cssquery-prototype.html) 09:00:00 INFO - 2015-12-02 09:00:00,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 144744448 09:00:00 INFO - 2015-12-02 09:00:00,599 DEBUG : BROWSER_OUTPUT: 09:03:03 INFO - 2015-12-02 09:03:03,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57305/tests/dromaeo/cssquery-yui.html) 09:03:03 INFO - 2015-12-02 09:03:03,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 145174528 09:03:03 INFO - 2015-12-02 09:03:03,850 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/dromaeo/cssquery-yui.html (next: http://localhost:57305/tests/dromaeo/cssquery-dojo.html) 09:06:06 INFO - 2015-12-02 09:06:06,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 147853312 09:06:06 INFO - 2015-12-02 09:06:06,502 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,502 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:06:06 INFO - 2015-12-02 09:06:06,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:06:06 INFO - 2015-12-02 09:06:06,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:06:06 INFO - 2015-12-02 09:06:06,502 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:06:06 INFO - 2015-12-02 09:06:06,502 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2648.3379155211196;2671.051776619299;2710.2953232159643;2722.9727702722967;2728.0451841855347;4567.58891699747;4700.506446823081;4709.788059537324;4744.97627511862;4746.288056791479;4627.514111018345;4691.554302341281;4723.669343145981;4727.05458908218;4734.692245004081;4369.541198174194;4410.492793328776;4438.866833994985;4452.821887124511;4463.107378524292;4461.910761784762;4471.66462515311;4534.8639540813665;4545.090981803636;4580.656450766206;4169.478815148092;4273.52991170974;4279.1013887083745;4363.738175709436;4382.802773875183;4374.9781251093855;4379.60574567554;4379.605835474823;4391.407160033386;4442.355858400514;4202.453681021479;4355.760433176174;4369.584889435499;4399;4424.358468022118;4502.2571275739465;4552.408186935711;4553.726776393427;4636.374089497942;4667.206574882244;5060.620453465968;5067.467915868854;5099.4390617032095;5103;5113.2330150477355;4938.62960277977;5056.089903817311;5107.131787596118;5126.179811230185;5145.99653067652;4651.90680190155;4711.387519622495;4718.622510199176;4721.102990431807;4756.048790241931;5201.5838732901275;5217.139172036647;5221.216817477332;5235.3717553893775;5267.815626453055;4777.450593181759;4876.536729010738;4926.852194434173;5024.698518088926;5032.84901452957;5106.795728170831;5115.360579927509;5119.6160287978555;5120.769565369567;5183.118869792144;5040.46564018087;5042.697438153649;5044.369453818273;5058.317127187856;5073.822416215415;4722.268048452495;4876.073546026244;4928.531789479994;5021.648484606042;5029.06962211992;4163.3130533462245;4185.665146788249;4192.517860446027;4205.1589682063095;4235.788210589458;3669.43123815809;3680.3191409589313;3690.225052738901;3703.9074023149637;3713.145976425383;4197.349410841324;4249.596288352602;4307.461567304087;4355.847545335898;4418.4918734345965;5082.898342033139;5107.8723031923755;5139.537441630271;5156.04613146569;5205.817796377109;4240.978795106004;4426.734395936254;4432.49026361966;4437.8224871004795;4481.2381895077915;4350.651947844165;4383.057642606855;4404.66964977628;4432.933505997413;4455.799489023002;4887.95112048882;4913.385826771653;4920.286558449076;4921.729304888266;4923.753812309298;4881.463039065629;4958.801647934042;5141.170252022049;5156.1492353761205;5213.009528189784;4790.7844147012775;4806.158922188673;4873.829415970424;4876.683015604116;4915.729634869974;5013.072581572421;5043.4956504349275;5049.520295571915;5050;5062.670926389773;4911.140550403737;4948.802047918043;5005.649604527648;5120.590352771844;5157.6647517911215;4974.253861920741;4995.900081998267;4998.850034498971;5014;5036.949630503795;4969.701817890938;4994.1509943309;4995.125852975787;5006.449290578106;5021.146405111067;4617.907641847211;4706.341112244357;4718.5753282203395;4889.413270407574;4932.482089380707;4960.082384758831;4970.080535101018;4980.028894365709;4984.2025275955675;4994.375703037121;4803.879903002453;4814.903701925872;4846.588040016638;4857;4881.243407271879 09:06:06 INFO - 2015-12-02 09:06:06,503 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.3701454371103;576.7894718427775;584.3922320786382;589.0575079872204;596.880623875225;35915;37001.62998370016;37024.62975370246;37063.81468092659;37389;39512.407313890246;39878.80060599693;39991.200175996535;40325.7983710081;40393.39409908854;7902.170272121431;7984.960075199645;7990.161033091529;8002.319802816767;8067.63695633695;7808.570528620923;7907.327877130451;7968.641411136513;7981.201879812031;8007;7752.689892404325;7809.023872015998;7812.921870781276;7816.296533312001;7838.608069596526;7936.24605662464;8003.399745019117;8014.358851291882;8033.036035675727;8033.236842499953;7807.180246074194;7959.323457506119;7967.681292748283;7998.880016799752;8016;36028.27943441143;36872;36917.815410923045;36920.26159476822;36954;3066.2947522069826;3151.9054428367185;3364.96635033649;3431.1422144463886;3651.1967367179445;27277.318067048283;27318.45363092727;27388.726112738816;27540.311492212855;27953.440931181467;3255.625603055655;3258.7067163955358;3266.869325226988;3290.8848190313224;3296.8021918684717;218624;219781;220922;220999;221571;38061.80969095137;43141.35287970683;43286.134277314275;43303.35044974328;43370.56629433728;37247.441288380694;37528.81235593805;37545.24909501795;37566;37594.43608345877;12948.287844168473;13194.822854229136;13251.271180084996;13264.801027984588;13265;9394.24846012331;9467.715968520955;9493.952530237304;9497.097775711296;9498.09768072032;13330.866691333156;13427.12723672958;13445.193288402726;13472.326383680973;13513.324333783272;5551.722413879371;5717.171010203498;5721.656700597978;5744.281964754406;5757.510611598061;859.832332695131;930.3905941608258;1007.1590222164428;1018.6639104768329;1024.257413375297;25786.35534111662;25927.74072259253;26021.349466263495;26302.736972630413;26328;946.5078159357096;999.9051039112161;1002.1581871228058;1058.6718117383637;1075.2097208551709;12935.417906194243;13230.206187628773;13363.665908352175;13421.932890335682;13451.260180690157;500453.95914367883;507104;511489;513315;514109;48026.759866200446;48229.75885120552;48323.516764831904;48397.516024840006;48427.75786121047;1194.2953657342036;1209.3348658237935;1211.3821950805152;1212.7210741529498;1213.787587172259;26514.734852651225;26606;27016.59475107914;27237;29853;42971.57028429801;43341.783291083346;43438.56561434345;43554;43722.56277437185;246478;248704;250332;251456;251946;38149.80925095357;41995;42474.15051699011;42999.355009674255;43058.138837223705;45426.31860522029;46754.76622617001;46851;47186;47552.2867156986;33583.49624755582;33756.32487350288;34335.62657493672;34966.65033349634;35318.117047074025;36133;37577;37696;38173.236535269694;42224.1555168901;36278.27443451169;37313.626863732105;37600.2479950394;37675;38030.429543557424;34044.829775850965;35586.46620300646;36051.819740901126;36088.27823443569;36151.81924090363;28360.290992725346;29329.41341173122;32310.515342269413;32554.511682325257;32733.836330818194 09:06:06 INFO - 2015-12-02 09:06:06,503 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.66800033966206;334.14625631511495;335.50345488676743;336.68688120048347;337.50485349899947;14865.108093514396;15200.315985780639;15554.222288885567;15749.2912818923;16193.514194574182;14985.850141498582;15192.164430956293;15449.768253476206;15454;15527.611809704764;4320.027993701416;4480.551944805509;4486.97756511217;4488.865334039984;4494.6179574736025;3647.8905632831056;4454.57681520255;4490.9550904491025;4495.348174514694;4496.460424749034;4483.08096840147;4506.098780243964;5423.078076726966;5592.468715472024;5631.352394474647;4832.081904438145;5592.273004509408;5602.747876345554;5603.859903502404;5625.774969001255;4844.5882100021545;4847.2002119650215;4849.854504364875;4852.733099679516;4858.5384388483035;11660.300381977024;11684.766304673944;11727.237729547553;11743.7064073398;13260.867391326059;1771.8848274862094;1815.754873092129;1821.772278465192;1854.9629007419776;1898.3355825461117;8815.559222038872;9688.370255933341;9871.40771553709;12117.697057573543;12769.808452873214;1734.314945596495;1771.176402972611;1786.178357955342;1786.5712229064932;1818.1909050472545;52497.2125418119;52530.21204681933;53616.19575706367;54744;54781;9445.102715242041;9574.138327550554;9787;9803.705888823346;9925.2059835213;12270.141090123785;12347.62957111288;12349.073819463576;12351.93824030874;12394.380280985915;6792.252852186256;6838.418734407532;6911.75808846688;7077.929220707727;7169.605671688108;6104.938950610437;6113.296970848321;6117.235345581802;6125.2649682037545;6210.9068363974575;4008.0581063450068;4062.431259623655;4089.5910408958866;4166.479190101238;4176.791160441966;1578.873690104789;1698.2612563534901;1715.3481676962674;1735.8698097642728;1741.7996930353172;801.2708435323827;843.1020962674731;858.994975878224;956.4691596164196;979.9951000244953;15380.92309538445;15618.297176627078;15673.529794106194;15988.600284992968;16386.918065409598;832.238501770885;844.3793811548506;853.5476197615274;855.8801767752519;858.6222062292571;6912.619805910623;9133.95433022844;9152.8627070594;9215.53922303882;9311.76720581991;453825;463304;466676;482291;484611;68974;69148.30851691519;69474.65262673756;69829;70864.22839428953;1050.9527071281811;1061.57536985205;1084.013547671615;1086.760912599227;1093.338530189224;14654.706905862036;14679.55961321162;14679.63300917443;14701.55895323142;15148.394064237307;32073.03780886577;32458.513122302713;32524.674753252166;33246.83376583102;33603.99188024363;38402.42396364113;38614.42078368883;39168.6083139165;39534.61628842977;42990.57009429866;8498.235158835734;8770.956145219234;8862.069482704223;8871.423357481743;8878.73363799087;10122.291439599452;10755.462226888782;15976.840231597535;16266.918665406598;16691.165441728106;13744.793828092386;13783.724325513233;13824.585262442142;13885.791713124108;13997.860021400063;13102.082854200115;13183.53857614979;13215.66960825987;13348.332583370599;13569;12883.098183127091;13056.477740890257;13268.867311327149;13319.600411987656;13566.59300220995;8851.911480885108;8933.19601235892;8943.329250306122;8967.955160224157;9054.683086091954;12890.871091288967;13418.463261469822;13491.662708432368;13505.662358440724;13571.728565428833 09:06:06 INFO - 2015-12-02 09:06:06,506 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.3549931532177;1413.109740863256;1413.660721426858;1597.4888035828535;1660.991695041525;6166.568340216187;6283.026130949699;7143.678534465948;7407.851842963138;7423.814404639887;7069.575825450476;7125.5724656520515;7178.2103968563415;7230.746923857666;7232.3490885820265;2046.641837678404;2086.9478263043393;2092.6233278009954;2093.267356425254;2093.6336141175234;2089.4358523198725;2090.947726306847;2099.895005249731;2122.2253877334815;2141.218455263833;2061.9793802061936;2064.566441047382;2093.591749608827;2111.261058629475;2116.6507526258147;2048.4366799130207;2064.0195906944155;2065.5972085443345;2066.132224465728;2071.616750901073;2054.250198677472;2070.9792902070935;2071.0369678099755;2084.5414008918015;2094.3298144593737;7132.893006604853;7145.964270178668;7187.101612298463;7226.241244669339;7234.168070671835;4065;4134.697570265387;4134.937975930364;4138.337865941435;4147.81334839933;2340.6840076589615;2390.1873363056643;2711.051132103748;2753.8347699138117;2765.9308517287027;883.9559017494986;885.3581153663607;889.8442772514849;907.5190149220923;938.5119737736408;9480.762980925463;9614.230861531061;9688.12806847387;9714.854277185848;9762.755931101708;3810.2189051244427;3865.7873816940337;3895.3572660511263;3916.8433262669173;3919.333713268751;8486.19381158789;8526.062133165347;8535.914640853636;8539.48763074205;8580.828383432296;4191.979040104841;4202.306619407764;4215.515215750228;4236.639885609758;4250.872473825791;3741.981290093532;3759.8908322045063;3787.0721673190246;3794.4118661607495;3806.9619303807162;3298.5711857458377;3304.5043243513664;3318.5685860837934;3351.865925363007;3355.815430151365;1040.15747244732;1047.895210478946;1048.496721573649;1057;1057.1595581512715;1174.7944109780753;1181.0905602686055;1201.9038476921826;1218.421249906305;1220.127608759741;6627.304133065959;6642.169728783902;6666.766663166863;6677;6749.156355455568;425.6637256567277;426.4328443170576;430.618902271492;432.2975165356296;435.06895244177485;5384.111621582395;5390.4879036491475;5439.972800135974;5443.673379597237;5444.3194600674915;7658.73194438192;7755.069391673035;8186.959065204635;8288.21261980111;8297.751067467985;7949.165337639581;8003.839923201504;8026.157253488416;8031.477953932976;8033.879491807627;6460.580062295936;6590.439812615981;6654.301298363602;6905.37851593359;6911.481638877104;6563.901541476786;6589.637569933508;6591.6374599397495;6598.736050557924;6621.834454138685;7556.924430755842;7589.6584653689615;7808.5314881107315;7838.882416763639;7851.803704907423;7801.2198780121535;7882.684692612232;7908.52548847071;7972.162922893244;8091.919080809116;6285.271550323698;6313.494920406265;6394.520410969103;6395.840103997437;6414.358564143735;6891.241963383924;6944.895826562707;6946.16646002483;6955.721771129098;6968.547044442095;6417.101605775102;6436.485081193399;6568.80293591193;6658.5671931324305;6763;6439.356064393523;6515;6516.283208847118;6604.603723776589;6622.966885165543;6554.901676474761;6602.63685497283;6608.471322294301;6623.768168114093;6635.6350400728425;5877.676727779842;5919.644821310735;5928.466438020427;5962.19510366095;5966.492848107786;6096.9390306096375;6133.294671112879;6145.877082458415;6146;6148.139260503623 09:06:06 INFO - 2015-12-02 09:06:06,506 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.78864900245327;300.171526586621;305.6714032415153;306.1244839758292;307.28862682889115;5558.86102847429;5564.777408903644;5604.775808967636;5610.747516361764;5633.211350410946;5482.122860342346;5497.862553436166;5502.724863756806;5518.944810551893;5520.282363292777;4015.6586690131376;4245.808938597763;4247.193033323659;4253.65970722343;4256.574342565749;4116.835326586933;4172.895677608054;4295.334223195409;4295.377170310318;4302.763348015857;4229.661627069842;4243.639290660298;4247.15056988602;4247.469066366704;4252.213340531996;4223.092035212444;4244.448221731155;4252.553481884389;4254.468191476066;4266.253405653998;3736.4955730976244;3737.6636102750613;3740.513733214692;3740.588535261119;3744.6817020553285;5121.743912804345;5146.485351464861;5300.522952934254;5309.946900530984;5312.362516498007;4812.759362031885;4813.542713442217;4818.542238487338;4828.034393121355;4834.226523756182;5766.538676905838;5785.971070144622;5808;5810.854728631776;5823.796167134173;3959.1685745993377;3960.5841386654274;3965.6034396560403;3967.1668949520636;3970.1861118470642;5885.293764748215;6086.391360863922;6105.755769769204;6114.480269177126;6125.387461253839;4104.994276402241;4106.035081755785;4111.650509706648;4112.054227527686;4114.444549985714;4173.207090652766;4176.624103830609;4176.937345939813;4177.268977928911;4181.853635122817;4802.183628783116;4813.590844778233;4815.061063092663;4816.446108697474;4817.927731084036;5663.433656634304;5743.511801496919;5805;5806.622569532967;5815.069588865761;1455.548779878241;1484.1911158418689;1485.2202593638426;1485.3909896942203;1486.4574430333066;971.0871780526282;971.965981190669;975.1029053271008;992.9404235745878;996.9651062212932;5065.569426598707;5073;5086.593072554187;5105;5113.846584602468;6022.307434644984;6031.728572214261;6040.214772079689;6040.305364883006;6055.152278680988;5041.168207245763;5061.2661164131;5062.367204099488;5073.8731531712;5091.0836049511445;3207.118042538274;3255.527948447509;3270.3459308138467;3277.557529733503;3282.2778988622463;5755.107958266475;5762.711864406763;5763.308402991668;5764.855878602984;5766.94233057664;6077.665728384893;6217.533684973645;6288.717007734663;6314.652694101776;6323.430891219812;5736.110902810071;5776.393478684678;5790.507806836382;5792.797252096157;5823.126531020381;6092.878142437038;6096.055111457731;6100.450959413674;6101.176341194059;6108.694565271808;5846.444587764156;5883.735231914659;5932.377100404396;5948.137520059654;5955.136505206808;5802.158686990447;5809.215755872903;5811.593188476766;5813.418658134322;5825.300963884361;4097.569755175783;4103.363978583325;4135.069609337875;4139.937900931549;4154.563770804022;5970.492508136684;6081.452669259611;6090.421409966223;6095.420935011167;6100.908486372619;5838.620489668158;5862.032764593794;5865.882682346414;5867.442592953663;5887.4406931341455;5846.41535846412;5855.970720146372;5872.265966754156;5886.705664716661;5892.5285977122585;5684.431556844283;5724.169995350568;5730.283714535683;5730.312362516524;5733.713314334183;5761.222234998221;5877.059670452707;5889.734961926638;5893.263342082239;5896.439838215363;5718.828435146952;5719.656820590778;5730.054541000855;5736.6558006519745;5738 09:06:06 INFO - 2015-12-02 09:06:06,507 DEBUG : BROWSER_OUTPUT: |5;yui.html;775.4223103787679;783.0290439854575;793.5675057093883;798.3493452835938;801.4389927051066;10689.946550267248;11137.33176009439;12731.681707957307;12912.548060817873;12932.094753367268;13534.187948723084;13774.793378099337;13777.51778687746;13785.379657915393;13823;625.0436831647564;633.0630666613415;808.2281421242714;812.7846120777998;817.8691409374501;794.9085855126648;799.6921185343656;802.8153524689325;805.8831469436929;810.5987536169604;840.2941529115542;844.1094645149365;844.2654890245495;847.0978407995495;848.0332421039989;832.5337810825957;833.8832563441123;835.7116794705817;835.9289460395843;838.4717627894448;620.10394979255;621.2482895696213;621.5307442880596;621.6052806467925;624.1231070346171;11227.326360418401;11331.886681133166;11344.716382090513;11353;11361.772764544745;10828.458577071193;11082.612108576242;11433.599824006204;11453.656390308304;11461.770764584662;9502.524873756285;9520.333576649637;9537.809243815154;9672.468014259213;9732.270079743977;3335.199552107501;3347.548081009057;3378.9831050844587;3392.6098498672723;3411.795292282471;41994.580054199374;42061.369079463526;42359;42565;42802.35796463056;9293.58178881952;9374.812503749887;9465.858012129824;9468.19520340765;9536.332456727963;15998.840011599968;16101.27544260511;16143.919280403758;16160.67678646444;16176;6204.193454850931;6269.46709529686;6355.1420558224045;6373.968130159412;6443.48452123829;3451.534042904226;3483.7909725416557;3551.3074950384425;3570.5001299818045;3581.0510214793103;2742.2184677366854;2755.4213615140643;2757.0901602471536;2769.529180039398;2778.9722102778715;498.0536979738453;501.1830715933079;506.45050120618805;506.62256618819214;524.4414698346249;508.69224119407966;582.8397190772572;599.2060519811267;618.9059372252607;619.5693992675137;7691.269329413697;7720.575368354795;7799.337056350274;7814.492058016211;7864.370850331959;556.546414672041;564.1002600851635;597.8580910460998;612.1669419929631;630.9526785491015;3338.1988322802354;3769.4157405602177;3799.8290076946605;3835.271298453285;3884.3979183226643;48882.26676599854;49045;49363.012739745725;49753.25370119451;50130;44509.99999999935;45013.77493112513;45090.774546127715;45412.77293613577;45757.084858302645;41782.37326440106;42330.57669423328;42456.575434245264;42598.57401426008;42882.14235715331;7357.742479013209;7364.889526657212;7839.176886426843;7855.018122734658;8134.227248411392;30458.84770576133;30532.389352212387;31373.52939705952;31504.36991260116;31521.8423907879;36538;37610.247795044495;38215.61784382121;38808;40303.39544906888;9874.40753554789;10297.3821570706;10484.947575262075;10538.367697937842;10626.149908007186;11164.832527511931;11234.494447750034;11256.662300131009;11329.735327505052;11962;10890.836637450602;10910.672679819618;11093.833592495957;11156.219064665396;11212.215144939775;10842.457877106272;10846.945765271123;10867;10879.401632910265;11084.390358530358;10643.8935610646;10772;10808.675739727822;10901.073408760027;11203.943980280046;9189.172974432333;9322.347435679438;9519.333646644669;9531.189848862647;9688.41869487833;9133.77165570866;9227.261819054595;9311.208547273287;9463.479508627091;9550.85673714881 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,333 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: __startTimestamp1449075966495__endTimestamp 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:06:06 INFO - 2015-12-02 09:06:06,508 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:06:06 INFO - 2015-12-02 09:06:06,509 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,509 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4679.63 Median:4806.16 stddev:497.16 (10.3%) stddev-sans-first:472.45 09:06:06 INFO - 2015-12-02 09:06:06,510 DEBUG : BROWSER_OUTPUT: Values: 2648.3 2671.1 2710.3 2723.0 2728.0 4567.6 4700.5 4709.8 4745.0 4746.3 4627.5 4691.6 4723.7 4727.1 4734.7 4369.5 4410.5 4438.9 4452.8 4463.1 4461.9 4471.7 4534.9 4545.1 4580.7 4169.5 4273.5 4279.1 4363.7 4382.8 4375.0 4379.6 4379.6 4391.4 4442.4 4202.5 4355.8 4369.6 4399.0 4424.4 4502.3 4552.4 4553.7 4636.4 4667.2 5060.6 5067.5 5099.4 5103.0 5113.2 4938.6 5056.1 5107.1 5126.2 5146.0 4651.9 4711.4 4718.6 4721.1 4756.0 5201.6 5217.1 5221.2 5235.4 5267.8 4777.5 4876.5 4926.9 5024.7 5032.8 5106.8 5115.4 5119.6 5120.8 5183.1 5040.5 5042.7 5044.4 5058.3 5073.8 4722.3 4876.1 4928.5 5021.6 5029.1 4163.3 4185.7 4192.5 4205.2 4235.8 3669.4 3680.3 3690.2 3703.9 3713.1 4197.3 4249.6 4307.5 4355.8 4418.5 5082.9 5107.9 5139.5 5156.0 5205.8 4241.0 4426.7 4432.5 4437.8 4481.2 4350.7 4383.1 4404.7 4432.9 4455.8 4888.0 4913.4 4920.3 4921.7 4923.8 4881.5 4958.8 5141.2 5156.1 5213.0 4790.8 4806.2 4873.8 4876.7 4915.7 5013.1 5043.5 5049.5 5050.0 5062.7 4911.1 4948.8 5005.6 5120.6 5157.7 4974.3 4995.9 4998.9 5014.0 5036.9 4969.7 4994.2 4995.1 5006.4 5021.1 4617.9 4706.3 4718.6 4889.4 4932.5 4960.1 4970.1 4980.0 4984.2 4994.4 4803.9 4814.9 4846.6 4857.0 4881.2 09:06:06 INFO - 2015-12-02 09:06:06,510 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,510 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47664.60 Median:37537.03 stddev:93610.00 (249.4%) stddev-sans-first:93805.79 09:06:06 INFO - 2015-12-02 09:06:06,510 DEBUG : BROWSER_OUTPUT: Values: 562.4 576.8 584.4 589.1 596.9 35915.0 37001.6 37024.6 37063.8 37389.0 39512.4 39878.8 39991.2 40325.8 40393.4 7902.2 7985.0 7990.2 8002.3 8067.6 7808.6 7907.3 7968.6 7981.2 8007.0 7752.7 7809.0 7812.9 7816.3 7838.6 7936.2 8003.4 8014.4 8033.0 8033.2 7807.2 7959.3 7967.7 7998.9 8016.0 36028.3 36872.0 36917.8 36920.3 36954.0 3066.3 3151.9 3365.0 3431.1 3651.2 27277.3 27318.5 27388.7 27540.3 27953.4 3255.6 3258.7 3266.9 3290.9 3296.8 218624.0 219781.0 220922.0 220999.0 221571.0 38061.8 43141.4 43286.1 43303.4 43370.6 37247.4 37528.8 37545.2 37566.0 37594.4 12948.3 13194.8 13251.3 13264.8 13265.0 9394.2 9467.7 9494.0 9497.1 9498.1 13330.9 13427.1 13445.2 13472.3 13513.3 5551.7 5717.2 5721.7 5744.3 5757.5 859.8 930.4 1007.2 1018.7 1024.3 25786.4 25927.7 26021.3 26302.7 26328.0 946.5 999.9 1002.2 1058.7 1075.2 12935.4 13230.2 13363.7 13421.9 13451.3 500454.0 507104.0 511489.0 513315.0 514109.0 48026.8 48229.8 48323.5 48397.5 48427.8 1194.3 1209.3 1211.4 1212.7 1213.8 26514.7 26606.0 27016.6 27237.0 29853.0 42971.6 43341.8 43438.6 43554.0 43722.6 246478.0 248704.0 250332.0 251456.0 251946.0 38149.8 41995.0 42474.2 42999.4 43058.1 45426.3 46754.8 46851.0 47186.0 47552.3 33583.5 33756.3 34335.6 34966.7 35318.1 36133.0 37577.0 37696.0 38173.2 42224.2 36278.3 37313.6 37600.2 37675.0 38030.4 34044.8 35586.5 36051.8 36088.3 36151.8 28360.3 29329.4 32310.5 32554.5 32733.8 09:06:06 INFO - 2015-12-02 09:06:06,510 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,510 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25447.17 Median:39351.61 stddev:76787.66 (195.1%) stddev-sans-first:76979.92 09:06:06 INFO - 2015-12-02 09:06:06,511 DEBUG : BROWSER_OUTPUT: Values: 333.7 334.1 335.5 336.7 337.5 14865.1 15200.3 15554.2 15749.3 16193.5 14985.9 15192.2 15449.8 15454.0 15527.6 4320.0 4480.6 4487.0 4488.9 4494.6 3647.9 4454.6 4491.0 4495.3 4496.5 4483.1 4506.1 5423.1 5592.5 5631.4 4832.1 5592.3 5602.7 5603.9 5625.8 4844.6 4847.2 4849.9 4852.7 4858.5 11660.3 11684.8 11727.2 11743.7 13260.9 1771.9 1815.8 1821.8 1855.0 1898.3 8815.6 9688.4 9871.4 12117.7 12769.8 1734.3 1771.2 1786.2 1786.6 1818.2 52497.2 52530.2 53616.2 54744.0 54781.0 9445.1 9574.1 9787.0 9803.7 9925.2 12270.1 12347.6 12349.1 12351.9 12394.4 6792.3 6838.4 6911.8 7077.9 7169.6 6104.9 6113.3 6117.2 6125.3 6210.9 4008.1 4062.4 4089.6 4166.5 4176.8 1578.9 1698.3 1715.3 1735.9 1741.8 801.3 843.1 859.0 956.5 980.0 15380.9 15618.3 15673.5 15988.6 16386.9 832.2 844.4 853.5 855.9 858.6 6912.6 9134.0 9152.9 9215.5 9311.8 453825.0 463304.0 466676.0 482291.0 484611.0 68974.0 69148.3 69474.7 69829.0 70864.2 1051.0 1061.6 1084.0 1086.8 1093.3 14654.7 14679.6 14679.6 14701.6 15148.4 32073.0 32458.5 32524.7 33246.8 33604.0 38402.4 38614.4 39168.6 39534.6 42990.6 8498.2 8771.0 8862.1 8871.4 8878.7 10122.3 10755.5 15976.8 16266.9 16691.2 13744.8 13783.7 13824.6 13885.8 13997.9 13102.1 13183.5 13215.7 13348.3 13569.0 12883.1 13056.5 13268.9 13319.6 13566.6 8851.9 8933.2 8943.3 8968.0 9054.7 12890.9 13418.5 13491.7 13505.7 13571.7 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4972.60 Median:6224.80 stddev:2593.86 (41.7%) stddev-sans-first:2587.02 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: Values: 1372.4 1413.1 1413.7 1597.5 1661.0 6166.6 6283.0 7143.7 7407.9 7423.8 7069.6 7125.6 7178.2 7230.7 7232.3 2046.6 2086.9 2092.6 2093.3 2093.6 2089.4 2090.9 2099.9 2122.2 2141.2 2062.0 2064.6 2093.6 2111.3 2116.7 2048.4 2064.0 2065.6 2066.1 2071.6 2054.3 2071.0 2071.0 2084.5 2094.3 7132.9 7146.0 7187.1 7226.2 7234.2 4065.0 4134.7 4134.9 4138.3 4147.8 2340.7 2390.2 2711.1 2753.8 2765.9 884.0 885.4 889.8 907.5 938.5 9480.8 9614.2 9688.1 9714.9 9762.8 3810.2 3865.8 3895.4 3916.8 3919.3 8486.2 8526.1 8535.9 8539.5 8580.8 4192.0 4202.3 4215.5 4236.6 4250.9 3742.0 3759.9 3787.1 3794.4 3807.0 3298.6 3304.5 3318.6 3351.9 3355.8 1040.2 1047.9 1048.5 1057.0 1057.2 1174.8 1181.1 1201.9 1218.4 1220.1 6627.3 6642.2 6666.8 6677.0 6749.2 425.7 426.4 430.6 432.3 435.1 5384.1 5390.5 5440.0 5443.7 5444.3 7658.7 7755.1 8187.0 8288.2 8297.8 7949.2 8003.8 8026.2 8031.5 8033.9 6460.6 6590.4 6654.3 6905.4 6911.5 6563.9 6589.6 6591.6 6598.7 6621.8 7556.9 7589.7 7808.5 7838.9 7851.8 7801.2 7882.7 7908.5 7972.2 8091.9 6285.3 6313.5 6394.5 6395.8 6414.4 6891.2 6944.9 6946.2 6955.7 6968.5 6417.1 6436.5 6568.8 6658.6 6763.0 6439.4 6515.0 6516.3 6604.6 6623.0 6554.9 6602.6 6608.5 6623.8 6635.6 5877.7 5919.6 5928.5 5962.2 5966.5 6096.9 6133.3 6145.9 6146.0 6148.1 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4822.19 Median:5561.82 stddev:1436.35 (25.8%) stddev-sans-first:1399.70 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: Values: 299.8 300.2 305.7 306.1 307.3 5558.9 5564.8 5604.8 5610.7 5633.2 5482.1 5497.9 5502.7 5518.9 5520.3 4015.7 4245.8 4247.2 4253.7 4256.6 4116.8 4172.9 4295.3 4295.4 4302.8 4229.7 4243.6 4247.2 4247.5 4252.2 4223.1 4244.4 4252.6 4254.5 4266.3 3736.5 3737.7 3740.5 3740.6 3744.7 5121.7 5146.5 5300.5 5309.9 5312.4 4812.8 4813.5 4818.5 4828.0 4834.2 5766.5 5786.0 5808.0 5810.9 5823.8 3959.2 3960.6 3965.6 3967.2 3970.2 5885.3 6086.4 6105.8 6114.5 6125.4 4105.0 4106.0 4111.7 4112.1 4114.4 4173.2 4176.6 4176.9 4177.3 4181.9 4802.2 4813.6 4815.1 4816.4 4817.9 5663.4 5743.5 5805.0 5806.6 5815.1 1455.5 1484.2 1485.2 1485.4 1486.5 971.1 972.0 975.1 992.9 997.0 5065.6 5073.0 5086.6 5105.0 5113.8 6022.3 6031.7 6040.2 6040.3 6055.2 5041.2 5061.3 5062.4 5073.9 5091.1 3207.1 3255.5 3270.3 3277.6 3282.3 5755.1 5762.7 5763.3 5764.9 5766.9 6077.7 6217.5 6288.7 6314.7 6323.4 5736.1 5776.4 5790.5 5792.8 5823.1 6092.9 6096.1 6100.5 6101.2 6108.7 5846.4 5883.7 5932.4 5948.1 5955.1 5802.2 5809.2 5811.6 5813.4 5825.3 4097.6 4103.4 4135.1 4139.9 4154.6 5970.5 6081.5 6090.4 6095.4 6100.9 5838.6 5862.0 5865.9 5867.4 5887.4 5846.4 5856.0 5872.3 5886.7 5892.5 5684.4 5724.2 5730.3 5730.3 5733.7 5761.2 5877.1 5889.7 5893.3 5896.4 5718.8 5719.7 5730.1 5736.7 5738.0 09:06:06 INFO - 2015-12-02 09:06:06,512 DEBUG : BROWSER_OUTPUT: 09:06:06 INFO - 2015-12-02 09:06:06,513 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12420.89 Median:45052.27 stddev:13953.89 (31.0%) stddev-sans-first:13965.63 09:06:06 INFO - 2015-12-02 09:06:06,513 DEBUG : BROWSER_OUTPUT: Values: 775.4 783.0 793.6 798.3 801.4 10689.9 11137.3 12731.7 12912.5 12932.1 13534.2 13774.8 13777.5 13785.4 13823.0 625.0 633.1 808.2 812.8 817.9 794.9 799.7 802.8 805.9 810.6 840.3 844.1 844.3 847.1 848.0 832.5 833.9 835.7 835.9 838.5 620.1 621.2 621.5 621.6 624.1 11227.3 11331.9 11344.7 11353.0 11361.8 10828.5 11082.6 11433.6 11453.7 11461.8 9502.5 9520.3 9537.8 9672.5 9732.3 3335.2 3347.5 3379.0 3392.6 3411.8 41994.6 42061.4 42359.0 42565.0 42802.4 9293.6 9374.8 9465.9 9468.2 9536.3 15998.8 16101.3 16143.9 16160.7 16176.0 6204.2 6269.5 6355.1 6374.0 6443.5 3451.5 3483.8 3551.3 3570.5 3581.1 2742.2 2755.4 2757.1 2769.5 2779.0 498.1 501.2 506.5 506.6 524.4 508.7 582.8 599.2 618.9 619.6 7691.3 7720.6 7799.3 7814.5 7864.4 556.5 564.1 597.9 612.2 631.0 3338.2 3769.4 3799.8 3835.3 3884.4 48882.3 49045.0 49363.0 49753.3 50130.0 44510.0 45013.8 45090.8 45412.8 45757.1 41782.4 42330.6 42456.6 42598.6 42882.1 7357.7 7364.9 7839.2 7855.0 8134.2 30458.8 30532.4 31373.5 31504.4 31521.8 36538.0 37610.2 38215.6 38808.0 40303.4 9874.4 10297.4 10484.9 10538.4 10626.1 11164.8 11234.5 11256.7 11329.7 11962.0 10890.8 10910.7 11093.8 11156.2 11212.2 10842.5 10846.9 10867.0 10879.4 11084.4 10643.9 10772.0 10808.7 10901.1 11203.9 9189.2 9322.3 9519.3 9531.2 9688.4 9133.8 9227.3 9311.2 9463.5 9550.9 09:06:06 INFO - 2015-12-02 09:06:06,513 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:06:06 INFO - 2015-12-02 09:06:06,513 DEBUG : BROWSER_OUTPUT: 09:06:07 INFO - 2015-12-02 09:06:07,271 INFO : Browser exited with error code: 0 09:06:07 INFO - 2015-12-02 09:06:07,292 INFO : Completed test dromaeo_css (00:18:34) 09:06:07 INFO - 2015-12-02 09:06:07,292 INFO : Starting test kraken 09:06:07 INFO - 2015-12-02 09:06:07,292 DEBUG : operating with platform_type : linux_ 09:06:07 INFO - 2015-12-02 09:06:07,292 INFO : Initialising browser for kraken test... 09:06:07 INFO - 2015-12-02 09:06:07,299 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNHscc7/profile http://localhost:57305/getInfo.html 09:06:12 INFO - 2015-12-02 09:06:12,180 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:06:12 INFO - 2015-12-02 09:06:12,181 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:06:12 INFO - 2015-12-02 09:06:12,181 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:06:12 INFO - 2015-12-02 09:06:12,181 DEBUG : BROWSER_OUTPUT: __metrics 09:06:12 INFO - 2015-12-02 09:06:12,363 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] 09:06:13 INFO - 2015-12-02 09:06:13,287 INFO : Browser initialized. 09:06:13 INFO - 2015-12-02 09:06:13,287 INFO : Running cycle 1/1 for kraken test... 09:06:13 INFO - 2015-12-02 09:06:13,287 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNHscc7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:06:25 INFO - 2015-12-02 09:06:25,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 142966784 09:06:25 INFO - 2015-12-02 09:06:25,291 DEBUG : BROWSER_OUTPUT: 09:06:27 INFO - 2015-12-02 09:06:27,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57305/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:28 INFO - 2015-12-02 09:06:28,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 142979072 09:06:28 INFO - 2015-12-02 09:06:28,476 DEBUG : BROWSER_OUTPUT: 09:06:31 INFO - 2015-12-02 09:06:31,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57305/tests/kraken/driver.html?testName=audio-dft) 09:06:31 INFO - 2015-12-02 09:06:31,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 143339520 09:06:31 INFO - 2015-12-02 09:06:31,828 DEBUG : BROWSER_OUTPUT: 09:06:34 INFO - 2015-12-02 09:06:34,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57305/tests/kraken/driver.html?testName=audio-fft) 09:06:35 INFO - 2015-12-02 09:06:35,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 137498624 09:06:35 INFO - 2015-12-02 09:06:35,341 DEBUG : BROWSER_OUTPUT: 09:06:37 INFO - 2015-12-02 09:06:37,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57305/tests/kraken/driver.html?testName=audio-oscillator) 09:06:38 INFO - 2015-12-02 09:06:38,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 09:06:38 INFO - 2015-12-02 09:06:38,069 DEBUG : BROWSER_OUTPUT: 09:06:40 INFO - 2015-12-02 09:06:40,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:40 INFO - 2015-12-02 09:06:40,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 139857920 09:06:40 INFO - 2015-12-02 09:06:40,904 DEBUG : BROWSER_OUTPUT: 09:06:43 INFO - 2015-12-02 09:06:43,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57305/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:44 INFO - 2015-12-02 09:06:44,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 139935744 09:06:44 INFO - 2015-12-02 09:06:44,570 DEBUG : BROWSER_OUTPUT: 09:06:48 INFO - 2015-12-02 09:06:48,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57305/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:48 INFO - 2015-12-02 09:06:48,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 137830400 09:06:48 INFO - 2015-12-02 09:06:48,715 DEBUG : BROWSER_OUTPUT: 09:06:51 INFO - 2015-12-02 09:06:51,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57305/tests/kraken/driver.html?testName=json-parse-financial) 09:06:52 INFO - 2015-12-02 09:06:52,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 138579968 09:06:52 INFO - 2015-12-02 09:06:52,179 DEBUG : BROWSER_OUTPUT: 09:06:53 INFO - 2015-12-02 09:06:53,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:54 INFO - 2015-12-02 09:06:54,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 140742656 09:06:54 INFO - 2015-12-02 09:06:54,509 DEBUG : BROWSER_OUTPUT: 09:06:56 INFO - 2015-12-02 09:06:56,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:57 INFO - 2015-12-02 09:06:57,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 140337152 09:06:57 INFO - 2015-12-02 09:06:57,034 DEBUG : BROWSER_OUTPUT: 09:06:59 INFO - 2015-12-02 09:06:59,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:59 INFO - 2015-12-02 09:06:59,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 141119488 09:06:59 INFO - 2015-12-02 09:06:59,793 DEBUG : BROWSER_OUTPUT: 09:07:02 INFO - 2015-12-02 09:07:02,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:02 INFO - 2015-12-02 09:07:02,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 140341248 09:07:02 INFO - 2015-12-02 09:07:02,975 DEBUG : BROWSER_OUTPUT: 09:07:05 INFO - 2015-12-02 09:07:05,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:06 INFO - 2015-12-02 09:07:06,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 140554240 09:07:06 INFO - 2015-12-02 09:07:06,171 DEBUG : BROWSER_OUTPUT: 09:07:07 INFO - 2015-12-02 09:07:07,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57305/tests/kraken/driver.html?testName=ai-astar) 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 140689408 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:07:08 INFO - 2015-12-02 09:07:08,200 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;105;113;113;111;123;111;112;111;112 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;131;158;173;139;152;155;137;170;137 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;166;163;164;161;166;168;162;164;163 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;74;73;72;73;72;135;72;72;73 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;95;132;93;94;94;140;94;97;129 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;111;110;110;110;110;110 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;155;150;150;147;148;147;148;148;148 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;97;96;96;97;95;96;96;97 09:07:08 INFO - 2015-12-02 09:07:08,201 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;71;70;72;71;72;72;69;70 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;69;69;69;68 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;83;86;83;83;87;86;85;87;87 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;120;128;131;118;131;121;127;131;140 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;139;149;146;148;149;145;146;147;146 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;76;69;70;69;69;68;69 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:07:08 INFO - 2015-12-02 09:07:08,202 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:07:08 INFO - 2015-12-02 09:07:08,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,824 09:07:08 INFO - 2015-12-02 09:07:08,203 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:07:08 INFO - 2015-12-02 09:07:08,203 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076028194__endTimestamp 09:07:08 INFO - 2015-12-02 09:07:08,203 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,204 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:07:08 INFO - 2015-12-02 09:07:08,204 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:07:08 INFO - 2015-12-02 09:07:08,205 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,205 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:4.43 (3.9%) stddev-sans-first:4.66 09:07:08 INFO - 2015-12-02 09:07:08,205 DEBUG : BROWSER_OUTPUT: Values: 114.0 105.0 113.0 113.0 111.0 123.0 111.0 112.0 111.0 112.0 09:07:08 INFO - 2015-12-02 09:07:08,205 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,205 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.30 Median:153.50 stddev:14.31 (9.3%) stddev-sans-first:15.17 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: Values: 151.0 131.0 158.0 173.0 139.0 152.0 155.0 137.0 170.0 137.0 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:2.20 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: Values: 163.0 166.0 163.0 164.0 161.0 166.0 168.0 162.0 164.0 163.0 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:73.00 stddev:19.66 (26.9%) stddev-sans-first:20.80 09:07:08 INFO - 2015-12-02 09:07:08,206 DEBUG : BROWSER_OUTPUT: Values: 84.0 74.0 73.0 72.0 73.0 72.0 135.0 72.0 72.0 73.0 09:07:08 INFO - 2015-12-02 09:07:08,207 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,208 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:94.00 stddev:19.24 (20.5%) stddev-sans-first:19.82 09:07:08 INFO - 2015-12-02 09:07:08,208 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 132.0 93.0 94.0 94.0 140.0 94.0 97.0 129.0 09:07:08 INFO - 2015-12-02 09:07:08,208 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,209 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:07:08 INFO - 2015-12-02 09:07:08,209 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 09:07:08 INFO - 2015-12-02 09:07:08,209 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,209 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.00 stddev:2.38 (1.6%) stddev-sans-first:2.50 09:07:08 INFO - 2015-12-02 09:07:08,209 DEBUG : BROWSER_OUTPUT: Values: 148.0 155.0 150.0 150.0 147.0 148.0 147.0 148.0 148.0 148.0 09:07:08 INFO - 2015-12-02 09:07:08,209 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 97.0 96.0 96.0 97.0 95.0 96.0 96.0 97.0 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.50 stddev:1.20 (1.7%) stddev-sans-first:1.05 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 71.0 70.0 72.0 71.0 72.0 72.0 69.0 70.0 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,210 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.50 stddev:2.49 (2.9%) stddev-sans-first:1.79 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: Values: 91.0 83.0 86.0 83.0 83.0 87.0 86.0 85.0 87.0 87.0 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:130.50 stddev:6.57 (5.0%) stddev-sans-first:6.91 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: Values: 130.0 120.0 128.0 131.0 118.0 131.0 121.0 127.0 131.0 140.0 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:146.50 stddev:3.13 (2.1%) stddev-sans-first:3.02 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: Values: 142.0 139.0 149.0 146.0 148.0 149.0 145.0 146.0 147.0 146.0 09:07:08 INFO - 2015-12-02 09:07:08,211 DEBUG : BROWSER_OUTPUT: 09:07:08 INFO - 2015-12-02 09:07:08,212 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.00 stddev:2.25 (3.3%) stddev-sans-first:2.37 09:07:08 INFO - 2015-12-02 09:07:08,212 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 76.0 69.0 70.0 69.0 69.0 68.0 69.0 09:07:08 INFO - 2015-12-02 09:07:08,212 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:07:08 INFO - 2015-12-02 09:07:08,212 DEBUG : BROWSER_OUTPUT: 09:07:09 INFO - 2015-12-02 09:07:09,167 INFO : Browser exited with error code: 0 09:07:09 INFO - 2015-12-02 09:07:09,221 INFO : Completed test kraken (00:01:01) 09:07:09 INFO - 2015-12-02 09:07:09,221 INFO : Starting test v8_7 09:07:09 INFO - 2015-12-02 09:07:09,221 DEBUG : operating with platform_type : linux_ 09:07:09 INFO - 2015-12-02 09:07:09,221 INFO : Initialising browser for v8_7 test... 09:07:09 INFO - 2015-12-02 09:07:09,227 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPrsuO/profile http://localhost:57305/getInfo.html 09:07:14 INFO - 2015-12-02 09:07:14,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:07:14 INFO - 2015-12-02 09:07:14,058 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:07:14 INFO - 2015-12-02 09:07:14,058 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:07:14 INFO - 2015-12-02 09:07:14,059 DEBUG : BROWSER_OUTPUT: __metrics 09:07:14 INFO - 2015-12-02 09:07:14,195 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] 09:07:15 INFO - 2015-12-02 09:07:15,123 INFO : Browser initialized. 09:07:15 INFO - 2015-12-02 09:07:15,123 INFO : Running cycle 1/1 for v8_7 test... 09:07:15 INFO - 2015-12-02 09:07:15,123 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPrsuO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:07:27 INFO - 2015-12-02 09:07:27,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 143040512 09:07:27 INFO - 2015-12-02 09:07:27,226 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57305/tests/v8_7/run.html (next: http://localhost:57305/tests/v8_7/run.html) 09:07:48 INFO - 2015-12-02 09:07:48,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 137740288 09:07:48 INFO - 2015-12-02 09:07:48,917 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,918 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:07:48 INFO - 2015-12-02 09:07:48,918 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:07:48 INFO - 2015-12-02 09:07:48,918 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:07:48 INFO - 2015-12-02 09:07:48,918 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:07:48 INFO - 2015-12-02 09:07:48,918 DEBUG : BROWSER_OUTPUT: |0;Richards;167.42005692281936 09:07:48 INFO - 2015-12-02 09:07:48,918 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.1620626151013 09:07:48 INFO - 2015-12-02 09:07:48,919 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 09:07:48 INFO - 2015-12-02 09:07:48,919 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 09:07:48 INFO - 2015-12-02 09:07:48,919 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1077.5862068965516 09:07:48 INFO - 2015-12-02 09:07:48,919 DEBUG : BROWSER_OUTPUT: |5;Earley;705.2186177715091 09:07:48 INFO - 2015-12-02 09:07:48,919 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 09:07:48 INFO - 2015-12-02 09:07:48,920 DEBUG : BROWSER_OUTPUT: |7;RegExp;25794.871794871793 09:07:48 INFO - 2015-12-02 09:07:48,920 DEBUG : BROWSER_OUTPUT: |8;Splay;600.1188354129531 09:07:48 INFO - 2015-12-02 09:07:48,920 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 09:07:48 INFO - 2015-12-02 09:07:48,920 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:07:48 INFO - 2015-12-02 09:07:48,920 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076068915__endTimestamp 09:07:48 INFO - 2015-12-02 09:07:48,920 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,921 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:07:48 INFO - 2015-12-02 09:07:48,921 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:07:48 INFO - 2015-12-02 09:07:48,921 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,921 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,921 DEBUG : BROWSER_OUTPUT: Values: 167.4 09:07:48 INFO - 2015-12-02 09:07:48,921 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,922 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.16 Median:184.16 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,922 DEBUG : BROWSER_OUTPUT: Values: 184.2 09:07:48 INFO - 2015-12-02 09:07:48,922 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,922 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,923 DEBUG : BROWSER_OUTPUT: Values: 278.5 09:07:48 INFO - 2015-12-02 09:07:48,923 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,923 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,923 DEBUG : BROWSER_OUTPUT: Values: 5164.9 09:07:48 INFO - 2015-12-02 09:07:48,923 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,923 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,924 DEBUG : BROWSER_OUTPUT: Values: 1077.6 09:07:48 INFO - 2015-12-02 09:07:48,924 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,924 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:705.22 Median:705.22 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,924 DEBUG : BROWSER_OUTPUT: Values: 705.2 09:07:48 INFO - 2015-12-02 09:07:48,924 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: Values: 12231.7 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: Values: 25794.9 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.12 Median:600.12 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: Values: 600.1 09:07:48 INFO - 2015-12-02 09:07:48,926 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-12-02 09:07:48,927 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 09:07:48 INFO - 2015-12-02 09:07:48,927 DEBUG : BROWSER_OUTPUT: Values: 4845.4 09:07:48 INFO - 2015-12-02 09:07:48,927 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:07:48 INFO - 2015-12-02 09:07:48,927 DEBUG : BROWSER_OUTPUT: 09:07:49 INFO - 2015-12-02 09:07:49,811 INFO : Browser exited with error code: 0 09:07:49 INFO - 2015-12-02 09:07:49,823 INFO : Completed test v8_7 (00:00:40) 09:07:49 INFO - 2015-12-02 09:07:49,887 INFO : Completed test suite (00:20:17) 09:07:49 INFO - 2015-12-02 09:07:49,888 DEBUG : Working with test: dromaeo_css 09:07:49 INFO - 2015-12-02 09:07:49,888 DEBUG : Generating results file: dromaeo_css 09:07:49 INFO - 2015-12-02 09:07:49,889 DEBUG : Working with test: kraken 09:07:49 INFO - 2015-12-02 09:07:49,889 DEBUG : Generating results file: kraken 09:07:49 INFO - 2015-12-02 09:07:49,890 INFO : javascript benchmark 09:07:49 INFO - 2015-12-02 09:07:49,890 DEBUG : Working with test: v8_7 09:07:49 INFO - 2015-12-02 09:07:49,890 DEBUG : Generating results file: v8_7 09:07:49 INFO - 2015-12-02 09:07:49,890 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:07:49 INFO - 2015-12-02 09:07:49,942 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:07:49 INFO - 2015-12-02 09:07:49,942 DEBUG : process_Request line: dromaeo_css 6350.87 graph.html#tests=[[72,132,43]] 09:07:49 INFO - 2015-12-02 09:07:49,942 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:07:49 INFO - 2015-12-02 09:07:49,972 DEBUG : process_Request line: kraken 1537.20 graph.html#tests=[[232,132,43]] 09:07:49 INFO - 2015-12-02 09:07:49,972 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:07:50 INFO - 2015-12-02 09:07:50,005 DEBUG : process_Request line: v8_7 21402.38 graph.html#tests=[[230,132,43]] 09:07:50 INFO - 2015-12-02 09:07:50,006 INFO : javascript benchmark 09:07:50 INFO - 2015-12-02 09:07:50,010 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.3379155211196, 2671.051776619299, 2710.2953232159643, 2722.9727702722967, 2728.0451841855347, 4567.58891699747, 4700.506446823081, 4709.788059537324, 4744.97627511862, 4746.288056791479, 4627.514111018345, 4691.554302341281, 4723.669343145981, 4727.05458908218, 4734.692245004081, 4369.541198174194, 4410.492793328776, 4438.866833994985, 4452.821887124511, 4463.107378524292, 4461.910761784762, 4471.66462515311, 4534.8639540813665, 4545.090981803636, 4580.656450766206, 4169.478815148092, 4273.52991170974, 4279.1013887083745, 4363.738175709436, 4382.802773875183, 4374.9781251093855, 4379.60574567554, 4379.605835474823, 4391.407160033386, 4442.355858400514, 4202.453681021479, 4355.760433176174, 4369.584889435499, 4399.0, 4424.358468022118, 4502.2571275739465, 4552.408186935711, 4553.726776393427, 4636.374089497942, 4667.206574882244, 5060.620453465968, 5067.467915868854, 5099.4390617032095, 5103.0, 5113.2330150477355, 4938.62960277977, 5056.089903817311, 5107.131787596118, 5126.179811230185, 5145.99653067652, 4651.90680190155, 4711.387519622495, 4718.622510199176, 4721.102990431807, 4756.048790241931, 5201.5838732901275, 5217.139172036647, 5221.216817477332, 5235.3717553893775, 5267.815626453055, 4777.450593181759, 4876.536729010738, 4926.852194434173, 5024.698518088926, 5032.84901452957, 5106.795728170831, 5115.360579927509, 5119.6160287978555, 5120.769565369567, 5183.118869792144, 5040.46564018087, 5042.697438153649, 5044.369453818273, 5058.317127187856, 5073.822416215415, 4722.268048452495, 4876.073546026244, 4928.531789479994, 5021.648484606042, 5029.06962211992, 4163.3130533462245, 4185.665146788249, 4192.517860446027, 4205.1589682063095, 4235.788210589458, 3669.43123815809, 3680.3191409589313, 3690.225052738901, 3703.9074023149637, 3713.145976425383, 4197.349410841324, 4249.596288352602, 4307.461567304087, 4355.847545335898, 4418.4918734345965, 5082.898342033139, 5107.8723031923755, 5139.537441630271, 5156.04613146569, 5205.817796377109, 4240.978795106004, 4426.734395936254, 4432.49026361966, 4437.8224871004795, 4481.2381895077915, 4350.651947844165, 4383.057642606855, 4404.66964977628, 4432.933505997413, 4455.799489023002, 4887.95112048882, 4913.385826771653, 4920.286558449076, 4921.729304888266, 4923.753812309298, 4881.463039065629, 4958.801647934042, 5141.170252022049, 5156.1492353761205, 5213.009528189784, 4790.7844147012775, 4806.158922188673, 4873.829415970424, 4876.683015604116, 4915.729634869974, 5013.072581572421, 5043.4956504349275, 5049.520295571915, 5050.0, 5062.670926389773, 4911.140550403737, 4948.802047918043, 5005.649604527648, 5120.590352771844, 5157.6647517911215, 4974.253861920741, 4995.900081998267, 4998.850034498971, 5014.0, 5036.949630503795, 4969.701817890938, 4994.1509943309, 4995.125852975787, 5006.449290578106, 5021.146405111067, 4617.907641847211, 4706.341112244357, 4718.5753282203395, 4889.413270407574, 4932.482089380707, 4960.082384758831, 4970.080535101018, 4980.028894365709, 4984.2025275955675, 4994.375703037121, 4803.879903002453, 4814.903701925872, 4846.588040016638, 4857.0, 4881.243407271879], "unit": "ms", "name": "dojo.html", "value": 4648.182509936835}, {"lowerIsBetter": false, "replicates": [562.3701454371103, 576.7894718427775, 584.3922320786382, 589.0575079872204, 596.880623875225, 35915.0, 37001.62998370016, 37024.62975370246, 37063.81468092659, 37389.0, 39512.407313890246, 39878.80060599693, 39991.200175996535, 40325.7983710081, 40393.39409908854, 7902.170272121431, 7984.960075199645, 7990.161033091529, 8002.319802816767, 8067.63695633695, 7808.570528620923, 7907.327877130451, 7968.641411136513, 7981.201879812031, 8007.0, 7752.689892404325, 7809.023872015998, 7812.921870781276, 7816.296533312001, 7838.608069596526, 7936.24605662464, 8003.399745019117, 8014.358851291882, 8033.036035675727, 8033.236842499953, 7807.180246074194, 7959.323457506119, 7967.681292748283, 7998.880016799752, 8016.0, 36028.27943441143, 36872.0, 36917.815410923045, 36920.26159476822, 36954.0, 3066.2947522069826, 3151.9054428367185, 3364.96635033649, 3431.1422144463886, 3651.1967367179445, 27277.318067048283, 27318.45363092727, 27388.726112738816, 27540.311492212855, 27953.440931181467, 3255.625603055655, 3258.7067163955358, 3266.869325226988, 3290.8848190313224, 3296.8021918684717, 218624.0, 219781.0, 220922.0, 220999.0, 221571.0, 38061.80969095137, 43141.35287970683, 43286.134277314275, 43303.35044974328, 43370.56629433728, 37247.441288380694, 37528.81235593805, 37545.24909501795, 37566.0, 37594.43608345877, 12948.287844168473, 13194.822854229136, 13251.271180084996, 13264.801027984588, 13265.0, 9394.24846012331, 9467.715968520955, 9493.952530237304, 9497.097775711296, 9498.09768072032, 13330.866691333156, 13427.12723672958, 13445.193288402726, 13472.326383680973, 13513.324333783272, 5551.722413879371, 5717.171010203498, 5721.656700597978, 5744.281964754406, 5757.510611598061, 859.832332695131, 930.3905941608258, 1007.1590222164428, 1018.6639104768329, 1024.257413375297, 25786.35534111662, 25927.74072259253, 26021.349466263495, 26302.736972630413, 26328.0, 946.5078159357096, 999.9051039112161, 1002.1581871228058, 1058.6718117383637, 1075.2097208551709, 12935.417906194243, 13230.206187628773, 13363.665908352175, 13421.932890335682, 13451.260180690157, 500453.95914367883, 507104.0, 511489.0, 513315.0, 514109.0, 48026.759866200446, 48229.75885120552, 48323.516764831904, 48397.516024840006, 48427.75786121047, 1194.2953657342036, 1209.3348658237935, 1211.3821950805152, 1212.7210741529498, 1213.787587172259, 26514.734852651225, 26606.0, 27016.59475107914, 27237.0, 29853.0, 42971.57028429801, 43341.783291083346, 43438.56561434345, 43554.0, 43722.56277437185, 246478.0, 248704.0, 250332.0, 251456.0, 251946.0, 38149.80925095357, 41995.0, 42474.15051699011, 42999.355009674255, 43058.138837223705, 45426.31860522029, 46754.76622617001, 46851.0, 47186.0, 47552.2867156986, 33583.49624755582, 33756.32487350288, 34335.62657493672, 34966.65033349634, 35318.117047074025, 36133.0, 37577.0, 37696.0, 38173.236535269694, 42224.1555168901, 36278.27443451169, 37313.626863732105, 37600.2479950394, 37675.0, 38030.429543557424, 34044.829775850965, 35586.46620300646, 36051.819740901126, 36088.27823443569, 36151.81924090363, 28360.290992725346, 29329.41341173122, 32310.515342269413, 32554.511682325257, 32733.836330818194], "unit": "ms", "name": "ext.html", "value": 17228.969765866637}, {"lowerIsBetter": false, "replicates": [333.66800033966206, 334.14625631511495, 335.50345488676743, 336.68688120048347, 337.50485349899947, 14865.108093514396, 15200.315985780639, 15554.222288885567, 15749.2912818923, 16193.514194574182, 14985.850141498582, 15192.164430956293, 15449.768253476206, 15454.0, 15527.611809704764, 4320.027993701416, 4480.551944805509, 4486.97756511217, 4488.865334039984, 4494.6179574736025, 3647.8905632831056, 4454.57681520255, 4490.9550904491025, 4495.348174514694, 4496.460424749034, 4483.08096840147, 4506.098780243964, 5423.078076726966, 5592.468715472024, 5631.352394474647, 4832.081904438145, 5592.273004509408, 5602.747876345554, 5603.859903502404, 5625.774969001255, 4844.5882100021545, 4847.2002119650215, 4849.854504364875, 4852.733099679516, 4858.5384388483035, 11660.300381977024, 11684.766304673944, 11727.237729547553, 11743.7064073398, 13260.867391326059, 1771.8848274862094, 1815.754873092129, 1821.772278465192, 1854.9629007419776, 1898.3355825461117, 8815.559222038872, 9688.370255933341, 9871.40771553709, 12117.697057573543, 12769.808452873214, 1734.314945596495, 1771.176402972611, 1786.178357955342, 1786.5712229064932, 1818.1909050472545, 52497.2125418119, 52530.21204681933, 53616.19575706367, 54744.0, 54781.0, 9445.102715242041, 9574.138327550554, 9787.0, 9803.705888823346, 9925.2059835213, 12270.141090123785, 12347.62957111288, 12349.073819463576, 12351.93824030874, 12394.380280985915, 6792.252852186256, 6838.418734407532, 6911.75808846688, 7077.929220707727, 7169.605671688108, 6104.938950610437, 6113.296970848321, 6117.235345581802, 6125.2649682037545, 6210.9068363974575, 4008.0581063450068, 4062.431259623655, 4089.5910408958866, 4166.479190101238, 4176.791160441966, 1578.873690104789, 1698.2612563534901, 1715.3481676962674, 1735.8698097642728, 1741.7996930353172, 801.2708435323827, 843.1020962674731, 858.994975878224, 956.4691596164196, 979.9951000244953, 15380.92309538445, 15618.297176627078, 15673.529794106194, 15988.600284992968, 16386.918065409598, 832.238501770885, 844.3793811548506, 853.5476197615274, 855.8801767752519, 858.6222062292571, 6912.619805910623, 9133.95433022844, 9152.8627070594, 9215.53922303882, 9311.76720581991, 453825.0, 463304.0, 466676.0, 482291.0, 484611.0, 68974.0, 69148.30851691519, 69474.65262673756, 69829.0, 70864.22839428953, 1050.9527071281811, 1061.57536985205, 1084.013547671615, 1086.760912599227, 1093.338530189224, 14654.706905862036, 14679.55961321162, 14679.63300917443, 14701.55895323142, 15148.394064237307, 32073.03780886577, 32458.513122302713, 32524.674753252166, 33246.83376583102, 33603.99188024363, 38402.42396364113, 38614.42078368883, 39168.6083139165, 39534.61628842977, 42990.57009429866, 8498.235158835734, 8770.956145219234, 8862.069482704223, 8871.423357481743, 8878.73363799087, 10122.291439599452, 10755.462226888782, 15976.840231597535, 16266.918665406598, 16691.165441728106, 13744.793828092386, 13783.724325513233, 13824.585262442142, 13885.791713124108, 13997.860021400063, 13102.082854200115, 13183.53857614979, 13215.66960825987, 13348.332583370599, 13569.0, 12883.098183127091, 13056.477740890257, 13268.867311327149, 13319.600411987656, 13566.59300220995, 8851.911480885108, 8933.19601235892, 8943.329250306122, 8967.955160224157, 9054.683086091954, 12890.871091288967, 13418.463261469822, 13491.662708432368, 13505.662358440724, 13571.728565428833], "unit": "ms", "name": "jquery.html", "value": 8057.100405286307}, {"lowerIsBetter": false, "replicates": [1372.3549931532177, 1413.109740863256, 1413.660721426858, 1597.4888035828535, 1660.991695041525, 6166.568340216187, 6283.026130949699, 7143.678534465948, 7407.851842963138, 7423.814404639887, 7069.575825450476, 7125.5724656520515, 7178.2103968563415, 7230.746923857666, 7232.3490885820265, 2046.641837678404, 2086.9478263043393, 2092.6233278009954, 2093.267356425254, 2093.6336141175234, 2089.4358523198725, 2090.947726306847, 2099.895005249731, 2122.2253877334815, 2141.218455263833, 2061.9793802061936, 2064.566441047382, 2093.591749608827, 2111.261058629475, 2116.6507526258147, 2048.4366799130207, 2064.0195906944155, 2065.5972085443345, 2066.132224465728, 2071.616750901073, 2054.250198677472, 2070.9792902070935, 2071.0369678099755, 2084.5414008918015, 2094.3298144593737, 7132.893006604853, 7145.964270178668, 7187.101612298463, 7226.241244669339, 7234.168070671835, 4065.0, 4134.697570265387, 4134.937975930364, 4138.337865941435, 4147.81334839933, 2340.6840076589615, 2390.1873363056643, 2711.051132103748, 2753.8347699138117, 2765.9308517287027, 883.9559017494986, 885.3581153663607, 889.8442772514849, 907.5190149220923, 938.5119737736408, 9480.762980925463, 9614.230861531061, 9688.12806847387, 9714.854277185848, 9762.755931101708, 3810.2189051244427, 3865.7873816940337, 3895.3572660511263, 3916.8433262669173, 3919.333713268751, 8486.19381158789, 8526.062133165347, 8535.914640853636, 8539.48763074205, 8580.828383432296, 4191.979040104841, 4202.306619407764, 4215.515215750228, 4236.639885609758, 4250.872473825791, 3741.981290093532, 3759.8908322045063, 3787.0721673190246, 3794.4118661607495, 3806.9619303807162, 3298.5711857458377, 3304.5043243513664, 3318.5685860837934, 3351.865925363007, 3355.815430151365, 1040.15747244732, 1047.895210478946, 1048.496721573649, 1057.0, 1057.1595581512715, 1174.7944109780753, 1181.0905602686055, 1201.9038476921826, 1218.421249906305, 1220.127608759741, 6627.304133065959, 6642.169728783902, 6666.766663166863, 6677.0, 6749.156355455568, 425.6637256567277, 426.4328443170576, 430.618902271492, 432.2975165356296, 435.06895244177485, 5384.111621582395, 5390.4879036491475, 5439.972800135974, 5443.673379597237, 5444.3194600674915, 7658.73194438192, 7755.069391673035, 8186.959065204635, 8288.21261980111, 8297.751067467985, 7949.165337639581, 8003.839923201504, 8026.157253488416, 8031.477953932976, 8033.879491807627, 6460.580062295936, 6590.439812615981, 6654.301298363602, 6905.37851593359, 6911.481638877104, 6563.901541476786, 6589.637569933508, 6591.6374599397495, 6598.736050557924, 6621.834454138685, 7556.924430755842, 7589.6584653689615, 7808.5314881107315, 7838.882416763639, 7851.803704907423, 7801.2198780121535, 7882.684692612232, 7908.52548847071, 7972.162922893244, 8091.919080809116, 6285.271550323698, 6313.494920406265, 6394.520410969103, 6395.840103997437, 6414.358564143735, 6891.241963383924, 6944.895826562707, 6946.16646002483, 6955.721771129098, 6968.547044442095, 6417.101605775102, 6436.485081193399, 6568.80293591193, 6658.5671931324305, 6763.0, 6439.356064393523, 6515.0, 6516.283208847118, 6604.603723776589, 6622.966885165543, 6554.901676474761, 6602.63685497283, 6608.471322294301, 6623.768168114093, 6635.6350400728425, 5877.676727779842, 5919.644821310735, 5928.466438020427, 5962.19510366095, 5966.492848107786, 6096.9390306096375, 6133.294671112879, 6145.877082458415, 6146.0, 6148.139260503623], "unit": "ms", "name": "mootools.html", "value": 4012.9155075230656}, {"lowerIsBetter": false, "replicates": [299.78864900245327, 300.171526586621, 305.6714032415153, 306.1244839758292, 307.28862682889115, 5558.86102847429, 5564.777408903644, 5604.775808967636, 5610.747516361764, 5633.211350410946, 5482.122860342346, 5497.862553436166, 5502.724863756806, 5518.944810551893, 5520.282363292777, 4015.6586690131376, 4245.808938597763, 4247.193033323659, 4253.65970722343, 4256.574342565749, 4116.835326586933, 4172.895677608054, 4295.334223195409, 4295.377170310318, 4302.763348015857, 4229.661627069842, 4243.639290660298, 4247.15056988602, 4247.469066366704, 4252.213340531996, 4223.092035212444, 4244.448221731155, 4252.553481884389, 4254.468191476066, 4266.253405653998, 3736.4955730976244, 3737.6636102750613, 3740.513733214692, 3740.588535261119, 3744.6817020553285, 5121.743912804345, 5146.485351464861, 5300.522952934254, 5309.946900530984, 5312.362516498007, 4812.759362031885, 4813.542713442217, 4818.542238487338, 4828.034393121355, 4834.226523756182, 5766.538676905838, 5785.971070144622, 5808.0, 5810.854728631776, 5823.796167134173, 3959.1685745993377, 3960.5841386654274, 3965.6034396560403, 3967.1668949520636, 3970.1861118470642, 5885.293764748215, 6086.391360863922, 6105.755769769204, 6114.480269177126, 6125.387461253839, 4104.994276402241, 4106.035081755785, 4111.650509706648, 4112.054227527686, 4114.444549985714, 4173.207090652766, 4176.624103830609, 4176.937345939813, 4177.268977928911, 4181.853635122817, 4802.183628783116, 4813.590844778233, 4815.061063092663, 4816.446108697474, 4817.927731084036, 5663.433656634304, 5743.511801496919, 5805.0, 5806.622569532967, 5815.069588865761, 1455.548779878241, 1484.1911158418689, 1485.2202593638426, 1485.3909896942203, 1486.4574430333066, 971.0871780526282, 971.965981190669, 975.1029053271008, 992.9404235745878, 996.9651062212932, 5065.569426598707, 5073.0, 5086.593072554187, 5105.0, 5113.846584602468, 6022.307434644984, 6031.728572214261, 6040.214772079689, 6040.305364883006, 6055.152278680988, 5041.168207245763, 5061.2661164131, 5062.367204099488, 5073.8731531712, 5091.0836049511445, 3207.118042538274, 3255.527948447509, 3270.3459308138467, 3277.557529733503, 3282.2778988622463, 5755.107958266475, 5762.711864406763, 5763.308402991668, 5764.855878602984, 5766.94233057664, 6077.665728384893, 6217.533684973645, 6288.717007734663, 6314.652694101776, 6323.430891219812, 5736.110902810071, 5776.393478684678, 5790.507806836382, 5792.797252096157, 5823.126531020381, 6092.878142437038, 6096.055111457731, 6100.450959413674, 6101.176341194059, 6108.694565271808, 5846.444587764156, 5883.735231914659, 5932.377100404396, 5948.137520059654, 5955.136505206808, 5802.158686990447, 5809.215755872903, 5811.593188476766, 5813.418658134322, 5825.300963884361, 4097.569755175783, 4103.363978583325, 4135.069609337875, 4139.937900931549, 4154.563770804022, 5970.492508136684, 6081.452669259611, 6090.421409966223, 6095.420935011167, 6100.908486372619, 5838.620489668158, 5862.032764593794, 5865.882682346414, 5867.442592953663, 5887.4406931341455, 5846.41535846412, 5855.970720146372, 5872.265966754156, 5886.705664716661, 5892.5285977122585, 5684.431556844283, 5724.169995350568, 5730.283714535683, 5730.312362516524, 5733.713314334183, 5761.222234998221, 5877.059670452707, 5889.734961926638, 5893.263342082239, 5896.439838215363, 5718.828435146952, 5719.656820590778, 5730.054541000855, 5736.6558006519745, 5738.0], "unit": "ms", "name": "prototype.html", "value": 4354.794567967874}, {"lowerIsBetter": false, "replicates": [775.4223103787679, 783.0290439854575, 793.5675057093883, 798.3493452835938, 801.4389927051066, 10689.946550267248, 11137.33176009439, 12731.681707957307, 12912.548060817873, 12932.094753367268, 13534.187948723084, 13774.793378099337, 13777.51778687746, 13785.379657915393, 13823.0, 625.0436831647564, 633.0630666613415, 808.2281421242714, 812.7846120777998, 817.8691409374501, 794.9085855126648, 799.6921185343656, 802.8153524689325, 805.8831469436929, 810.5987536169604, 840.2941529115542, 844.1094645149365, 844.2654890245495, 847.0978407995495, 848.0332421039989, 832.5337810825957, 833.8832563441123, 835.7116794705817, 835.9289460395843, 838.4717627894448, 620.10394979255, 621.2482895696213, 621.5307442880596, 621.6052806467925, 624.1231070346171, 11227.326360418401, 11331.886681133166, 11344.716382090513, 11353.0, 11361.772764544745, 10828.458577071193, 11082.612108576242, 11433.599824006204, 11453.656390308304, 11461.770764584662, 9502.524873756285, 9520.333576649637, 9537.809243815154, 9672.468014259213, 9732.270079743977, 3335.199552107501, 3347.548081009057, 3378.9831050844587, 3392.6098498672723, 3411.795292282471, 41994.580054199374, 42061.369079463526, 42359.0, 42565.0, 42802.35796463056, 9293.58178881952, 9374.812503749887, 9465.858012129824, 9468.19520340765, 9536.332456727963, 15998.840011599968, 16101.27544260511, 16143.919280403758, 16160.67678646444, 16176.0, 6204.193454850931, 6269.46709529686, 6355.1420558224045, 6373.968130159412, 6443.48452123829, 3451.534042904226, 3483.7909725416557, 3551.3074950384425, 3570.5001299818045, 3581.0510214793103, 2742.2184677366854, 2755.4213615140643, 2757.0901602471536, 2769.529180039398, 2778.9722102778715, 498.0536979738453, 501.1830715933079, 506.45050120618805, 506.62256618819214, 524.4414698346249, 508.69224119407966, 582.8397190772572, 599.2060519811267, 618.9059372252607, 619.5693992675137, 7691.269329413697, 7720.575368354795, 7799.337056350274, 7814.492058016211, 7864.370850331959, 556.546414672041, 564.1002600851635, 597.8580910460998, 612.1669419929631, 630.9526785491015, 3338.1988322802354, 3769.4157405602177, 3799.8290076946605, 3835.271298453285, 3884.3979183226643, 48882.26676599854, 49045.0, 49363.012739745725, 49753.25370119451, 50130.0, 44509.99999999935, 45013.77493112513, 45090.774546127715, 45412.77293613577, 45757.084858302645, 41782.37326440106, 42330.57669423328, 42456.575434245264, 42598.57401426008, 42882.14235715331, 7357.742479013209, 7364.889526657212, 7839.176886426843, 7855.018122734658, 8134.227248411392, 30458.84770576133, 30532.389352212387, 31373.52939705952, 31504.36991260116, 31521.8423907879, 36538.0, 37610.247795044495, 38215.61784382121, 38808.0, 40303.39544906888, 9874.40753554789, 10297.3821570706, 10484.947575262075, 10538.367697937842, 10626.149908007186, 11164.832527511931, 11234.494447750034, 11256.662300131009, 11329.735327505052, 11962.0, 10890.836637450602, 10910.672679819618, 11093.833592495957, 11156.219064665396, 11212.215144939775, 10842.457877106272, 10846.945765271123, 10867.0, 10879.401632910265, 11084.390358530358, 10643.8935610646, 10772.0, 10808.675739727822, 10901.073408760027, 11203.943980280046, 9189.172974432333, 9322.347435679438, 9519.333646644669, 9531.189848862647, 9688.41869487833, 9133.77165570866, 9227.261819054595, 9311.208547273287, 9463.479508627091, 9550.85673714881], "unit": "ms", "name": "yui.html", "value": 5818.414089772473}], "name": "dromaeo_css", "value": 6350.867697423143}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 105.0, 113.0, 113.0, 111.0, 123.0, 111.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 158.0, 173.0, 139.0, 152.0, 155.0, 137.0, 170.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [163.0, 166.0, 163.0, 164.0, 161.0, 166.0, 168.0, 162.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [84.0, 74.0, 73.0, 72.0, 73.0, 72.0, 135.0, 72.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 132.0, 93.0, 94.0, 94.0, 140.0, 94.0, 97.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 155.0, 150.0, 150.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.9}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 71.0, 70.0, 72.0, 71.0, 72.0, 72.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 86.0, 83.0, 83.0, 87.0, 86.0, 85.0, 87.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [130.0, 120.0, 128.0, 131.0, 118.0, 131.0, 121.0, 127.0, 131.0, 140.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [142.0, 139.0, 149.0, 146.0, 148.0, 149.0, 145.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 76.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1537.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [184.1620626151013], "unit": "score", "name": "DeltaBlue", "value": 359.02074000000005}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [705.2186177715091], "unit": "score", "name": "Earley", "value": 945.0445340000002}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [600.1188354129531], "unit": "score", "name": "Splay", "value": 135.79143861386143}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21402.375053316213}]} 09:07:50 INFO - RETURN: dromaeo_css: 6350.87 09:07:50 INFO - RETURN: kraken: 1537.20 09:07:50 INFO - RETURN: v8_7: 21402.38 09:07:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21402.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1537.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6350.87"}}} 09:07:50 INFO - Return code: 0 09:07:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:07:50 INFO - # TBPL SUCCESS # 09:07:50 INFO - Running post-action listener: _resource_record_post_action 09:07:50 INFO - Running post-run listener: _resource_record_post_run 09:07:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504987648; Read time: 12; Write time: 508536 09:07:51 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 230879232; Read time: 0; Write time: 373420 09:07:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273276928; Read time: 12; Write time: 135080 09:07:51 INFO - Running post-run listener: _upload_blobber_files 09:07:51 INFO - Blob upload gear active. 09:07:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:07:51 INFO - Copying logs to upload dir... 09:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.311899 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-02 09:07:51.036358) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:51.039834) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010027 build_url: 'https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/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 09:07:51.092189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:51.092613) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1449074664.310392-181420060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:51.142679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:07:51.143039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:07:51.143435) ========= ========= Total master_lag: 0.25 =========