builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1449203317.72 results: success (0) buildid: 20151203200117 builduid: ffcaa872fc8e4a8cabb5747aa2f17fd5 revision: f70ee6e84e82ec22a16f33c6a3f3da3402a36272 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.717829) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.718316) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.718643) ========= 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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006417 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.746455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.746769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.772301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.772659) ========= 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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.826633) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.827067) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.827619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.828059) ========= 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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 20:28:37-- 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% 47.4M=0s 2015-12-03 20:28:37 (47.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104397 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.948483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.949217) ========= 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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022990 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.008186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.009034) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f70ee6e84e82ec22a16f33c6a3f3da3402a36272 --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 f70ee6e84e82ec22a16f33c6a3f3da3402a36272 --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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 20:28:38,043 truncating revision to first 12 chars 2015-12-03 20:28:38,044 Setting DEBUG logging. 2015-12-03 20:28:38,044 attempt 1/10 2015-12-03 20:28:38,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f70ee6e84e82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 20:28:38,367 unpacking tar archive at: fx-team-f70ee6e84e82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619304 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.642401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.642774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.654074) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.654366) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.654839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 20:28:38.655192) ========= /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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:28:38 INFO - MultiFileLogger online at 20151203 20:28:38 in /builds/slave/test 20:28:38 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 20:28:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:28:38 INFO - {'append_to_log': False, 20:28:38 INFO - 'base_work_dir': '/builds/slave/test', 20:28:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:28:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:28:38 INFO - 'branch': 'Fx-Team-Non-PGO', 20:28:38 INFO - 'buildbot_json_path': 'buildprops.json', 20:28:38 INFO - 'config_files': ('talos/linux_config.py',), 20:28:38 INFO - 'default_actions': ('clobber', 20:28:38 INFO - 'read-buildbot-config', 20:28:38 INFO - 'download-and-extract', 20:28:38 INFO - 'populate-webroot', 20:28:38 INFO - 'create-virtualenv', 20:28:38 INFO - 'install', 20:28:38 INFO - 'run-tests'), 20:28:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:28:38 INFO - 'download_minidump_stackwalk': True, 20:28:38 INFO - 'download_symbols': 'ondemand', 20:28:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:28:38 INFO - 'tooltool.py': '/tools/tooltool.py', 20:28:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:28:38 INFO - '/tools/misc-python/virtualenv.py')}, 20:28:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:28:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:28:38 INFO - 'installer_path': 'installer.exe', 20:28:38 INFO - 'log_level': 'info', 20:28:38 INFO - 'log_name': 'talos', 20:28:38 INFO - 'log_to_console': True, 20:28:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:28:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:28:38 INFO - 'opt_config_files': (), 20:28:38 INFO - 'pip_index': False, 20:28:38 INFO - 'sps_profile': False, 20:28:38 INFO - 'sps_profile_interval': 0, 20:28:38 INFO - 'suite': 'dromaeojs-e10s', 20:28:38 INFO - 'system_bits': '64', 20:28:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:28:38 INFO - 'title': 'talos-linux64-ix-045', 20:28:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:28:38 INFO - 'use_talos_json': True, 20:28:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:28:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:28:38 INFO - 'work_dir': 'build'} 20:28:38 INFO - ##### 20:28:38 INFO - ##### Running clobber step. 20:28:38 INFO - ##### 20:28:38 INFO - Running pre-action listener: _resource_record_pre_action 20:28:38 INFO - Running main action method: clobber 20:28:38 INFO - rmtree: /builds/slave/test/build 20:28:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:28:39 INFO - Running post-action listener: _resource_record_post_action 20:28:39 INFO - ##### 20:28:39 INFO - ##### Running read-buildbot-config step. 20:28:39 INFO - ##### 20:28:39 INFO - Running pre-action listener: _resource_record_pre_action 20:28:39 INFO - Running main action method: read_buildbot_config 20:28:39 INFO - Using buildbot properties: 20:28:39 INFO - { 20:28:39 INFO - "properties": { 20:28:39 INFO - "buildnumber": 798, 20:28:39 INFO - "product": "firefox", 20:28:39 INFO - "script_repo_revision": "production", 20:28:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:28:39 INFO - "repository": "", 20:28:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 20:28:39 INFO - "buildid": "20151203200117", 20:28:39 INFO - "slavename": "talos-linux64-ix-045", 20:28:39 INFO - "pgo_build": "False", 20:28:39 INFO - "basedir": "/builds/slave/test", 20:28:39 INFO - "project": "", 20:28:39 INFO - "platform": "ubuntu64_hw", 20:28:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:28:39 INFO - "slavebuilddir": "test", 20:28:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:28:39 INFO - "branch": "fx-team", 20:28:39 INFO - "repo_path": "integration/fx-team", 20:28:39 INFO - "stage_platform": "linux64", 20:28:39 INFO - "builduid": "ffcaa872fc8e4a8cabb5747aa2f17fd5", 20:28:39 INFO - "revision": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272" 20:28:39 INFO - }, 20:28:39 INFO - "sourcestamp": { 20:28:39 INFO - "repository": "", 20:28:39 INFO - "hasPatch": false, 20:28:39 INFO - "project": "", 20:28:39 INFO - "branch": "fx-team-linux64-talos", 20:28:39 INFO - "changes": [ 20:28:39 INFO - { 20:28:39 INFO - "category": null, 20:28:39 INFO - "files": [ 20:28:39 INFO - { 20:28:39 INFO - "url": null, 20:28:39 INFO - "name": "https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:28:39 INFO - } 20:28:39 INFO - ], 20:28:39 INFO - "repository": "", 20:28:39 INFO - "rev": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272", 20:28:39 INFO - "who": "markcapella@twcny.rr.com", 20:28:39 INFO - "when": 1449203257, 20:28:39 INFO - "number": 6742802, 20:28:39 INFO - "comments": "Bug 1215959 - (GeckoCarets2) - skip-if overlooked perma-orange test", 20:28:39 INFO - "project": "", 20:28:39 INFO - "at": "Thu 03 Dec 2015 20:27:37", 20:28:39 INFO - "branch": "fx-team-linux64-talos", 20:28:39 INFO - "revlink": "", 20:28:39 INFO - "properties": [ 20:28:39 INFO - [ 20:28:39 INFO - "buildid", 20:28:39 INFO - "20151203200117", 20:28:39 INFO - "Change" 20:28:39 INFO - ], 20:28:39 INFO - [ 20:28:39 INFO - "builduid", 20:28:39 INFO - "ffcaa872fc8e4a8cabb5747aa2f17fd5", 20:28:39 INFO - "Change" 20:28:39 INFO - ], 20:28:39 INFO - [ 20:28:39 INFO - "pgo_build", 20:28:39 INFO - "False", 20:28:39 INFO - "Change" 20:28:39 INFO - ] 20:28:39 INFO - ], 20:28:39 INFO - "revision": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272" 20:28:39 INFO - } 20:28:39 INFO - ], 20:28:39 INFO - "revision": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272" 20:28:39 INFO - } 20:28:39 INFO - } 20:28:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:28:39 INFO - Running post-action listener: _resource_record_post_action 20:28:39 INFO - ##### 20:28:39 INFO - ##### Running download-and-extract step. 20:28:39 INFO - ##### 20:28:39 INFO - Running pre-action listener: _resource_record_pre_action 20:28:39 INFO - Running main action method: download_and_extract 20:28:39 INFO - mkdir: /builds/slave/test/build/tests 20:28:39 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')]} 20:28:39 INFO - https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:28:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json 20:28:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json 20:28:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:28:41 INFO - Downloaded 1302 bytes. 20:28:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:28:41 INFO - Using the following test package requirements: 20:28:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:28:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'jsshell-linux-x86_64.zip'], 20:28:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:28:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:28:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:28:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:28:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:28:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:28: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')]} 20:28:41 INFO - https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:44 INFO - Downloaded 21791680 bytes. 20:28:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:28:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:28:45 INFO - Return code: 0 20:28:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:45 INFO - https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:28:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:49 INFO - Downloaded 21791680 bytes. 20:28:49 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 20:28:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:49 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 20:28:50 INFO - Return code: 0 20:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:50 INFO - https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:28:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:28:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:28:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:51 INFO - Downloaded 11132001 bytes. 20:28:51 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 20:28:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:28:51 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 20:28:51 INFO - Return code: 0 20:28: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')]} 20:28:51 INFO - https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:28:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:28:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:28:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/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 20:28:53 INFO - Downloaded 57698058 bytes. 20:28:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:28:53 INFO - mkdir: /builds/slave/test/properties 20:28:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:53 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:53 INFO - Contents: 20:28:53 INFO - build_url:https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:28:53 INFO - Running post-action listener: _resource_record_post_action 20:28:53 INFO - Running post-action listener: set_extra_try_arguments 20:28:53 INFO - ##### 20:28:53 INFO - ##### Running populate-webroot step. 20:28:53 INFO - ##### 20:28:53 INFO - Running pre-action listener: _resource_record_pre_action 20:28:53 INFO - Running main action method: populate_webroot 20:28:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:28:53 INFO - '../fennec_ids.txt'], 20:28:53 INFO - 'tests': ['tcheck2']}, 20:28:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:53 INFO - '--tppagecycles', 20:28:53 INFO - '7'], 20:28:53 INFO - 'tests': ['tsvgm']}}, 20:28:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:28:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:28:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:28:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'tests': ['damp', 'tps']}, 20:28:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['damp', 'tps']}, 20:28:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:28:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:53 INFO - 'other': {'tests': ['a11yr', 20:28:53 INFO - 'ts_paint', 20:28:53 INFO - 'tpaint', 20:28:53 INFO - 'sessionrestore', 20:28:53 INFO - 'sessionrestore_no_auto_restore']}, 20:28:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['a11yr', 20:28:53 INFO - 'ts_paint', 20:28:53 INFO - 'tpaint', 20:28:53 INFO - 'sessionrestore', 20:28:53 INFO - 'sessionrestore_no_auto_restore']}, 20:28:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['a11yr', 20:28:53 INFO - 'ts_paint', 20:28:53 INFO - 'tpaint', 20:28:53 INFO - 'sessionrestore', 20:28:53 INFO - 'sessionrestore_no_auto_restore']}, 20:28:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['a11yr', 20:28:53 INFO - 'ts_paint', 20:28:53 INFO - 'tpaint', 20:28:53 INFO - 'sessionrestore', 20:28:53 INFO - 'sessionrestore_no_auto_restore']}, 20:28:53 INFO - 'other_l64': {'tests': ['a11yr', 20:28:53 INFO - 'ts_paint', 20:28:53 INFO - 'tpaint', 20:28:53 INFO - 'sessionrestore', 20:28:53 INFO - 'sessionrestore_no_auto_restore']}, 20:28:53 INFO - 'other_nol64': {'tests': ['a11yr', 20:28:53 INFO - 'ts_paint', 20:28:53 INFO - 'tpaint', 20:28:53 INFO - 'sessionrestore', 20:28:53 INFO - 'sessionrestore_no_auto_restore']}, 20:28:53 INFO - 'svgr': {'tests': ['tsvgx', 20:28:53 INFO - 'tsvgr_opacity', 20:28:53 INFO - 'tart', 20:28:53 INFO - 'tscrollx', 20:28:53 INFO - 'cart']}, 20:28:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['tsvgx', 20:28:53 INFO - 'tsvgr_opacity', 20:28:53 INFO - 'tart', 20:28:53 INFO - 'tscrollx', 20:28:53 INFO - 'cart']}, 20:28:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'tests': ['tp5o']}, 20:28:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'talos_options': ['--e10s'], 20:28:53 INFO - 'tests': ['tp5o']}, 20:28:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'talos_options': ['--xperf_path', 20:28:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:53 INFO - 'tests': ['tp5n']}, 20:28:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:53 INFO - 'talos_options': ['--e10s', 20:28:53 INFO - '--xperf_path', 20:28:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:53 INFO - 'tests': ['tp5n']}}, 20:28:53 INFO - 'talos.zip': {'path': '', 20:28:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:53 INFO - Running post-action listener: _resource_record_post_action 20:28:53 INFO - ##### 20:28:53 INFO - ##### Running create-virtualenv step. 20:28:53 INFO - ##### 20:28:53 INFO - Running pre-action listener: _resource_record_pre_action 20:28:53 INFO - Running main action method: create_virtualenv 20:28:53 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28: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 20:28:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:53 INFO - Using real prefix '/usr' 20:28:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:53 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:55 INFO - Installing pip.................done. 20:28:55 INFO - Return code: 0 20:28:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:28:55 INFO - Using env: {'DISPLAY': ':0', 20:28:55 INFO - 'HOME': '/home/cltbld', 20:28:55 INFO - 'LANG': 'en_US.UTF-8', 20:28:55 INFO - 'LANGUAGE': 'en_US:en', 20:28:55 INFO - 'LOGNAME': 'cltbld', 20:28:55 INFO - 'MAIL': '/var/mail/cltbld', 20:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:55 INFO - 'MOZ_NO_REMOTE': '1', 20:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:55 INFO - 'NO_EM_RESTART': '1', 20:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:55 INFO - 'PWD': '/builds/slave/test', 20:28:55 INFO - 'SHELL': '/bin/bash', 20:28:55 INFO - 'SHLVL': '1', 20:28:55 INFO - 'TERM': 'linux', 20:28:55 INFO - 'TMOUT': '86400', 20:28:55 INFO - 'USER': 'cltbld', 20:28:55 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:55 INFO - '_': '/tools/buildbot/bin/python'} 20:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28: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 20:28:56 INFO - Cleaning up... 20:28:56 INFO - Return code: 0 20:28:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:28: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 20:28: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 20:28:56 INFO - Using env: {'DISPLAY': ':0', 20:28:56 INFO - 'HOME': '/home/cltbld', 20:28:56 INFO - 'LANG': 'en_US.UTF-8', 20:28:56 INFO - 'LANGUAGE': 'en_US:en', 20:28:56 INFO - 'LOGNAME': 'cltbld', 20:28:56 INFO - 'MAIL': '/var/mail/cltbld', 20:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:56 INFO - 'MOZ_NO_REMOTE': '1', 20:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:56 INFO - 'NO_EM_RESTART': '1', 20:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:56 INFO - 'PWD': '/builds/slave/test', 20:28:56 INFO - 'SHELL': '/bin/bash', 20:28:56 INFO - 'SHLVL': '1', 20:28:56 INFO - 'TERM': 'linux', 20:28:56 INFO - 'TMOUT': '86400', 20:28:56 INFO - 'USER': 'cltbld', 20:28:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:56 INFO - '_': '/tools/buildbot/bin/python'} 20:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:56 INFO - Downloading/unpacking psutil>=0.7.1 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:28:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:58 INFO - Installing collected packages: psutil 20:28:58 INFO - Running setup.py install for psutil 20:28:58 INFO - building 'psutil._psutil_linux' extension 20:28: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 20:28: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 20:28:58 INFO - building 'psutil._psutil_posix' extension 20:28:58 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 20:28: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:58 INFO - Successfully installed psutil 20:28:58 INFO - Cleaning up... 20:28:58 INFO - Return code: 0 20:28:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:28:58 INFO - Using env: {'DISPLAY': ':0', 20:28:58 INFO - 'HOME': '/home/cltbld', 20:28:58 INFO - 'LANG': 'en_US.UTF-8', 20:28:58 INFO - 'LANGUAGE': 'en_US:en', 20:28:58 INFO - 'LOGNAME': 'cltbld', 20:28:58 INFO - 'MAIL': '/var/mail/cltbld', 20:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:58 INFO - 'MOZ_NO_REMOTE': '1', 20:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:58 INFO - 'NO_EM_RESTART': '1', 20:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:58 INFO - 'PWD': '/builds/slave/test', 20:28:58 INFO - 'SHELL': '/bin/bash', 20:28:58 INFO - 'SHLVL': '1', 20:28:58 INFO - 'TERM': 'linux', 20:28:58 INFO - 'TMOUT': '86400', 20:28:58 INFO - 'USER': 'cltbld', 20:28:58 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:58 INFO - '_': '/tools/buildbot/bin/python'} 20:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:29:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:29:00 INFO - Installing collected packages: mozsystemmonitor 20:29:00 INFO - Running setup.py install for mozsystemmonitor 20:29:00 INFO - Successfully installed mozsystemmonitor 20:29:00 INFO - Cleaning up... 20:29:00 INFO - Return code: 0 20:29:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:29:00 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')]} 20:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:00 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')]} 20:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:00 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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:29:00 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 20:29:00 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 20:29:00 INFO - Using env: {'DISPLAY': ':0', 20:29:00 INFO - 'HOME': '/home/cltbld', 20:29:00 INFO - 'LANG': 'en_US.UTF-8', 20:29:00 INFO - 'LANGUAGE': 'en_US:en', 20:29:00 INFO - 'LOGNAME': 'cltbld', 20:29:00 INFO - 'MAIL': '/var/mail/cltbld', 20:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:00 INFO - 'MOZ_NO_REMOTE': '1', 20:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:00 INFO - 'NO_EM_RESTART': '1', 20:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:00 INFO - 'PWD': '/builds/slave/test', 20:29:00 INFO - 'SHELL': '/bin/bash', 20:29:00 INFO - 'SHLVL': '1', 20:29:00 INFO - 'TERM': 'linux', 20:29:00 INFO - 'TMOUT': '86400', 20:29:00 INFO - 'USER': 'cltbld', 20:29:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:00 INFO - '_': '/tools/buildbot/bin/python'} 20:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:29:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:29:02 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 20:29:02 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 20:29:02 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 20:29:02 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 20:29:02 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 20:29:02 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 20:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:29:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29:03 INFO - Downloading docopt-0.6.1.tar.gz 20:29:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:29:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:29:03 INFO - Running setup.py install for blobuploader 20:29:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:29:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:29:03 INFO - Running setup.py install for requests 20:29:03 INFO - Running setup.py install for docopt 20:29:03 INFO - Successfully installed blobuploader requests docopt 20:29:03 INFO - Cleaning up... 20:29:03 INFO - Return code: 0 20:29:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:03 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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:29:03 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 20:29:03 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 20:29:03 INFO - Using env: {'DISPLAY': ':0', 20:29:03 INFO - 'HOME': '/home/cltbld', 20:29:03 INFO - 'LANG': 'en_US.UTF-8', 20:29:03 INFO - 'LANGUAGE': 'en_US:en', 20:29:03 INFO - 'LOGNAME': 'cltbld', 20:29:03 INFO - 'MAIL': '/var/mail/cltbld', 20:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:03 INFO - 'MOZ_NO_REMOTE': '1', 20:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:03 INFO - 'NO_EM_RESTART': '1', 20:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:03 INFO - 'PWD': '/builds/slave/test', 20:29:03 INFO - 'SHELL': '/bin/bash', 20:29:03 INFO - 'SHLVL': '1', 20:29:03 INFO - 'TERM': 'linux', 20:29:03 INFO - 'TMOUT': '86400', 20:29:03 INFO - 'USER': 'cltbld', 20:29:03 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:03 INFO - '_': '/tools/buildbot/bin/python'} 20:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:29:04 INFO - Running setup.py (path:/tmp/pip-7Oxl0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:29:04 INFO - Running setup.py (path:/tmp/pip-gMUFBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:29:04 INFO - Running setup.py (path:/tmp/pip-hqDUzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:29:04 INFO - Running setup.py (path:/tmp/pip-fUVey6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:29:04 INFO - Running setup.py (path:/tmp/pip-TRMqRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:29:04 INFO - Running setup.py (path:/tmp/pip-NMOik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:29:04 INFO - Running setup.py (path:/tmp/pip-zyWvOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:29:04 INFO - Running setup.py (path:/tmp/pip-Adiran-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:29:04 INFO - Running setup.py (path:/tmp/pip-qdm0_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:29:04 INFO - Running setup.py (path:/tmp/pip-ZQIiGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:29:04 INFO - Running setup.py (path:/tmp/pip-BplFD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:29:04 INFO - Running setup.py (path:/tmp/pip-IMC3q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:29:04 INFO - Running setup.py (path:/tmp/pip-9hCP2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:29:05 INFO - Running setup.py (path:/tmp/pip-yN2QYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:05 INFO - Running setup.py (path:/tmp/pip-cGTSJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:29:05 INFO - Running setup.py (path:/tmp/pip-PTTfc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:29:05 INFO - Running setup.py (path:/tmp/pip-mvF6yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:29:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:29:05 INFO - Running setup.py install for manifestparser 20:29:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozcrash 20:29:05 INFO - Running setup.py install for mozdebug 20:29:05 INFO - Running setup.py install for mozdevice 20:29:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozfile 20:29:05 INFO - Running setup.py install for mozhttpd 20:29:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozinfo 20:29:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Running setup.py install for mozInstall 20:29:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Running setup.py install for mozleak 20:29:06 INFO - Running setup.py install for mozlog 20:29:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Running setup.py install for moznetwork 20:29:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Running setup.py install for mozprocess 20:29:06 INFO - Running setup.py install for mozprofile 20:29:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Running setup.py install for mozrunner 20:29:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Running setup.py install for mozscreenshot 20:29:06 INFO - Running setup.py install for moztest 20:29:07 INFO - Running setup.py install for mozversion 20:29:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:29:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:29:07 INFO - Cleaning up... 20:29:07 INFO - Return code: 0 20:29:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:29: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')]} 20:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29: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')]} 20:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29: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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:29: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 20:29: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 20:29:07 INFO - Using env: {'DISPLAY': ':0', 20:29:07 INFO - 'HOME': '/home/cltbld', 20:29:07 INFO - 'LANG': 'en_US.UTF-8', 20:29:07 INFO - 'LANGUAGE': 'en_US:en', 20:29:07 INFO - 'LOGNAME': 'cltbld', 20:29:07 INFO - 'MAIL': '/var/mail/cltbld', 20:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:07 INFO - 'MOZ_NO_REMOTE': '1', 20:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:07 INFO - 'NO_EM_RESTART': '1', 20:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:07 INFO - 'PWD': '/builds/slave/test', 20:29:07 INFO - 'SHELL': '/bin/bash', 20:29:07 INFO - 'SHLVL': '1', 20:29:07 INFO - 'TERM': 'linux', 20:29:07 INFO - 'TMOUT': '86400', 20:29:07 INFO - 'USER': 'cltbld', 20:29:07 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:07 INFO - '_': '/tools/buildbot/bin/python'} 20:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:29:07 INFO - Running setup.py (path:/tmp/pip-ufMrGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:29:07 INFO - Running setup.py (path:/tmp/pip-wHyDc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:29:07 INFO - Running setup.py (path:/tmp/pip-HuiK5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:29:07 INFO - Running setup.py (path:/tmp/pip-Q2IZ0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:29:07 INFO - Running setup.py (path:/tmp/pip-OjdYl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:29:07 INFO - Running setup.py (path:/tmp/pip-V944_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:29:07 INFO - Running setup.py (path:/tmp/pip-U4cTYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:29:07 INFO - Running setup.py (path:/tmp/pip-KozdIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:29:07 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)) 20:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:29:07 INFO - Running setup.py (path:/tmp/pip-ngOa9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:29: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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:29:08 INFO - Running setup.py (path:/tmp/pip-ChEzKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:29: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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:29:08 INFO - Running setup.py (path:/tmp/pip-acy1VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:29: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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:29:08 INFO - Running setup.py (path:/tmp/pip-R7sJG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:29: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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:29:08 INFO - Running setup.py (path:/tmp/pip-2KhmvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:29: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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:29:08 INFO - Running setup.py (path:/tmp/pip-d35KjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:29:08 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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:08 INFO - Running setup.py (path:/tmp/pip-_RmUuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:08 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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:29:08 INFO - Running setup.py (path:/tmp/pip-rjbvo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:29:08 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)) 20:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:29:08 INFO - Running setup.py (path:/tmp/pip-pWO08r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:29:08 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)) 20:29:08 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)) 20:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:29:08 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)) 20:29:08 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)) 20:29:08 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)) 20:29:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:10 INFO - Downloading blessings-1.5.1.tar.gz 20:29: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 20:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:29:10 INFO - Installing collected packages: blessings 20:29:10 INFO - Running setup.py install for blessings 20:29:10 INFO - Successfully installed blessings 20:29:10 INFO - Cleaning up... 20:29:10 INFO - Return code: 0 20:29:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:29:10 INFO - Reading from file tmpfile_stdout 20:29:10 INFO - Current package versions: 20:29:10 INFO - argparse == 1.2.1 20:29:10 INFO - blessings == 1.5.1 20:29:10 INFO - blobuploader == 1.2.4 20:29:10 INFO - docopt == 0.6.1 20:29:10 INFO - manifestparser == 1.1 20:29:10 INFO - mozInstall == 1.12 20:29:10 INFO - mozcrash == 0.16 20:29:10 INFO - mozdebug == 0.1 20:29:10 INFO - mozdevice == 0.47 20:29:10 INFO - mozfile == 1.2 20:29:10 INFO - mozhttpd == 0.7 20:29:10 INFO - mozinfo == 0.9 20:29:10 INFO - mozleak == 0.1 20:29:10 INFO - mozlog == 3.1 20:29:10 INFO - moznetwork == 0.27 20:29:10 INFO - mozprocess == 0.22 20:29:10 INFO - mozprofile == 0.27 20:29:10 INFO - mozrunner == 6.11 20:29:10 INFO - mozscreenshot == 0.1 20:29:10 INFO - mozsystemmonitor == 0.0 20:29:10 INFO - moztest == 0.7 20:29:10 INFO - mozversion == 1.4 20:29:10 INFO - psutil == 3.1.1 20:29:10 INFO - requests == 1.2.3 20:29:10 INFO - wsgiref == 0.1.2 20:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:29:10 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 20:29:10 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 20:29:10 INFO - Using env: {'DISPLAY': ':0', 20:29:10 INFO - 'HOME': '/home/cltbld', 20:29:10 INFO - 'LANG': 'en_US.UTF-8', 20:29:10 INFO - 'LANGUAGE': 'en_US:en', 20:29:10 INFO - 'LOGNAME': 'cltbld', 20:29:10 INFO - 'MAIL': '/var/mail/cltbld', 20:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:10 INFO - 'MOZ_NO_REMOTE': '1', 20:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:10 INFO - 'NO_EM_RESTART': '1', 20:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:10 INFO - 'PWD': '/builds/slave/test', 20:29:10 INFO - 'SHELL': '/bin/bash', 20:29:10 INFO - 'SHLVL': '1', 20:29:10 INFO - 'TERM': 'linux', 20:29:10 INFO - 'TMOUT': '86400', 20:29:10 INFO - 'USER': 'cltbld', 20:29:10 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:10 INFO - '_': '/tools/buildbot/bin/python'} 20:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 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)) 20:29:10 INFO - Cleaning up... 20:29:10 INFO - Return code: 0 20:29:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:29:10 INFO - Using env: {'DISPLAY': ':0', 20:29:10 INFO - 'HOME': '/home/cltbld', 20:29:10 INFO - 'LANG': 'en_US.UTF-8', 20:29:10 INFO - 'LANGUAGE': 'en_US:en', 20:29:10 INFO - 'LOGNAME': 'cltbld', 20:29:10 INFO - 'MAIL': '/var/mail/cltbld', 20:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:10 INFO - 'MOZ_NO_REMOTE': '1', 20:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:10 INFO - 'NO_EM_RESTART': '1', 20:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:10 INFO - 'PWD': '/builds/slave/test', 20:29:10 INFO - 'SHELL': '/bin/bash', 20:29:10 INFO - 'SHLVL': '1', 20:29:10 INFO - 'TERM': 'linux', 20:29:10 INFO - 'TMOUT': '86400', 20:29:10 INFO - 'USER': 'cltbld', 20:29:10 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:10 INFO - '_': '/tools/buildbot/bin/python'} 20:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:11 INFO - Downloading/unpacking jsonschema 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:29:12 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 20:29:12 INFO - Downloading/unpacking functools32 (from jsonschema) 20:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:29: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 20:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:29:13 INFO - warning: no files found matching '*.txt' 20:29:13 INFO - no previously-included directories found matching 'build' 20:29:13 INFO - no previously-included directories found matching 'dist' 20:29:13 INFO - no previously-included directories found matching '.git*' 20:29:13 INFO - Installing collected packages: jsonschema, functools32 20:29:13 INFO - Running setup.py install for functools32 20:29:13 INFO - warning: no files found matching '*.txt' 20:29:13 INFO - no previously-included directories found matching 'build' 20:29:13 INFO - no previously-included directories found matching 'dist' 20:29:13 INFO - no previously-included directories found matching '.git*' 20:29:13 INFO - Successfully installed jsonschema functools32 20:29:13 INFO - Cleaning up... 20:29:13 INFO - Return code: 0 20:29:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:29: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')]} 20:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29: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')]} 20:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29: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 0x7f782d4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, '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': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', '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 20:29: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 20:29: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 20:29:13 INFO - Using env: {'DISPLAY': ':0', 20:29:13 INFO - 'HOME': '/home/cltbld', 20:29:13 INFO - 'LANG': 'en_US.UTF-8', 20:29:13 INFO - 'LANGUAGE': 'en_US:en', 20:29:13 INFO - 'LOGNAME': 'cltbld', 20:29:13 INFO - 'MAIL': '/var/mail/cltbld', 20:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:13 INFO - 'MOZ_NO_REMOTE': '1', 20:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:13 INFO - 'NO_EM_RESTART': '1', 20:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:13 INFO - 'PWD': '/builds/slave/test', 20:29:13 INFO - 'SHELL': '/bin/bash', 20:29:13 INFO - 'SHLVL': '1', 20:29:13 INFO - 'TERM': 'linux', 20:29:13 INFO - 'TMOUT': '86400', 20:29:13 INFO - 'USER': 'cltbld', 20:29:13 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:13 INFO - '_': '/tools/buildbot/bin/python'} 20:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:13 INFO - Downloading/unpacking flake8 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:29: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 20:29:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:29:15 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 20:29:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29:15 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 20:29:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:29:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:29:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:29:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:29:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:29:15 INFO - no previously-included directories found matching 'docs/_build' 20:29:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:29:15 INFO - Running setup.py install for pep8 20:29:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:29:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:29:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:29:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:29:16 INFO - no previously-included directories found matching 'docs/_build' 20:29:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:29:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:29:16 INFO - Cleaning up... 20:29:16 INFO - Return code: 0 20:29:16 INFO - Running post-action listener: _resource_record_post_action 20:29:16 INFO - Running post-action listener: _start_resource_monitoring 20:29:16 INFO - Starting resource monitoring. 20:29:16 INFO - ##### 20:29:16 INFO - ##### Running install step. 20:29:16 INFO - ##### 20:29:16 INFO - Running pre-action listener: _resource_record_pre_action 20:29:16 INFO - Running main action method: install 20:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:29:16 INFO - Reading from file tmpfile_stdout 20:29:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:29:16 INFO - Reading from file tmpfile_stdout 20:29:16 INFO - Output received: 20:29:16 INFO - Usage: mozinstall [options] installer 20:29:16 INFO - Options: 20:29:16 INFO - -h, --help show this help message and exit 20:29:16 INFO - -d DEST, --destination=DEST 20:29:16 INFO - Directory to install application into. [default: 20:29:16 INFO - "/builds/slave/test"] 20:29:16 INFO - --app=APP Application being installed. [default: firefox] 20:29:16 INFO - mkdir: /builds/slave/test/build/application 20:29:16 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'] 20:29:16 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 20:29:30 INFO - Reading from file tmpfile_stdout 20:29:30 INFO - Output received: 20:29:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:29:30 INFO - Running post-action listener: _resource_record_post_action 20:29:30 INFO - ##### 20:29:30 INFO - ##### Running run-tests step. 20:29:30 INFO - ##### 20:29:30 INFO - Running pre-action listener: _resource_record_pre_action 20:29:30 INFO - Running main action method: run_tests 20:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:29:30 INFO - Python 2.7.3 20:29:30 INFO - Return code: 0 20:29:30 INFO - grabbing minidump binary from tooltool 20:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:30 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 0x22600b0>, '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 0x2260fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2261440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:29:30 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 20:29:30 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 20:29:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:29:31 INFO - Return code: 0 20:29:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:29:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:29:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:29:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:29:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:29:31 INFO - Return code: 0 20:29:31 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/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test/build 20:29:31 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/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 20:29:31 INFO - Using env: {'DISPLAY': ':0', 20:29:31 INFO - 'HOME': '/home/cltbld', 20:29:31 INFO - 'LANG': 'en_US.UTF-8', 20:29:31 INFO - 'LANGUAGE': 'en_US:en', 20:29:31 INFO - 'LOGNAME': 'cltbld', 20:29:31 INFO - 'MAIL': '/var/mail/cltbld', 20:29:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:29:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:31 INFO - 'MOZ_NO_REMOTE': '1', 20:29:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:31 INFO - 'NO_EM_RESTART': '1', 20:29:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:31 INFO - 'PWD': '/builds/slave/test', 20:29:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:29:31 INFO - 'SHELL': '/bin/bash', 20:29:31 INFO - 'SHLVL': '1', 20:29:31 INFO - 'TERM': 'linux', 20:29:31 INFO - 'TMOUT': '86400', 20:29:31 INFO - 'USER': 'cltbld', 20:29:31 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345', 20:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:31 INFO - '_': '/tools/buildbot/bin/python'} 20:29:31 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/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 20:29:32 INFO - mozversion INFO | application_buildid: 20151203200117 20:29:32 INFO - mozversion INFO | application_changeset: f70ee6e84e82ec22a16f33c6a3f3da3402a36272 20:29:32 INFO - mozversion INFO | application_display_name: Nightly 20:29:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:29:32 INFO - mozversion INFO | application_name: Firefox 20:29:32 INFO - mozversion INFO | application_remotingname: firefox 20:29:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:29:32 INFO - mozversion INFO | application_vendor: Mozilla 20:29:32 INFO - mozversion INFO | application_version: 45.0a1 20:29:32 INFO - mozversion INFO | platform_buildid: 20151203200117 20:29:32 INFO - mozversion INFO | platform_changeset: f70ee6e84e82ec22a16f33c6a3f3da3402a36272 20:29:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:29:32 INFO - mozversion INFO | platform_version: 45.0a1 20:29:32 INFO - 2015-12-03 20:29:32,155 DEBUG : using testdate: 1449203372 20:29:32 INFO - 2015-12-03 20:29:32,155 DEBUG : actual date: 1449203372 20:29:32 INFO - 2015-12-03 20:29:32,166 INFO : starting webserver on 'localhost:50536' 20:29:32 INFO - 2015-12-03 20:29:32,167 INFO : Starting test suite talos-linux64-ix-045.e 20:29:32 INFO - 2015-12-03 20:29:32,167 INFO : Starting test dromaeo_css 20:29:32 INFO - 2015-12-03 20:29:32,167 DEBUG : operating with platform_type : linux_ 20:29:32 INFO - 2015-12-03 20:29:32,168 INFO : Initialising browser for dromaeo_css test... 20:29:32 INFO - 2015-12-03 20:29:32,183 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsZkfL5/profile http://localhost:50536/getInfo.html 20:29:36 INFO - 2015-12-03 20:29:36,852 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:29:36 INFO - 2015-12-03 20:29:36,853 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:29:36 INFO - 2015-12-03 20:29:36,853 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:29:36 INFO - 2015-12-03 20:29:36,853 DEBUG : BROWSER_OUTPUT: __metrics 20:29:36 INFO - 2015-12-03 20:29:36,970 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] 20:29:37 INFO - 2015-12-03 20:29:37,929 INFO : Browser initialized. 20:29:37 INFO - 2015-12-03 20:29:37,930 INFO : Running cycle 1/1 for dromaeo_css test... 20:29:37 INFO - 2015-12-03 20:29:37,930 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsZkfL5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:29:49 INFO - 2015-12-03 20:29:49,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 142888960 20:29:49 INFO - 2015-12-03 20:29:49,891 DEBUG : BROWSER_OUTPUT: 20:30:39 INFO - 2015-12-03 20:30:39,512 DEBUG : BROWSER_OUTPUT: 1449203439511 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] 20:32:51 INFO - 2015-12-03 20:32:51,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50536/tests/dromaeo/cssquery-ext.html) 20:32:52 INFO - 2015-12-03 20:32:52,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 146350080 20:32:52 INFO - 2015-12-03 20:32:52,711 DEBUG : BROWSER_OUTPUT: 20:35:54 INFO - 2015-12-03 20:35:54,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/dromaeo/cssquery-ext.html (next: http://localhost:50536/tests/dromaeo/cssquery-jquery.html) 20:35:55 INFO - 2015-12-03 20:35:55,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 144224256 20:35:55 INFO - 2015-12-03 20:35:55,363 DEBUG : BROWSER_OUTPUT: 20:38:57 INFO - 2015-12-03 20:38:57,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50536/tests/dromaeo/cssquery-mootools.html) 20:38:57 INFO - 2015-12-03 20:38:57,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 145711104 20:38:57 INFO - 2015-12-03 20:38:57,795 DEBUG : BROWSER_OUTPUT: 20:41:59 INFO - 2015-12-03 20:41:59,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50536/tests/dromaeo/cssquery-prototype.html) 20:42:00 INFO - 2015-12-03 20:42:00,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 144547840 20:42:00 INFO - 2015-12-03 20:42:00,168 DEBUG : BROWSER_OUTPUT: 20:45:02 INFO - 2015-12-03 20:45:02,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50536/tests/dromaeo/cssquery-yui.html) 20:45:03 INFO - 2015-12-03 20:45:03,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 145539072 20:45:03 INFO - 2015-12-03 20:45:03,406 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/dromaeo/cssquery-yui.html (next: http://localhost:50536/tests/dromaeo/cssquery-dojo.html) 20:48:05 INFO - 2015-12-03 20:48:05,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 147791872 20:48:05 INFO - 2015-12-03 20:48:05,899 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2626.5797472404415;2710.810243282971;2712.64735584374;2716.0493827160494;2726.40019195777;4617.930731039037;4756.595689366408;4769.451513075997;4778.020505796312;4811.494793046728;4698.060387922412;4736.12381709384;4737.526247375261;4807.831725889595;4827.444843842959;4357.259265924785;4373.147236288909;4526.026904215593;4526.366308716782;4563.178627846986;4234.703570750049;4381.868543943687;4421.137878113769;4442.400275962736;4532.410786597754;4332.891677708067;4340.565943405666;4436.64506839452;4447.332900064984;4457.108578284357;4367.54140815213;4409.0520538084465;4410.029793445437;4418.293073108287;4477.6417886569;4207.284761590537;4325.82696692132;4380.255356589388;4406;4447.799849006802;4599.448066232074;4661.207594708908;4693.366395536627;4698.718076915396;4722.338872557844;5119.334486516729;5145.6398052136365;5156.819511317123;5159.767810448501;5211.7133557654315;4941.752912354404;5045.243213517965;5077.746112694387;5180.326557547494;5235.790568377261;4820.325154478376;4827.179379505527;4830.95169048305;4831.95168048322;4881.95118048822;5286.577073834084;5303.893922121536;5311.840644780663;5311.920321195185;5318.521333079964;4747.881302967454;4855.344528488679;4974.0797952378925;5072.112380333427;5088.440271570124;5084.593232541388;5090.567301779316;5104.795808167706;5117.718525481134;5149.253358263031;5027.84916452507;5031;5036.395632524121;5042.369703787027;5048.066107770074;4780.067886762048;4877.122118018719;4968.329275547827;5035.748212589356;5080.822171224063;4194.370844373308;4213.768242746617;4219.746815191098;4231.132617813341;4259.829606815692;3643.143861192618;3704.81475926208;3722.4788529605876;3726.124360775216;3733.51464309638;4343;4376.124775045004;4467.106578684276;4478.171538265431;4524.5927866492175;5111.284420181178;5155.175171972466;5156.097682905476;5170.327857378592;5211.140161873324;4231.4710661167355;4309.267424537836;4442.244818380883;4464.508904020555;4498.59512643857;4430.335449682509;4481.327800829901;4516.36770852081;4527.1398434298035;4583.381243532081;4799.208130658472;4824.300476430828;4844.176489996779;4870.366852309177;4908.312836202863;4913.1893237615395;5008.974955125201;5067.239914012927;5115.15599926023;5164.7934082636275;4852.611791056636;4878.658493905393;4882.902341953212;4910.263460480956;4955.876103097451;5068.82259120929;5079.3904731430985;5081.949180508148;5085.110105731556;5090.287359769709;4918.655694101379;5025.522575355335;5043.747812609428;5137.409197942285;5228.189630607262;4889.315495830658;4908.828191013297;4920.704757714549;4948.480409557089;4949.33184020167;4898.82854100119;4922.852314430573;4932.950670493249;4935.235038569028;4949.579285760607;4642.976785116053;4699.318598803086;4766.880827979189;4770.141374552614;4784.306275590089;4956;4979.228219625964;4999.150144475375;5042.697438153723;5061.898762024813;4664.090502352009;4906.313116163811;4925.950740492693;4927.852164435073;4932.358793356841 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.1035078348468;561.9915701264482;572.3046498504318;579.9710014499275;585.6456843609619;37024.25951480969;37266.44100338497;37345.62654373456;37383.62616373839;37638.623613763855;41156.79421602895;41717;41746.165076698446;41772.791136044274;41814.79092604533;7899.210078992112;7996.880046799302;8058.476199047043;8067.072286687047;8067.3546116310845;7763.107242667081;7865.803354916145;7915.722949696762;7919.960400197991;7922.643481043338;7939.603019849013;7953.840923181533;8005.039395272575;8033.277005069543;8051.798705032392;7856.332211762007;7905;7929.167437419074;7942.404319676048;7965.482243654202;7811.804704882366;7929.246721561442;7929.32600728933;7950;7966.960165199195;37018.8149059253;37607.435888461696;37637.81181094104;37673.43489847627;37767.24465510702;2399.3881560202035;2748.8833598129327;2870.1389583125188;2955.9556606650917;3710.18375957289;27210.31974200641;27380.863095684395;27760.444791104266;27770.583441248396;27802.582961255597;3144.827034513101;3175.5712978748033;3223.9677603224136;3247.707706306444;3268.705816476505;202285;202542;203035.98482007644;203418;203668;38801.6119838798;38866.61133388687;54075.72962135164;54511;54642.72678636581;38353;38360.42459363112;38526;38533.807330963165;38684.61315386866;12148.514059437524;12159.574414895436;12162.452689628988;12337.568185113478;12362;9605;9683.612655493842;9694.806103877883;9701.07839755222;9712.70861874145;13109.541166059142;13602.727945441036;13614.863851361557;13710.38303276355;13727.382267797973;5417.268668729671;5613.635113717595;5616.241807356037;5644.5484361251;5656.91514627281;854.2013217641525;887.0175158520701;993.4287784523927;999.2156157416393;1046.3146638951498;25961.480770384485;26156.86921565418;26491.602625960626;26739.197824065308;26847.463050739265;907.7957459571544;980.7842274699555;987.7036888933292;1028.4806172882647;1072.6353039966293;13696.315184240748;13833.308334583231;13888;13921.651958701113;14009.789853152211;276257;281157;281580;282285;283385;46042;46302.305465418045;46376.768116159205;46467.30299045517;46641;1197.4012993503247;1200.8198770184542;1201.2912381694841;1208.6857417071624;1221.1818081885158;25557.3610659735;25785.742142579085;26366.868165659816;26396;26452.206433807016;40390.59609403869;40514;40671.59328406678;40765.592344076176;40864.591354087264;256479;258225;258730;258937;259237;29403.41193176167;30124.24689382783;42331.3650295252;42393.788031059645;43221.3516797242;40480.59519404768;40534;40688;40753.796231018656;41516.79241603773;34224.82887585546;34642.65357346394;34646.30707385889;34782.304353913285;35321.408216932665;34794;35062;35307.117322067155;35608;35728.82135589409;34471.655283446846;34563.30873382468;34920.65079349174;35080.298394032485;35088.64911350956;29876.402471950005;31421.52867707032;31995.680043200202;32117.839410802797;32345.676543234265;21931.561368772214;22013.738646673948;22066.44833879166;22099.779002210416;22271.220507282167 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.8542655804887;329.6626915171434;331.3670888602769;334.74057605355847;337.4802803682329;15138.091714497124;15591.688166236683;15851.445199418009;16002.359905603791;16666.58333541662;9765.414075155479;9919.603215871375;12666.17669851459;14053.71892562148;14142.363593638285;4473.373727678128;4575.519570445089;4579.290210017452;4966.304717339575;5131.255967884655;5067.239914012891;5101.0308041472;5102.489751024887;5104.617153713468;5111.488851114896;4851.466338702739;5001.774920128585;5015.824446144386;5095.133827249377;5357.223202635615;4993.950060499385;5017.899642007158;5037.949620503785;5062.417821950486;5080.669756465818;5048.62135339851;5064.392272927273;5070.2141168119;5072.568831649277;5087.211482220262;11117.166212534012;11302.886971130265;14755.77866332006;17810.732839007425;17830.19764110618;1725.5513566472682;1765.761622181015;1814.3377667151526;1824.9908750456295;1883.2937648381858;8311.293540049102;8888.688895888612;9218.769530761785;9299.76750581234;10258.281920265585;1766.1169415292354;1782.7860656721277;1795.8114397988154;1797.2002458905793;1815.5733402650367;48749.26876096861;50665.746671266774;51226.743866280805;55266;57770.71114644442;9331.113544213289;9656.420614762996;9688.46713430754;9719.222462203006;9753.268504862022;12194.146409751409;12199.085068619888;12206.328651924052;12212;12213.206141600767;6672.499562532829;6979.371856532936;7088.326608972139;7120.145582530129;7126.0379848720795;6631.171103612049;6664.900026499607;6685.431738302299;6723.058771771955;6750.628715420699;4158.896027599334;4219.873403797891;4232.4286221360335;4245.724027938174;4255.021345090647;1638.3037209186286;1724;1768.628587996535;1777.5911540345792;1780.6349698312074;798.2050314715094;836.3267569606404;858.6050416808213;900.2527901841456;910.8770316007386;13465.932670336586;14400.063995840237;14503.927480362741;15151;15833.52499425019;775.0350813237555;822.5442451597586;870.9956450217835;877.5042101212795;882.9646814127491;8552.828943421222;8641.56792160402;8643.654253829902;8673.826523469621;8712.085231050774;465018;466136;467403;468465;474173;70341.29658703347;75013.62493187499;75239.62380188065;75271.24728752642;77880.22119778843;1064.8402739589123;1066.2962444786249;1081.5835903177333;1086.1093902999464;1086.3481910853425;13844.515441959484;13928.373223204777;13946.860531394555;15247.771283430535;15328.923355383151;29935.850320748257;30083;30313.393732125674;31404.685953141092;32002;38834.41748373833;39264.2147157061;39878.20243595054;40038;42932.921372469566;8885.644574217218;8900.376973612045;8910.198082172636;8948.239399651102;8969.820603587761;13443.86556134426;16304.755428668343;16455;16568.751468727736;16907.66184676275;12444.253344799341;13103.2138071716;13288.933555332162;13566.253856038013;13756.380962856496;12628.558000469939;12732.872671273539;12901.870981290067;13253;13311.267880266678;13263.535776247785;13464.461421543028;13507.527236546674;13778.65553361174;13807.447702091804;8615.267702245379;8688.39181257306;8790.384673072824;8810.823783524165;8854.468731876108;10265.384076955406;12350.258984460961;12728.427220774902;12937.611871643865;13054.412551435398 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1450.9129452232874;1648.694991426586;1688.5609741467222;1690.2140504665329;1722.3024675006623;5996.220491336131;6047.969760151204;6957.965210173948;7538.962305188473;7544.3587295079915;7044.33078857509;7159.248278930715;7213.747518836842;7242.891356629655;7255.782326530212;2097.465146387673;2136.1241890824685;2144.8391370647187;2147.5168087180336;2162.4918144236094;2110.7256056712604;2132.1577976699273;2136.3590922723197;2142.2716276466;2146.195176808697;2100.884451355175;2100.9369718908456;2129.55279391328;2138.615049291127;2141.122139922632;2094.968575471369;2104.7684754676975;2109.5886302171084;2114.9788502114934;2118.0998075817715;2112.4296439961277;2190.8575942563684;2191.605511008018;2193.6161171795034;2196.6924630551734;7280.38116760076;7354.1542722587055;7368.300011498899;7386.482946193769;7391.186969433358;4260.7656578888145;4324.502682191557;4329.631981281595;4342.544032876534;4347.847825326098;2353.8940747666397;2409.8915548800346;2806.3685670723926;2853.372258103235;2863.914082577526;878.4246318661287;887.4143065576689;898.3666515106834;907.1336873285996;940.83535381308;9139.314551408672;9237.445753254759;9241.537923103819;9265.72202833916;9272.072792720674;3975.8807235782974;4035.9798201009394;4061.817218225187;4067.186562687474;4073.7148399612333;8581.570921453902;8655.437396569203;8661.047284798668;8712.259457946146;8725.520096394632;4356.586124318248;4360.280553708666;4362.585554372329;4381.802818873159;4400.779961001937;3941.664958478504;3973.523177218752;3981.1639555693628;3990.461287726178;3995.5604883462797;3289.1283809790425;3295.9340813183603;3309.7848639838335;3322.3853587086464;3324.1191084362663;1064.5050051725984;1065.515190588296;1068.7274744939991;1072.6674730833467;1075.843468271611;922.0318665401302;923.7459698582943;1131.4625552862324;1150.4362862197631;1157.3287493253893;6830.624315662686;6888.173419189629;6897.586144831326;6932.480063995221;6954.40887524556;427.6941986479682;429.4009856250513;438.5745826548243;439.20723094814167;439.76252823474965;5253.973730131325;5294.814681486129;5299.205119232069;5306.708131052829;5312.1766126250495;7560.130584982688;7698.538087714755;8531.701390451304;8573.799668046478;8665.090165532654;8585.098564650747;8598;8606.397552171287;8614.138586141462;8644.092370301028;6307.5269354798575;6365.14070600463;6378.840528986812;6381.170447841843;6435.09908612804;6511.837204069936;6519.054737063005;6521.9673901630185;6537.248216455168;6556.541042127005;7546.962265188639;7687.385009199363;7702.191269916802;7776.611169441619;7789;7739.071311442663;7826.373890088666;8116.107228205011;8153.6738530458115;8222;6120.357362476876;6129.049997250433;6145.0782382642965;6180.443760061616;6184.319724830355;6789.966050169915;6856.794296171123;6860.073890024983;6871.518993670595;6874.793756187322;6226.377362263737;6342.619442833445;6366.076918846648;6390.616563006234;6439.935600644121;6218.284897236876;6359.07793369968;6361.568647054561;6443.291237963914;6451.967740161269;6375.553711240169;6408.487321014214;6411.166548348685;6421.518386120966;6423.710933008119;5923.763049477972;5969.04495280753;5976.103584462366;5986.610870293417;6000.189974353581;6049.969750151221;6087.573869829246;6116.510679145568;6204.968975155095;6206.596571222856 20:48:05 INFO - 2015-12-03 20:48:05,900 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.8813013231347;284.13622587334504;285.04367845877067;286.83076984579105;289.39083229801264;5466.835994920149;5598.944010559893;5616;5658.43415658434;5660.801871934483;5611.2144299798065;5616.550675945925;5626;5629;5648.322201335845;4323.891902702434;4333.458317710286;4336.436263285768;4343.78281085946;4345.152695224432;4329.653627709791;4341.261985462479;4344.565543445662;4350.825966961318;4351.303791393378;4198.538160802309;4268.210381079494;4282.850100246492;4291.570842915715;4295.291276939317;4263.126059157865;4267.466566679165;4275.8075886585175;4276.059266961263;4280.850170244026;3708.072981754561;3719.0888232382968;3727.981360093182;3730.198007428416;3730.7015438765106;5405.324334458192;5419.241306217133;5428.728563571805;5434.592405569598;5451.291332126798;4570.817167313304;4650.9767451162525;4920.163572192736;4930.112579735646;4936.037472692827;5732.082866741343;5833.32916714579;5861.3552509223955;5868.354481007086;5885.440883116097;3974.0859602291634;3976.880693579197;3978.8607398740905;3980.5820388859042;3982.263281292941;6160.907586386208;6169.568130230886;6180.9381906180815;6184.319724830265;6188.659623720693;3844.7116466265143;3966.504186976628;3968.3849003404516;4081.714280000431;4093.815778289984;3999.9400008999887;4001.659858912025;4014.277430062617;4015.658669013108;4018.9196216075516;4708.4820669726305;4725.29120631908;4725.314829349725;4725.787339569728;4731.793392684844;5738.340090889517;5785.247917770663;5795.739191736382;5807.477327040502;5809.535237181015;1381.4336122189854;1383.1700979412474;1409.6757745718542;1410.104583589428;1427.586000059971;918.9356745027918;928.1878356438117;935.569637966543;938.2494004796135;939.8731171291788;5035.269885866529;5102.923456148161;5130.281760553526;5132;5147.0992576298995;6048.5483483963535;6069.848253793691;6076.635401875901;6079.848003799941;6165.167702360124;5078.365204349457;5101.132807422673;5117.590592752571;5127.256547800548;5131.692098474104;3224.9032529024166;3256.6580509046685;3265.6571060038355;3271.9672803272138;3302.53764472974;5675.829725108253;5707.086866101404;5721.856953576111;5722.542196624343;5724.77100915967;6215.720292586844;6236.501079913596;6250.15622890913;6256.405641464054;6257.499400047986;5615;5709.000924838137;5729.8567535811935;5731.512821410143;5732.426757324234;5990.700464976647;6033.758649653964;6041.154238406539;6046.818595442144;6080.7567697291615;5940.257467816523;5940.55445841555;5941.881162376815;5944;5954;5658.519025882846;5706.42935706426;5709.714514274353;5712.400197979152;5718.199452076796;3852.3643598807002;3963.56400795918;3974.7018973577674;4001.079751657077;4010.538788039413;6014.278286605635;6085.4523092921845;6141.692915354125;6150.507959363151;6152.354002829638;5873.853153671193;5899.705014749331;5904.734286957011;5941.851453713692;5941.9405805943115;5887.970560147171;5908.881822363614;5916.142159386779;5921.378255283305;5921.851953701192;5639.887202256014;5769.711514424346;5778.248827652378;5779.393163717749;5801.071828507418;5903.439173278532;5944.5838791284195;5944.851378715567;5962;5982.49148822355;5795.391483894299;5806.1000544915605;5806.65160090396;5817.94182058174;5830.7959221427045 20:48:05 INFO - 2015-12-03 20:48:05,901 DEBUG : BROWSER_OUTPUT: |5;yui.html;713.9500234983551;727.8871774874895;732.6300218389713;749.269462274283;791.6793698552085;11308.264962777424;11431;11448;11479.885201147996;11485.196036277453;11625.941870290659;12880.67798305043;13068.869311306884;13096.083274170813;13136.21182729037;793.6507936507918;797.696875187428;808.1837344282288;815.0219736316415;815.8123631564744;807.7294106474309;809.3080416244114;816.7549735079452;817.1828171828172;818.8526065308242;839.1566475691922;846.2130218896424;846.7629063862129;847.5084451018395;849.0957130655831;842.0737189092011;842.2461896602567;842.389267780857;843.5866425451516;844.0546587821648;624.9093881387173;625.2059883947361;627.2473032361139;628.779927025542;630.4357599948021;12443.937780311131;12471.189372690746;12503.624891253186;12514.249145051326;12638.55765048219;10300.690979270634;10481.737956551071;11134.220604557684;11388.601398950997;11424.771504569946;8931.151540603632;9237.49193794341;9239.380309845077;9322.533873306375;9453.858192127123;3210.2295449092285;3261.8858339957987;3269.1500209945348;3274.214188594744;3278.8196649184283;40796.59203407987;41041.58958410408;41152;41397.58602413998;41630.58369416327;8593.742187734379;8765.517896515752;8775.956120219358;8817.911820881709;8899.832209767648;16128.354865805471;16148.273327700046;16254.106024168548;16259.674806504041;16286.185690715654;6304.936950630435;6408.231012278463;6444.387783160592;6461.25695545009;6519.217693876671;3444.51776751255;3484.1638006878675;3495.178633021238;3514.191735900757;3551.520544726429;2629.9605505917425;2661.4544018476167;2663.2276639774636;2664.9067282645015;2679.4775018871524;486.0255188347341;492.1657790045838;492.58376671712347;496.7268002598556;503.98992020160125;391.6240409207193;485.3505199478078;549.5027000564495;569.63827969239;574.319431473705;6682.9331706682315;6892.862142757117;7066.470014748915;7197.940894956866;7208.4954053216825;469.29137003124845;565.3046752494455;568.7071158353451;574.7586013874183;577.9855503612443;3218.5333126696964;3482.425399809003;3483.7216003656476;3519.0674471265133;3567.7324200685052;50107.74946125246;50589.74705126451;50672.74663626658;50896.74551627218;51008.23487647688;45125.77437112859;46191.538084619395;46683.29975050377;46826.531734682896;47153;38974.271800974224;39179.21641567153;39828.402573961415;40646.796766016574;41056.79471602623;7572.962135189288;7701.345385642283;8029.879551806845;8164.7958801030445;8525.899177230014;32915.50626740649;33143;33237.16907077342;33279.833600831844;33522.99431017073;40301.596984029784;40797.38803918003;41662.791686041375;41790.582094178666;42405.363919540614;9738.464384458923;10013.246357251814;10217.1826253901;10256.53845576936;10388.42863642507;10628.84056739165;10841.241113122005;10843.024127828217;11001.944990275317;11345.319280843176;10331.535080921527;10554;10586.682399528027;10750.46247687628;10893.455327233765;10647.148228141885;10710.625128120479;10736.570537178426;10769;10783.568657253621;9950.651727189514;10030.949845250727;10089.848652270368;10141.951611463297;10261.692149235534;8849.91150088491;9297.252273245598;9325.953370233105;9377.343585948918;9570.760730981781;8955.865662014945;9196.264298855942;9299.401523664297;9320.580573874327;9408.153266206074 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,334 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: __startTimestamp1449204485893__endTimestamp 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,902 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4703.27 Median:4830.95 stddev:495.81 (10.3%) stddev-sans-first:469.81 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: Values: 2626.6 2710.8 2712.6 2716.0 2726.4 4617.9 4756.6 4769.5 4778.0 4811.5 4698.1 4736.1 4737.5 4807.8 4827.4 4357.3 4373.1 4526.0 4526.4 4563.2 4234.7 4381.9 4421.1 4442.4 4532.4 4332.9 4340.6 4436.6 4447.3 4457.1 4367.5 4409.1 4410.0 4418.3 4477.6 4207.3 4325.8 4380.3 4406.0 4447.8 4599.4 4661.2 4693.4 4698.7 4722.3 5119.3 5145.6 5156.8 5159.8 5211.7 4941.8 5045.2 5077.7 5180.3 5235.8 4820.3 4827.2 4831.0 4832.0 4882.0 5286.6 5303.9 5311.8 5311.9 5318.5 4747.9 4855.3 4974.1 5072.1 5088.4 5084.6 5090.6 5104.8 5117.7 5149.3 5027.8 5031.0 5036.4 5042.4 5048.1 4780.1 4877.1 4968.3 5035.7 5080.8 4194.4 4213.8 4219.7 4231.1 4259.8 3643.1 3704.8 3722.5 3726.1 3733.5 4343.0 4376.1 4467.1 4478.2 4524.6 5111.3 5155.2 5156.1 5170.3 5211.1 4231.5 4309.3 4442.2 4464.5 4498.6 4430.3 4481.3 4516.4 4527.1 4583.4 4799.2 4824.3 4844.2 4870.4 4908.3 4913.2 5009.0 5067.2 5115.2 5164.8 4852.6 4878.7 4882.9 4910.3 4955.9 5068.8 5079.4 5081.9 5085.1 5090.3 4918.7 5025.5 5043.7 5137.4 5228.2 4889.3 4908.8 4920.7 4948.5 4949.3 4898.8 4922.9 4933.0 4935.2 4949.6 4643.0 4699.3 4766.9 4770.1 4784.3 4956.0 4979.2 4999.2 5042.7 5061.9 4664.1 4906.3 4926.0 4927.9 4932.4 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40385.30 Median:20367.22 stddev:65104.22 (319.7%) stddev-sans-first:65218.16 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: Values: 555.1 562.0 572.3 580.0 585.6 37024.3 37266.4 37345.6 37383.6 37638.6 41156.8 41717.0 41746.2 41772.8 41814.8 7899.2 7996.9 8058.5 8067.1 8067.4 7763.1 7865.8 7915.7 7920.0 7922.6 7939.6 7953.8 8005.0 8033.3 8051.8 7856.3 7905.0 7929.2 7942.4 7965.5 7811.8 7929.2 7929.3 7950.0 7967.0 37018.8 37607.4 37637.8 37673.4 37767.2 2399.4 2748.9 2870.1 2956.0 3710.2 27210.3 27380.9 27760.4 27770.6 27802.6 3144.8 3175.6 3224.0 3247.7 3268.7 202285.0 202542.0 203036.0 203418.0 203668.0 38801.6 38866.6 54075.7 54511.0 54642.7 38353.0 38360.4 38526.0 38533.8 38684.6 12148.5 12159.6 12162.5 12337.6 12362.0 9605.0 9683.6 9694.8 9701.1 9712.7 13109.5 13602.7 13614.9 13710.4 13727.4 5417.3 5613.6 5616.2 5644.5 5656.9 854.2 887.0 993.4 999.2 1046.3 25961.5 26156.9 26491.6 26739.2 26847.5 907.8 980.8 987.7 1028.5 1072.6 13696.3 13833.3 13888.0 13921.7 14009.8 276257.0 281157.0 281580.0 282285.0 283385.0 46042.0 46302.3 46376.8 46467.3 46641.0 1197.4 1200.8 1201.3 1208.7 1221.2 25557.4 25785.7 26366.9 26396.0 26452.2 40390.6 40514.0 40671.6 40765.6 40864.6 256479.0 258225.0 258730.0 258937.0 259237.0 29403.4 30124.2 42331.4 42393.8 43221.4 40480.6 40534.0 40688.0 40753.8 41516.8 34224.8 34642.7 34646.3 34782.3 35321.4 34794.0 35062.0 35307.1 35608.0 35728.8 34471.7 34563.3 34920.7 35080.3 35088.6 29876.4 31421.5 31995.7 32117.8 32345.7 21931.6 22013.7 22066.4 22099.8 22271.2 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25416.68 Median:4239.08 stddev:76541.82 (1805.6%) stddev-sans-first:76733.35 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: Values: 323.9 329.7 331.4 334.7 337.5 15138.1 15591.7 15851.4 16002.4 16666.6 9765.4 9919.6 12666.2 14053.7 14142.4 4473.4 4575.5 4579.3 4966.3 5131.3 5067.2 5101.0 5102.5 5104.6 5111.5 4851.5 5001.8 5015.8 5095.1 5357.2 4994.0 5017.9 5037.9 5062.4 5080.7 5048.6 5064.4 5070.2 5072.6 5087.2 11117.2 11302.9 14755.8 17810.7 17830.2 1725.6 1765.8 1814.3 1825.0 1883.3 8311.3 8888.7 9218.8 9299.8 10258.3 1766.1 1782.8 1795.8 1797.2 1815.6 48749.3 50665.7 51226.7 55266.0 57770.7 9331.1 9656.4 9688.5 9719.2 9753.3 12194.1 12199.1 12206.3 12212.0 12213.2 6672.5 6979.4 7088.3 7120.1 7126.0 6631.2 6664.9 6685.4 6723.1 6750.6 4158.9 4219.9 4232.4 4245.7 4255.0 1638.3 1724.0 1768.6 1777.6 1780.6 798.2 836.3 858.6 900.3 910.9 13465.9 14400.1 14503.9 15151.0 15833.5 775.0 822.5 871.0 877.5 883.0 8552.8 8641.6 8643.7 8673.8 8712.1 465018.0 466136.0 467403.0 468465.0 474173.0 70341.3 75013.6 75239.6 75271.2 77880.2 1064.8 1066.3 1081.6 1086.1 1086.3 13844.5 13928.4 13946.9 15247.8 15328.9 29935.9 30083.0 30313.4 31404.7 32002.0 38834.4 39264.2 39878.2 40038.0 42932.9 8885.6 8900.4 8910.2 8948.2 8969.8 13443.9 16304.8 16455.0 16568.8 16907.7 12444.3 13103.2 13288.9 13566.3 13756.4 12628.6 12732.9 12901.9 13253.0 13311.3 13263.5 13464.5 13507.5 13778.7 13807.4 8615.3 8688.4 8790.4 8810.8 8854.5 10265.4 12350.3 12728.4 12937.6 13054.4 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,904 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4988.20 Median:6162.76 stddev:2579.31 (41.9%) stddev-sans-first:2572.85 20:48:05 INFO - 2015-12-03 20:48:05,905 DEBUG : BROWSER_OUTPUT: Values: 1450.9 1648.7 1688.6 1690.2 1722.3 5996.2 6048.0 6958.0 7539.0 7544.4 7044.3 7159.2 7213.7 7242.9 7255.8 2097.5 2136.1 2144.8 2147.5 2162.5 2110.7 2132.2 2136.4 2142.3 2146.2 2100.9 2100.9 2129.6 2138.6 2141.1 2095.0 2104.8 2109.6 2115.0 2118.1 2112.4 2190.9 2191.6 2193.6 2196.7 7280.4 7354.2 7368.3 7386.5 7391.2 4260.8 4324.5 4329.6 4342.5 4347.8 2353.9 2409.9 2806.4 2853.4 2863.9 878.4 887.4 898.4 907.1 940.8 9139.3 9237.4 9241.5 9265.7 9272.1 3975.9 4036.0 4061.8 4067.2 4073.7 8581.6 8655.4 8661.0 8712.3 8725.5 4356.6 4360.3 4362.6 4381.8 4400.8 3941.7 3973.5 3981.2 3990.5 3995.6 3289.1 3295.9 3309.8 3322.4 3324.1 1064.5 1065.5 1068.7 1072.7 1075.8 922.0 923.7 1131.5 1150.4 1157.3 6830.6 6888.2 6897.6 6932.5 6954.4 427.7 429.4 438.6 439.2 439.8 5254.0 5294.8 5299.2 5306.7 5312.2 7560.1 7698.5 8531.7 8573.8 8665.1 8585.1 8598.0 8606.4 8614.1 8644.1 6307.5 6365.1 6378.8 6381.2 6435.1 6511.8 6519.1 6522.0 6537.2 6556.5 7547.0 7687.4 7702.2 7776.6 7789.0 7739.1 7826.4 8116.1 8153.7 8222.0 6120.4 6129.0 6145.1 6180.4 6184.3 6790.0 6856.8 6860.1 6871.5 6874.8 6226.4 6342.6 6366.1 6390.6 6439.9 6218.3 6359.1 6361.6 6443.3 6452.0 6375.6 6408.5 6411.2 6421.5 6423.7 5923.8 5969.0 5976.1 5986.6 6000.2 6050.0 6087.6 6116.5 6205.0 6206.6 20:48:05 INFO - 2015-12-03 20:48:05,905 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4828.91 Median:5621.28 stddev:1461.10 (26.0%) stddev-sans-first:1424.68 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: Values: 275.9 284.1 285.0 286.8 289.4 5466.8 5598.9 5616.0 5658.4 5660.8 5611.2 5616.6 5626.0 5629.0 5648.3 4323.9 4333.5 4336.4 4343.8 4345.2 4329.7 4341.3 4344.6 4350.8 4351.3 4198.5 4268.2 4282.9 4291.6 4295.3 4263.1 4267.5 4275.8 4276.1 4280.9 3708.1 3719.1 3728.0 3730.2 3730.7 5405.3 5419.2 5428.7 5434.6 5451.3 4570.8 4651.0 4920.2 4930.1 4936.0 5732.1 5833.3 5861.4 5868.4 5885.4 3974.1 3976.9 3978.9 3980.6 3982.3 6160.9 6169.6 6180.9 6184.3 6188.7 3844.7 3966.5 3968.4 4081.7 4093.8 3999.9 4001.7 4014.3 4015.7 4018.9 4708.5 4725.3 4725.3 4725.8 4731.8 5738.3 5785.2 5795.7 5807.5 5809.5 1381.4 1383.2 1409.7 1410.1 1427.6 918.9 928.2 935.6 938.2 939.9 5035.3 5102.9 5130.3 5132.0 5147.1 6048.5 6069.8 6076.6 6079.8 6165.2 5078.4 5101.1 5117.6 5127.3 5131.7 3224.9 3256.7 3265.7 3272.0 3302.5 5675.8 5707.1 5721.9 5722.5 5724.8 6215.7 6236.5 6250.2 6256.4 6257.5 5615.0 5709.0 5729.9 5731.5 5732.4 5990.7 6033.8 6041.2 6046.8 6080.8 5940.3 5940.6 5941.9 5944.0 5954.0 5658.5 5706.4 5709.7 5712.4 5718.2 3852.4 3963.6 3974.7 4001.1 4010.5 6014.3 6085.5 6141.7 6150.5 6152.4 5873.9 5899.7 5904.7 5941.9 5941.9 5888.0 5908.9 5916.1 5921.4 5921.9 5639.9 5769.7 5778.2 5779.4 5801.1 5903.4 5944.6 5944.9 5962.0 5982.5 5795.4 5806.1 5806.7 5817.9 5830.8 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12395.75 Median:46437.42 stddev:14200.00 (30.6%) stddev-sans-first:14212.74 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: Values: 714.0 727.9 732.6 749.3 791.7 11308.3 11431.0 11448.0 11479.9 11485.2 11625.9 12880.7 13068.9 13096.1 13136.2 793.7 797.7 808.2 815.0 815.8 807.7 809.3 816.8 817.2 818.9 839.2 846.2 846.8 847.5 849.1 842.1 842.2 842.4 843.6 844.1 624.9 625.2 627.2 628.8 630.4 12443.9 12471.2 12503.6 12514.2 12638.6 10300.7 10481.7 11134.2 11388.6 11424.8 8931.2 9237.5 9239.4 9322.5 9453.9 3210.2 3261.9 3269.2 3274.2 3278.8 40796.6 41041.6 41152.0 41397.6 41630.6 8593.7 8765.5 8776.0 8817.9 8899.8 16128.4 16148.3 16254.1 16259.7 16286.2 6304.9 6408.2 6444.4 6461.3 6519.2 3444.5 3484.2 3495.2 3514.2 3551.5 2630.0 2661.5 2663.2 2664.9 2679.5 486.0 492.2 492.6 496.7 504.0 391.6 485.4 549.5 569.6 574.3 6682.9 6892.9 7066.5 7197.9 7208.5 469.3 565.3 568.7 574.8 578.0 3218.5 3482.4 3483.7 3519.1 3567.7 50107.7 50589.7 50672.7 50896.7 51008.2 45125.8 46191.5 46683.3 46826.5 47153.0 38974.3 39179.2 39828.4 40646.8 41056.8 7573.0 7701.3 8029.9 8164.8 8525.9 32915.5 33143.0 33237.2 33279.8 33523.0 40301.6 40797.4 41662.8 41790.6 42405.4 9738.5 10013.2 10217.2 10256.5 10388.4 10628.8 10841.2 10843.0 11001.9 11345.3 10331.5 10554.0 10586.7 10750.5 10893.5 10647.1 10710.6 10736.6 10769.0 10783.6 9950.7 10030.9 10089.8 10142.0 10261.7 8849.9 9297.3 9326.0 9377.3 9570.8 8955.9 9196.3 9299.4 9320.6 9408.2 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:48:05 INFO - 2015-12-03 20:48:05,906 DEBUG : BROWSER_OUTPUT: 20:48:06 INFO - 2015-12-03 20:48:06,591 INFO : Browser exited with error code: 0 20:48:06 INFO - 2015-12-03 20:48:06,611 INFO : Completed test dromaeo_css (00:18:34) 20:48:06 INFO - 2015-12-03 20:48:06,611 INFO : Starting test kraken 20:48:06 INFO - 2015-12-03 20:48:06,611 DEBUG : operating with platform_type : linux_ 20:48:06 INFO - 2015-12-03 20:48:06,611 INFO : Initialising browser for kraken test... 20:48:06 INFO - 2015-12-03 20:48:06,617 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGm4Qzy/profile http://localhost:50536/getInfo.html 20:48:11 INFO - 2015-12-03 20:48:11,291 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:48:11 INFO - 2015-12-03 20:48:11,291 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:48:11 INFO - 2015-12-03 20:48:11,291 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:48:11 INFO - 2015-12-03 20:48:11,291 DEBUG : BROWSER_OUTPUT: __metrics 20:48:11 INFO - 2015-12-03 20:48:11,408 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] 20:48:12 INFO - 2015-12-03 20:48:12,309 INFO : Browser initialized. 20:48:12 INFO - 2015-12-03 20:48:12,310 INFO : Running cycle 1/1 for kraken test... 20:48:12 INFO - 2015-12-03 20:48:12,310 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGm4Qzy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:48:24 INFO - 2015-12-03 20:48:24,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 143536128 20:48:24 INFO - 2015-12-03 20:48:24,334 DEBUG : BROWSER_OUTPUT: 20:48:26 INFO - 2015-12-03 20:48:26,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50536/tests/kraken/driver.html?testName=audio-beat-detection) 20:48:27 INFO - 2015-12-03 20:48:27,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 144293888 20:48:27 INFO - 2015-12-03 20:48:27,560 DEBUG : BROWSER_OUTPUT: 20:48:30 INFO - 2015-12-03 20:48:30,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50536/tests/kraken/driver.html?testName=audio-dft) 20:48:30 INFO - 2015-12-03 20:48:30,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 144936960 20:48:30 INFO - 2015-12-03 20:48:30,898 DEBUG : BROWSER_OUTPUT: 20:48:33 INFO - 2015-12-03 20:48:33,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50536/tests/kraken/driver.html?testName=audio-fft) 20:48:34 INFO - 2015-12-03 20:48:34,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 20:48:34 INFO - 2015-12-03 20:48:34,391 DEBUG : BROWSER_OUTPUT: 20:48:36 INFO - 2015-12-03 20:48:36,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50536/tests/kraken/driver.html?testName=audio-oscillator) 20:48:37 INFO - 2015-12-03 20:48:37,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 139194368 20:48:37 INFO - 2015-12-03 20:48:37,114 DEBUG : BROWSER_OUTPUT: 20:48:39 INFO - 2015-12-03 20:48:39,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:48:39 INFO - 2015-12-03 20:48:39,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 141520896 20:48:39 INFO - 2015-12-03 20:48:39,967 DEBUG : BROWSER_OUTPUT: 20:48:43 INFO - 2015-12-03 20:48:43,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50536/tests/kraken/driver.html?testName=imaging-darkroom) 20:48:43 INFO - 2015-12-03 20:48:43,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 141004800 20:48:43 INFO - 2015-12-03 20:48:43,694 DEBUG : BROWSER_OUTPUT: 20:48:47 INFO - 2015-12-03 20:48:47,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50536/tests/kraken/driver.html?testName=imaging-desaturate) 20:48:47 INFO - 2015-12-03 20:48:47,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 20:48:47 INFO - 2015-12-03 20:48:47,770 DEBUG : BROWSER_OUTPUT: 20:48:50 INFO - 2015-12-03 20:48:50,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50536/tests/kraken/driver.html?testName=json-parse-financial) 20:48:51 INFO - 2015-12-03 20:48:51,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 139345920 20:48:51 INFO - 2015-12-03 20:48:51,250 DEBUG : BROWSER_OUTPUT: 20:48:53 INFO - 2015-12-03 20:48:53,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:53 INFO - 2015-12-03 20:48:53,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 141197312 20:48:53 INFO - 2015-12-03 20:48:53,621 DEBUG : BROWSER_OUTPUT: 20:48:55 INFO - 2015-12-03 20:48:55,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:56 INFO - 2015-12-03 20:48:56,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 141524992 20:48:56 INFO - 2015-12-03 20:48:56,123 DEBUG : BROWSER_OUTPUT: 20:48:58 INFO - 2015-12-03 20:48:58,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:48:58 INFO - 2015-12-03 20:48:58,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 141959168 20:48:58 INFO - 2015-12-03 20:48:58,890 DEBUG : BROWSER_OUTPUT: 20:49:01 INFO - 2015-12-03 20:49:01,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:49:02 INFO - 2015-12-03 20:49:02,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 20:49:02 INFO - 2015-12-03 20:49:02,071 DEBUG : BROWSER_OUTPUT: 20:49:04 INFO - 2015-12-03 20:49:04,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:49:05 INFO - 2015-12-03 20:49:05,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 140972032 20:49:05 INFO - 2015-12-03 20:49:05,274 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50536/tests/kraken/driver.html?testName=ai-astar) 20:49:07 INFO - 2015-12-03 20:49:07,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 141475840 20:49:07 INFO - 2015-12-03 20:49:07,309 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,312 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:49:07 INFO - 2015-12-03 20:49:07,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:49:07 INFO - 2015-12-03 20:49:07,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;114;111;112;124;113;111;112;111 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;129;160;165;130;156;154;140;176;132 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;172;162;163;169;165;162;165;162 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;72;72;72;74;132;73;72;75 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;130;94;95;95;136;94;96;124 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;110;111;111;111;112 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;147;148;148;148;147;147;149;148 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;97;96;96;96;97;96;96;96 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;76;76;73;74;74;74;75;73;72 20:49:07 INFO - 2015-12-03 20:49:07,313 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;68;68;68;68;68 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;87;95;89;88;86;86;85;86 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;129;128;120;122;126;128;129;121;130 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;148;146;147;152;143;148;146;146;150 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;73;73;69;69;69;71;68;71;75 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1449204547310__endTimestamp 20:49:07 INFO - 2015-12-03 20:49:07,314 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,317 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:49:07 INFO - 2015-12-03 20:49:07,317 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:4.24 (3.8%) stddev-sans-first:4.48 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 114.0 111.0 112.0 124.0 113.0 111.0 112.0 111.0 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.00 stddev:16.46 (10.4%) stddev-sans-first:17.00 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: Values: 161.0 129.0 160.0 165.0 130.0 156.0 154.0 140.0 176.0 132.0 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:3.41 (2.1%) stddev-sans-first:3.48 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 172.0 162.0 163.0 169.0 165.0 162.0 165.0 162.0 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.70 Median:72.50 stddev:18.76 (25.9%) stddev-sans-first:19.78 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 72.0 72.0 74.0 132.0 73.0 72.0 75.0 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,318 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.00 stddev:17.36 (18.5%) stddev-sans-first:17.93 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 130.0 94.0 95.0 95.0 136.0 94.0 96.0 124.0 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 110.0 111.0 111.0 111.0 112.0 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 148.0 148.0 148.0 147.0 147.0 149.0 148.0 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 20:49:07 INFO - 2015-12-03 20:49:07,319 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.00 stddev:1.29 (1.7%) stddev-sans-first:1.36 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 76.0 73.0 74.0 74.0 74.0 75.0 73.0 72.0 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:3.05 (3.5%) stddev-sans-first:3.13 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 87.0 95.0 89.0 88.0 86.0 86.0 85.0 86.0 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:128.00 stddev:3.84 (3.0%) stddev-sans-first:3.86 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: Values: 122.0 129.0 128.0 120.0 122.0 126.0 128.0 129.0 121.0 130.0 20:49:07 INFO - 2015-12-03 20:49:07,320 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:147.50 stddev:3.84 (2.6%) stddev-sans-first:2.60 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: Values: 138.0 148.0 146.0 147.0 152.0 143.0 148.0 146.0 146.0 150.0 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.25 (3.2%) stddev-sans-first:2.37 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 73.0 69.0 69.0 69.0 71.0 68.0 71.0 75.0 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:49:07 INFO - 2015-12-03 20:49:07,321 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,250 INFO : Browser exited with error code: 0 20:49:08 INFO - 2015-12-03 20:49:08,301 INFO : Completed test kraken (00:01:01) 20:49:08 INFO - 2015-12-03 20:49:08,301 INFO : Starting test v8_7 20:49:08 INFO - 2015-12-03 20:49:08,301 DEBUG : operating with platform_type : linux_ 20:49:08 INFO - 2015-12-03 20:49:08,301 INFO : Initialising browser for v8_7 test... 20:49:08 INFO - 2015-12-03 20:49:08,307 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkON2zb/profile http://localhost:50536/getInfo.html 20:49:12 INFO - 2015-12-03 20:49:12,908 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:49:12 INFO - 2015-12-03 20:49:12,908 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:49:12 INFO - 2015-12-03 20:49:12,909 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:49:12 INFO - 2015-12-03 20:49:12,909 DEBUG : BROWSER_OUTPUT: __metrics 20:49:13 INFO - 2015-12-03 20:49:13,046 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] 20:49:13 INFO - 2015-12-03 20:49:13,957 INFO : Browser initialized. 20:49:13 INFO - 2015-12-03 20:49:13,958 INFO : Running cycle 1/1 for v8_7 test... 20:49:13 INFO - 2015-12-03 20:49:13,958 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkON2zb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:49:26 INFO - 2015-12-03 20:49:26,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 143589376 20:49:26 INFO - 2015-12-03 20:49:26,015 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50536/tests/v8_7/run.html (next: http://localhost:50536/tests/v8_7/run.html) 20:49:47 INFO - 2015-12-03 20:49:47,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 20:49:47 INFO - 2015-12-03 20:49:47,726 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,727 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:49:47 INFO - 2015-12-03 20:49:47,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:49:47 INFO - 2015-12-03 20:49:47,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:49:47 INFO - 2015-12-03 20:49:47,728 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:49:47 INFO - 2015-12-03 20:49:47,728 DEBUG : BROWSER_OUTPUT: |0;Richards;164.3655489809336 20:49:47 INFO - 2015-12-03 20:49:47,729 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.60402436773123 20:49:47 INFO - 2015-12-03 20:49:47,729 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 20:49:47 INFO - 2015-12-03 20:49:47,729 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 20:49:47 INFO - 2015-12-03 20:49:47,729 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1079.913606911447 20:49:47 INFO - 2015-12-03 20:49:47,729 DEBUG : BROWSER_OUTPUT: |5;Earley;744.6016381236038 20:49:47 INFO - 2015-12-03 20:49:47,729 DEBUG : BROWSER_OUTPUT: |6;Boyer;12071.42857142857 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: |7;RegExp;27756.756756756757 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: |8;Splay;603.6144578313254 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: __startTimestamp1449204587726__endTimestamp 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:49:47 INFO - 2015-12-03 20:49:47,730 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.37 Median:164.37 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: Values: 164.4 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.60 Median:184.60 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: Values: 184.6 20:49:47 INFO - 2015-12-03 20:49:47,731 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: Values: 277.7 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: Values: 5208.3 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,732 DEBUG : BROWSER_OUTPUT: Values: 1079.9 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:744.60 Median:744.60 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: Values: 744.6 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12071.43 Median:12071.43 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: Values: 12071.4 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27756.76 Median:27756.76 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,733 DEBUG : BROWSER_OUTPUT: Values: 27756.8 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.61 Median:603.61 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: Values: 603.6 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: Values: 4845.4 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:49:47 INFO - 2015-12-03 20:49:47,734 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,642 INFO : Browser exited with error code: 0 20:49:48 INFO - 2015-12-03 20:49:48,656 INFO : Completed test v8_7 (00:00:40) 20:49:48 INFO - 2015-12-03 20:49:48,745 INFO : Completed test suite (00:20:16) 20:49:48 INFO - 2015-12-03 20:49:48,745 DEBUG : Working with test: dromaeo_css 20:49:48 INFO - 2015-12-03 20:49:48,745 DEBUG : Generating results file: dromaeo_css 20:49:48 INFO - 2015-12-03 20:49:48,746 DEBUG : Working with test: kraken 20:49:48 INFO - 2015-12-03 20:49:48,746 DEBUG : Generating results file: kraken 20:49:48 INFO - 2015-12-03 20:49:48,747 INFO : javascript benchmark 20:49:48 INFO - 2015-12-03 20:49:48,747 DEBUG : Working with test: v8_7 20:49:48 INFO - 2015-12-03 20:49:48,747 DEBUG : Generating results file: v8_7 20:49:48 INFO - 2015-12-03 20:49:48,747 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:49:48 INFO - 2015-12-03 20:49:48,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 20:49:48 INFO - 2015-12-03 20:49:48,796 DEBUG : process_Request line: dromaeo_css 6292.02 graph.html#tests=[[72,132,43]] 20:49:48 INFO - 2015-12-03 20:49:48,796 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:49:48 INFO - 2015-12-03 20:49:48,834 DEBUG : process_Request line: kraken 1538.50 graph.html#tests=[[232,132,43]] 20:49:48 INFO - 2015-12-03 20:49:48,834 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:49:48 INFO - 2015-12-03 20:49:48,865 DEBUG : process_Request line: v8_7 21167.25 graph.html#tests=[[230,132,43]] 20:49:48 INFO - 2015-12-03 20:49:48,866 INFO : javascript benchmark 20:49:48 INFO - 2015-12-03 20:49:48,870 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2626.5797472404415, 2710.810243282971, 2712.64735584374, 2716.0493827160494, 2726.40019195777, 4617.930731039037, 4756.595689366408, 4769.451513075997, 4778.020505796312, 4811.494793046728, 4698.060387922412, 4736.12381709384, 4737.526247375261, 4807.831725889595, 4827.444843842959, 4357.259265924785, 4373.147236288909, 4526.026904215593, 4526.366308716782, 4563.178627846986, 4234.703570750049, 4381.868543943687, 4421.137878113769, 4442.400275962736, 4532.410786597754, 4332.891677708067, 4340.565943405666, 4436.64506839452, 4447.332900064984, 4457.108578284357, 4367.54140815213, 4409.0520538084465, 4410.029793445437, 4418.293073108287, 4477.6417886569, 4207.284761590537, 4325.82696692132, 4380.255356589388, 4406.0, 4447.799849006802, 4599.448066232074, 4661.207594708908, 4693.366395536627, 4698.718076915396, 4722.338872557844, 5119.334486516729, 5145.6398052136365, 5156.819511317123, 5159.767810448501, 5211.7133557654315, 4941.752912354404, 5045.243213517965, 5077.746112694387, 5180.326557547494, 5235.790568377261, 4820.325154478376, 4827.179379505527, 4830.95169048305, 4831.95168048322, 4881.95118048822, 5286.577073834084, 5303.893922121536, 5311.840644780663, 5311.920321195185, 5318.521333079964, 4747.881302967454, 4855.344528488679, 4974.0797952378925, 5072.112380333427, 5088.440271570124, 5084.593232541388, 5090.567301779316, 5104.795808167706, 5117.718525481134, 5149.253358263031, 5027.84916452507, 5031.0, 5036.395632524121, 5042.369703787027, 5048.066107770074, 4780.067886762048, 4877.122118018719, 4968.329275547827, 5035.748212589356, 5080.822171224063, 4194.370844373308, 4213.768242746617, 4219.746815191098, 4231.132617813341, 4259.829606815692, 3643.143861192618, 3704.81475926208, 3722.4788529605876, 3726.124360775216, 3733.51464309638, 4343.0, 4376.124775045004, 4467.106578684276, 4478.171538265431, 4524.5927866492175, 5111.284420181178, 5155.175171972466, 5156.097682905476, 5170.327857378592, 5211.140161873324, 4231.4710661167355, 4309.267424537836, 4442.244818380883, 4464.508904020555, 4498.59512643857, 4430.335449682509, 4481.327800829901, 4516.36770852081, 4527.1398434298035, 4583.381243532081, 4799.208130658472, 4824.300476430828, 4844.176489996779, 4870.366852309177, 4908.312836202863, 4913.1893237615395, 5008.974955125201, 5067.239914012927, 5115.15599926023, 5164.7934082636275, 4852.611791056636, 4878.658493905393, 4882.902341953212, 4910.263460480956, 4955.876103097451, 5068.82259120929, 5079.3904731430985, 5081.949180508148, 5085.110105731556, 5090.287359769709, 4918.655694101379, 5025.522575355335, 5043.747812609428, 5137.409197942285, 5228.189630607262, 4889.315495830658, 4908.828191013297, 4920.704757714549, 4948.480409557089, 4949.33184020167, 4898.82854100119, 4922.852314430573, 4932.950670493249, 4935.235038569028, 4949.579285760607, 4642.976785116053, 4699.318598803086, 4766.880827979189, 4770.141374552614, 4784.306275590089, 4956.0, 4979.228219625964, 4999.150144475375, 5042.697438153723, 5061.898762024813, 4664.090502352009, 4906.313116163811, 4925.950740492693, 4927.852164435073, 4932.358793356841], "unit": "ms", "name": "dojo.html", "value": 4672.02931727052}, {"lowerIsBetter": false, "replicates": [555.1035078348468, 561.9915701264482, 572.3046498504318, 579.9710014499275, 585.6456843609619, 37024.25951480969, 37266.44100338497, 37345.62654373456, 37383.62616373839, 37638.623613763855, 41156.79421602895, 41717.0, 41746.165076698446, 41772.791136044274, 41814.79092604533, 7899.210078992112, 7996.880046799302, 8058.476199047043, 8067.072286687047, 8067.3546116310845, 7763.107242667081, 7865.803354916145, 7915.722949696762, 7919.960400197991, 7922.643481043338, 7939.603019849013, 7953.840923181533, 8005.039395272575, 8033.277005069543, 8051.798705032392, 7856.332211762007, 7905.0, 7929.167437419074, 7942.404319676048, 7965.482243654202, 7811.804704882366, 7929.246721561442, 7929.32600728933, 7950.0, 7966.960165199195, 37018.8149059253, 37607.435888461696, 37637.81181094104, 37673.43489847627, 37767.24465510702, 2399.3881560202035, 2748.8833598129327, 2870.1389583125188, 2955.9556606650917, 3710.18375957289, 27210.31974200641, 27380.863095684395, 27760.444791104266, 27770.583441248396, 27802.582961255597, 3144.827034513101, 3175.5712978748033, 3223.9677603224136, 3247.707706306444, 3268.705816476505, 202285.0, 202542.0, 203035.98482007644, 203418.0, 203668.0, 38801.6119838798, 38866.61133388687, 54075.72962135164, 54511.0, 54642.72678636581, 38353.0, 38360.42459363112, 38526.0, 38533.807330963165, 38684.61315386866, 12148.514059437524, 12159.574414895436, 12162.452689628988, 12337.568185113478, 12362.0, 9605.0, 9683.612655493842, 9694.806103877883, 9701.07839755222, 9712.70861874145, 13109.541166059142, 13602.727945441036, 13614.863851361557, 13710.38303276355, 13727.382267797973, 5417.268668729671, 5613.635113717595, 5616.241807356037, 5644.5484361251, 5656.91514627281, 854.2013217641525, 887.0175158520701, 993.4287784523927, 999.2156157416393, 1046.3146638951498, 25961.480770384485, 26156.86921565418, 26491.602625960626, 26739.197824065308, 26847.463050739265, 907.7957459571544, 980.7842274699555, 987.7036888933292, 1028.4806172882647, 1072.6353039966293, 13696.315184240748, 13833.308334583231, 13888.0, 13921.651958701113, 14009.789853152211, 276257.0, 281157.0, 281580.0, 282285.0, 283385.0, 46042.0, 46302.305465418045, 46376.768116159205, 46467.30299045517, 46641.0, 1197.4012993503247, 1200.8198770184542, 1201.2912381694841, 1208.6857417071624, 1221.1818081885158, 25557.3610659735, 25785.742142579085, 26366.868165659816, 26396.0, 26452.206433807016, 40390.59609403869, 40514.0, 40671.59328406678, 40765.592344076176, 40864.591354087264, 256479.0, 258225.0, 258730.0, 258937.0, 259237.0, 29403.41193176167, 30124.24689382783, 42331.3650295252, 42393.788031059645, 43221.3516797242, 40480.59519404768, 40534.0, 40688.0, 40753.796231018656, 41516.79241603773, 34224.82887585546, 34642.65357346394, 34646.30707385889, 34782.304353913285, 35321.408216932665, 34794.0, 35062.0, 35307.117322067155, 35608.0, 35728.82135589409, 34471.655283446846, 34563.30873382468, 34920.65079349174, 35080.298394032485, 35088.64911350956, 29876.402471950005, 31421.52867707032, 31995.680043200202, 32117.839410802797, 32345.676543234265, 21931.561368772214, 22013.738646673948, 22066.44833879166, 22099.779002210416, 22271.220507282167], "unit": "ms", "name": "ext.html", "value": 16473.262561712523}, {"lowerIsBetter": false, "replicates": [323.8542655804887, 329.6626915171434, 331.3670888602769, 334.74057605355847, 337.4802803682329, 15138.091714497124, 15591.688166236683, 15851.445199418009, 16002.359905603791, 16666.58333541662, 9765.414075155479, 9919.603215871375, 12666.17669851459, 14053.71892562148, 14142.363593638285, 4473.373727678128, 4575.519570445089, 4579.290210017452, 4966.304717339575, 5131.255967884655, 5067.239914012891, 5101.0308041472, 5102.489751024887, 5104.617153713468, 5111.488851114896, 4851.466338702739, 5001.774920128585, 5015.824446144386, 5095.133827249377, 5357.223202635615, 4993.950060499385, 5017.899642007158, 5037.949620503785, 5062.417821950486, 5080.669756465818, 5048.62135339851, 5064.392272927273, 5070.2141168119, 5072.568831649277, 5087.211482220262, 11117.166212534012, 11302.886971130265, 14755.77866332006, 17810.732839007425, 17830.19764110618, 1725.5513566472682, 1765.761622181015, 1814.3377667151526, 1824.9908750456295, 1883.2937648381858, 8311.293540049102, 8888.688895888612, 9218.769530761785, 9299.76750581234, 10258.281920265585, 1766.1169415292354, 1782.7860656721277, 1795.8114397988154, 1797.2002458905793, 1815.5733402650367, 48749.26876096861, 50665.746671266774, 51226.743866280805, 55266.0, 57770.71114644442, 9331.113544213289, 9656.420614762996, 9688.46713430754, 9719.222462203006, 9753.268504862022, 12194.146409751409, 12199.085068619888, 12206.328651924052, 12212.0, 12213.206141600767, 6672.499562532829, 6979.371856532936, 7088.326608972139, 7120.145582530129, 7126.0379848720795, 6631.171103612049, 6664.900026499607, 6685.431738302299, 6723.058771771955, 6750.628715420699, 4158.896027599334, 4219.873403797891, 4232.4286221360335, 4245.724027938174, 4255.021345090647, 1638.3037209186286, 1724.0, 1768.628587996535, 1777.5911540345792, 1780.6349698312074, 798.2050314715094, 836.3267569606404, 858.6050416808213, 900.2527901841456, 910.8770316007386, 13465.932670336586, 14400.063995840237, 14503.927480362741, 15151.0, 15833.52499425019, 775.0350813237555, 822.5442451597586, 870.9956450217835, 877.5042101212795, 882.9646814127491, 8552.828943421222, 8641.56792160402, 8643.654253829902, 8673.826523469621, 8712.085231050774, 465018.0, 466136.0, 467403.0, 468465.0, 474173.0, 70341.29658703347, 75013.62493187499, 75239.62380188065, 75271.24728752642, 77880.22119778843, 1064.8402739589123, 1066.2962444786249, 1081.5835903177333, 1086.1093902999464, 1086.3481910853425, 13844.515441959484, 13928.373223204777, 13946.860531394555, 15247.771283430535, 15328.923355383151, 29935.850320748257, 30083.0, 30313.393732125674, 31404.685953141092, 32002.0, 38834.41748373833, 39264.2147157061, 39878.20243595054, 40038.0, 42932.921372469566, 8885.644574217218, 8900.376973612045, 8910.198082172636, 8948.239399651102, 8969.820603587761, 13443.86556134426, 16304.755428668343, 16455.0, 16568.751468727736, 16907.66184676275, 12444.253344799341, 13103.2138071716, 13288.933555332162, 13566.253856038013, 13756.380962856496, 12628.558000469939, 12732.872671273539, 12901.870981290067, 13253.0, 13311.267880266678, 13263.535776247785, 13464.461421543028, 13507.527236546674, 13778.65553361174, 13807.447702091804, 8615.267702245379, 8688.39181257306, 8790.384673072824, 8810.823783524165, 8854.468731876108, 10265.384076955406, 12350.258984460961, 12728.427220774902, 12937.611871643865, 13054.412551435398], "unit": "ms", "name": "jquery.html", "value": 8050.807504529361}, {"lowerIsBetter": false, "replicates": [1450.9129452232874, 1648.694991426586, 1688.5609741467222, 1690.2140504665329, 1722.3024675006623, 5996.220491336131, 6047.969760151204, 6957.965210173948, 7538.962305188473, 7544.3587295079915, 7044.33078857509, 7159.248278930715, 7213.747518836842, 7242.891356629655, 7255.782326530212, 2097.465146387673, 2136.1241890824685, 2144.8391370647187, 2147.5168087180336, 2162.4918144236094, 2110.7256056712604, 2132.1577976699273, 2136.3590922723197, 2142.2716276466, 2146.195176808697, 2100.884451355175, 2100.9369718908456, 2129.55279391328, 2138.615049291127, 2141.122139922632, 2094.968575471369, 2104.7684754676975, 2109.5886302171084, 2114.9788502114934, 2118.0998075817715, 2112.4296439961277, 2190.8575942563684, 2191.605511008018, 2193.6161171795034, 2196.6924630551734, 7280.38116760076, 7354.1542722587055, 7368.300011498899, 7386.482946193769, 7391.186969433358, 4260.7656578888145, 4324.502682191557, 4329.631981281595, 4342.544032876534, 4347.847825326098, 2353.8940747666397, 2409.8915548800346, 2806.3685670723926, 2853.372258103235, 2863.914082577526, 878.4246318661287, 887.4143065576689, 898.3666515106834, 907.1336873285996, 940.83535381308, 9139.314551408672, 9237.445753254759, 9241.537923103819, 9265.72202833916, 9272.072792720674, 3975.8807235782974, 4035.9798201009394, 4061.817218225187, 4067.186562687474, 4073.7148399612333, 8581.570921453902, 8655.437396569203, 8661.047284798668, 8712.259457946146, 8725.520096394632, 4356.586124318248, 4360.280553708666, 4362.585554372329, 4381.802818873159, 4400.779961001937, 3941.664958478504, 3973.523177218752, 3981.1639555693628, 3990.461287726178, 3995.5604883462797, 3289.1283809790425, 3295.9340813183603, 3309.7848639838335, 3322.3853587086464, 3324.1191084362663, 1064.5050051725984, 1065.515190588296, 1068.7274744939991, 1072.6674730833467, 1075.843468271611, 922.0318665401302, 923.7459698582943, 1131.4625552862324, 1150.4362862197631, 1157.3287493253893, 6830.624315662686, 6888.173419189629, 6897.586144831326, 6932.480063995221, 6954.40887524556, 427.6941986479682, 429.4009856250513, 438.5745826548243, 439.20723094814167, 439.76252823474965, 5253.973730131325, 5294.814681486129, 5299.205119232069, 5306.708131052829, 5312.1766126250495, 7560.130584982688, 7698.538087714755, 8531.701390451304, 8573.799668046478, 8665.090165532654, 8585.098564650747, 8598.0, 8606.397552171287, 8614.138586141462, 8644.092370301028, 6307.5269354798575, 6365.14070600463, 6378.840528986812, 6381.170447841843, 6435.09908612804, 6511.837204069936, 6519.054737063005, 6521.9673901630185, 6537.248216455168, 6556.541042127005, 7546.962265188639, 7687.385009199363, 7702.191269916802, 7776.611169441619, 7789.0, 7739.071311442663, 7826.373890088666, 8116.107228205011, 8153.6738530458115, 8222.0, 6120.357362476876, 6129.049997250433, 6145.0782382642965, 6180.443760061616, 6184.319724830355, 6789.966050169915, 6856.794296171123, 6860.073890024983, 6871.518993670595, 6874.793756187322, 6226.377362263737, 6342.619442833445, 6366.076918846648, 6390.616563006234, 6439.935600644121, 6218.284897236876, 6359.07793369968, 6361.568647054561, 6443.291237963914, 6451.967740161269, 6375.553711240169, 6408.487321014214, 6411.166548348685, 6421.518386120966, 6423.710933008119, 5923.763049477972, 5969.04495280753, 5976.103584462366, 5986.610870293417, 6000.189974353581, 6049.969750151221, 6087.573869829246, 6116.510679145568, 6204.968975155095, 6206.596571222856], "unit": "ms", "name": "mootools.html", "value": 4037.716355060803}, {"lowerIsBetter": false, "replicates": [275.8813013231347, 284.13622587334504, 285.04367845877067, 286.83076984579105, 289.39083229801264, 5466.835994920149, 5598.944010559893, 5616.0, 5658.43415658434, 5660.801871934483, 5611.2144299798065, 5616.550675945925, 5626.0, 5629.0, 5648.322201335845, 4323.891902702434, 4333.458317710286, 4336.436263285768, 4343.78281085946, 4345.152695224432, 4329.653627709791, 4341.261985462479, 4344.565543445662, 4350.825966961318, 4351.303791393378, 4198.538160802309, 4268.210381079494, 4282.850100246492, 4291.570842915715, 4295.291276939317, 4263.126059157865, 4267.466566679165, 4275.8075886585175, 4276.059266961263, 4280.850170244026, 3708.072981754561, 3719.0888232382968, 3727.981360093182, 3730.198007428416, 3730.7015438765106, 5405.324334458192, 5419.241306217133, 5428.728563571805, 5434.592405569598, 5451.291332126798, 4570.817167313304, 4650.9767451162525, 4920.163572192736, 4930.112579735646, 4936.037472692827, 5732.082866741343, 5833.32916714579, 5861.3552509223955, 5868.354481007086, 5885.440883116097, 3974.0859602291634, 3976.880693579197, 3978.8607398740905, 3980.5820388859042, 3982.263281292941, 6160.907586386208, 6169.568130230886, 6180.9381906180815, 6184.319724830265, 6188.659623720693, 3844.7116466265143, 3966.504186976628, 3968.3849003404516, 4081.714280000431, 4093.815778289984, 3999.9400008999887, 4001.659858912025, 4014.277430062617, 4015.658669013108, 4018.9196216075516, 4708.4820669726305, 4725.29120631908, 4725.314829349725, 4725.787339569728, 4731.793392684844, 5738.340090889517, 5785.247917770663, 5795.739191736382, 5807.477327040502, 5809.535237181015, 1381.4336122189854, 1383.1700979412474, 1409.6757745718542, 1410.104583589428, 1427.586000059971, 918.9356745027918, 928.1878356438117, 935.569637966543, 938.2494004796135, 939.8731171291788, 5035.269885866529, 5102.923456148161, 5130.281760553526, 5132.0, 5147.0992576298995, 6048.5483483963535, 6069.848253793691, 6076.635401875901, 6079.848003799941, 6165.167702360124, 5078.365204349457, 5101.132807422673, 5117.590592752571, 5127.256547800548, 5131.692098474104, 3224.9032529024166, 3256.6580509046685, 3265.6571060038355, 3271.9672803272138, 3302.53764472974, 5675.829725108253, 5707.086866101404, 5721.856953576111, 5722.542196624343, 5724.77100915967, 6215.720292586844, 6236.501079913596, 6250.15622890913, 6256.405641464054, 6257.499400047986, 5615.0, 5709.000924838137, 5729.8567535811935, 5731.512821410143, 5732.426757324234, 5990.700464976647, 6033.758649653964, 6041.154238406539, 6046.818595442144, 6080.7567697291615, 5940.257467816523, 5940.55445841555, 5941.881162376815, 5944.0, 5954.0, 5658.519025882846, 5706.42935706426, 5709.714514274353, 5712.400197979152, 5718.199452076796, 3852.3643598807002, 3963.56400795918, 3974.7018973577674, 4001.079751657077, 4010.538788039413, 6014.278286605635, 6085.4523092921845, 6141.692915354125, 6150.507959363151, 6152.354002829638, 5873.853153671193, 5899.705014749331, 5904.734286957011, 5941.851453713692, 5941.9405805943115, 5887.970560147171, 5908.881822363614, 5916.142159386779, 5921.378255283305, 5921.851953701192, 5639.887202256014, 5769.711514424346, 5778.248827652378, 5779.393163717749, 5801.071828507418, 5903.439173278532, 5944.5838791284195, 5944.851378715567, 5962.0, 5982.49148822355, 5795.391483894299, 5806.1000544915605, 5806.65160090396, 5817.94182058174, 5830.7959221427045], "unit": "ms", "name": "prototype.html", "value": 4340.234494907106}, {"lowerIsBetter": false, "replicates": [713.9500234983551, 727.8871774874895, 732.6300218389713, 749.269462274283, 791.6793698552085, 11308.264962777424, 11431.0, 11448.0, 11479.885201147996, 11485.196036277453, 11625.941870290659, 12880.67798305043, 13068.869311306884, 13096.083274170813, 13136.21182729037, 793.6507936507918, 797.696875187428, 808.1837344282288, 815.0219736316415, 815.8123631564744, 807.7294106474309, 809.3080416244114, 816.7549735079452, 817.1828171828172, 818.8526065308242, 839.1566475691922, 846.2130218896424, 846.7629063862129, 847.5084451018395, 849.0957130655831, 842.0737189092011, 842.2461896602567, 842.389267780857, 843.5866425451516, 844.0546587821648, 624.9093881387173, 625.2059883947361, 627.2473032361139, 628.779927025542, 630.4357599948021, 12443.937780311131, 12471.189372690746, 12503.624891253186, 12514.249145051326, 12638.55765048219, 10300.690979270634, 10481.737956551071, 11134.220604557684, 11388.601398950997, 11424.771504569946, 8931.151540603632, 9237.49193794341, 9239.380309845077, 9322.533873306375, 9453.858192127123, 3210.2295449092285, 3261.8858339957987, 3269.1500209945348, 3274.214188594744, 3278.8196649184283, 40796.59203407987, 41041.58958410408, 41152.0, 41397.58602413998, 41630.58369416327, 8593.742187734379, 8765.517896515752, 8775.956120219358, 8817.911820881709, 8899.832209767648, 16128.354865805471, 16148.273327700046, 16254.106024168548, 16259.674806504041, 16286.185690715654, 6304.936950630435, 6408.231012278463, 6444.387783160592, 6461.25695545009, 6519.217693876671, 3444.51776751255, 3484.1638006878675, 3495.178633021238, 3514.191735900757, 3551.520544726429, 2629.9605505917425, 2661.4544018476167, 2663.2276639774636, 2664.9067282645015, 2679.4775018871524, 486.0255188347341, 492.1657790045838, 492.58376671712347, 496.7268002598556, 503.98992020160125, 391.6240409207193, 485.3505199478078, 549.5027000564495, 569.63827969239, 574.319431473705, 6682.9331706682315, 6892.862142757117, 7066.470014748915, 7197.940894956866, 7208.4954053216825, 469.29137003124845, 565.3046752494455, 568.7071158353451, 574.7586013874183, 577.9855503612443, 3218.5333126696964, 3482.425399809003, 3483.7216003656476, 3519.0674471265133, 3567.7324200685052, 50107.74946125246, 50589.74705126451, 50672.74663626658, 50896.74551627218, 51008.23487647688, 45125.77437112859, 46191.538084619395, 46683.29975050377, 46826.531734682896, 47153.0, 38974.271800974224, 39179.21641567153, 39828.402573961415, 40646.796766016574, 41056.79471602623, 7572.962135189288, 7701.345385642283, 8029.879551806845, 8164.7958801030445, 8525.899177230014, 32915.50626740649, 33143.0, 33237.16907077342, 33279.833600831844, 33522.99431017073, 40301.596984029784, 40797.38803918003, 41662.791686041375, 41790.582094178666, 42405.363919540614, 9738.464384458923, 10013.246357251814, 10217.1826253901, 10256.53845576936, 10388.42863642507, 10628.84056739165, 10841.241113122005, 10843.024127828217, 11001.944990275317, 11345.319280843176, 10331.535080921527, 10554.0, 10586.682399528027, 10750.46247687628, 10893.455327233765, 10647.148228141885, 10710.625128120479, 10736.570537178426, 10769.0, 10783.568657253621, 9950.651727189514, 10030.949845250727, 10089.848652270368, 10141.951611463297, 10261.692149235534, 8849.91150088491, 9297.252273245598, 9325.953370233105, 9377.343585948918, 9570.760730981781, 8955.865662014945, 9196.264298855942, 9299.401523664297, 9320.580573874327, 9408.153266206074], "unit": "ms", "name": "yui.html", "value": 5713.776318277303}], "name": "dromaeo_css", "value": 6292.017670383758}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 114.0, 111.0, 112.0, 124.0, 113.0, 111.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [161.0, 129.0, 160.0, 165.0, 130.0, 156.0, 154.0, 140.0, 176.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 172.0, 162.0, 163.0, 169.0, 165.0, 162.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 72.0, 72.0, 74.0, 132.0, 73.0, 72.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 130.0, 94.0, 95.0, 95.0, 136.0, 94.0, 96.0, 124.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 112.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 76.0, 73.0, 74.0, 74.0, 74.0, 75.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 95.0, 89.0, 88.0, 86.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [122.0, 129.0, 128.0, 120.0, 122.0, 126.0, 128.0, 129.0, 121.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 146.0, 147.0, 152.0, 143.0, 148.0, 146.0, 146.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 73.0, 69.0, 69.0, 69.0, 71.0, 68.0, 71.0, 75.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1538.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.3655489809336], "unit": "score", "name": "Richards", "value": 214.77736799999994}, {"lowerIsBetter": false, "replicates": [184.60402436773123], "unit": "score", "name": "DeltaBlue", "value": 358.16120599999994}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [744.6016381236038], "unit": "score", "name": "Earley", "value": 895.0598090000003}, {"lowerIsBetter": false, "replicates": [12071.42857142857], "unit": "score", "name": "Boyer", "value": 55.209952662721896}, {"lowerIsBetter": false, "replicates": [27756.756756756757], "unit": "score", "name": "RegExp", "value": 32.82029698149949}, {"lowerIsBetter": false, "replicates": [603.6144578313254], "unit": "score", "name": "Splay", "value": 135.00504990019962}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21167.251223975167}]} 20:49:48 INFO - RETURN: dromaeo_css: 6292.02 20:49:48 INFO - RETURN: kraken: 1538.50 20:49:48 INFO - RETURN: v8_7: 21167.25 20:49:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21167.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1538.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6292.02"}}} 20:49:48 INFO - Return code: 0 20:49:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:49:49 INFO - # TBPL SUCCESS # 20:49:49 INFO - Running post-action listener: _resource_record_post_action 20:49:49 INFO - Running post-run listener: _resource_record_post_run 20:49:50 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522797056; Read time: 32; Write time: 460940 20:49:50 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 247885824; Read time: 0; Write time: 314988 20:49:50 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274911232; Read time: 32; Write time: 145952 20:49:50 INFO - Running post-run listener: _upload_blobber_files 20:49:50 INFO - Blob upload gear active. 20:49:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:49:50 INFO - Copying logs to upload dir... 20:49:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.470425 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 20:49:50.145166) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:50.148480) ========= 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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010019 build_url: 'https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/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-03 20:49:50.202311) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:50.202687) ========= 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=61fa6ed41387771909ec0f71000001b3-1449203020.980432-2119238345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:50.253784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 20:49:50.254238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 20:49:50.254612) ========= ========= Total master_lag: 0.25 =========