builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1449203317.7 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.697774) ========= 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.698343) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.698711) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006343 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.735670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.736012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.769034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.769399) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.820289) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.820716) ========= 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.821236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:37.821646) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 20:28:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-03 20:28:38 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.024195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.024567) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014276 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.076827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:38.077641) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 20:28:38,462 truncating revision to first 12 chars 2015-12-03 20:28:38,462 Setting DEBUG logging. 2015-12-03 20:28:38,462 attempt 1/10 2015-12-03 20:28:38,462 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:39,119 unpacking tar archive at: fx-team-f70ee6e84e82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.961008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:39.053246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:39.053558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:39.265866) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 20:28:39.266346) ========= 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:39.267309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 20:28:39.267690) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:28:39 INFO - MultiFileLogger online at 20151203 20:28:39 in /builds/slave/test 20:28:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:28:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:28:39 INFO - {'append_to_log': False, 20:28:39 INFO - 'base_work_dir': '/builds/slave/test', 20:28:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:28:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:28:39 INFO - 'branch': 'Fx-Team-Non-PGO', 20:28:39 INFO - 'buildbot_json_path': 'buildprops.json', 20:28:39 INFO - 'config_files': ('talos/linux_config.py',), 20:28:39 INFO - 'default_actions': ('clobber', 20:28:39 INFO - 'read-buildbot-config', 20:28:39 INFO - 'download-and-extract', 20:28:39 INFO - 'populate-webroot', 20:28:39 INFO - 'create-virtualenv', 20:28:39 INFO - 'install', 20:28:39 INFO - 'run-tests'), 20:28:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:28:39 INFO - 'download_minidump_stackwalk': True, 20:28:39 INFO - 'download_symbols': 'ondemand', 20:28:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:28:39 INFO - 'tooltool.py': '/tools/tooltool.py', 20:28:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:28:39 INFO - '/tools/misc-python/virtualenv.py')}, 20:28:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:28:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:28:39 INFO - 'installer_path': 'installer.exe', 20:28:39 INFO - 'log_level': 'info', 20:28:39 INFO - 'log_name': 'talos', 20:28:39 INFO - 'log_to_console': True, 20:28:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:28:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:28:39 INFO - 'opt_config_files': (), 20:28:39 INFO - 'pip_index': False, 20:28:39 INFO - 'sps_profile': False, 20:28:39 INFO - 'sps_profile_interval': 0, 20:28:39 INFO - 'suite': 'dromaeojs', 20:28:39 INFO - 'system_bits': '64', 20:28:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:28:39 INFO - 'title': 'talos-linux64-ix-068', 20:28:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:28:39 INFO - 'use_talos_json': True, 20:28:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:28:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:28:39 INFO - 'work_dir': 'build'} 20:28:39 INFO - ##### 20:28:39 INFO - ##### Running clobber 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: clobber 20:28:39 INFO - rmtree: /builds/slave/test/build 20:28:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:28:40 INFO - Running post-action listener: _resource_record_post_action 20:28:40 INFO - ##### 20:28:40 INFO - ##### Running read-buildbot-config step. 20:28:40 INFO - ##### 20:28:40 INFO - Running pre-action listener: _resource_record_pre_action 20:28:40 INFO - Running main action method: read_buildbot_config 20:28:40 INFO - Using buildbot properties: 20:28:40 INFO - { 20:28:40 INFO - "properties": { 20:28:40 INFO - "buildnumber": 2189, 20:28:40 INFO - "product": "firefox", 20:28:40 INFO - "script_repo_revision": "production", 20:28:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:28:40 INFO - "repository": "", 20:28:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:28:40 INFO - "buildid": "20151203200117", 20:28:40 INFO - "slavename": "talos-linux64-ix-068", 20:28:40 INFO - "pgo_build": "False", 20:28:40 INFO - "basedir": "/builds/slave/test", 20:28:40 INFO - "project": "", 20:28:40 INFO - "platform": "ubuntu64_hw", 20:28:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:28:40 INFO - "slavebuilddir": "test", 20:28:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:28:40 INFO - "branch": "fx-team", 20:28:40 INFO - "repo_path": "integration/fx-team", 20:28:40 INFO - "stage_platform": "linux64", 20:28:40 INFO - "builduid": "ffcaa872fc8e4a8cabb5747aa2f17fd5", 20:28:40 INFO - "revision": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272" 20:28:40 INFO - }, 20:28:40 INFO - "sourcestamp": { 20:28:40 INFO - "repository": "", 20:28:40 INFO - "hasPatch": false, 20:28:40 INFO - "project": "", 20:28:40 INFO - "branch": "fx-team-linux64-talos", 20:28:40 INFO - "changes": [ 20:28:40 INFO - { 20:28:40 INFO - "category": null, 20:28:40 INFO - "files": [ 20:28:40 INFO - { 20:28:40 INFO - "url": null, 20:28:40 INFO - "name": "https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:28:40 INFO - } 20:28:40 INFO - ], 20:28:40 INFO - "repository": "", 20:28:40 INFO - "rev": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272", 20:28:40 INFO - "who": "markcapella@twcny.rr.com", 20:28:40 INFO - "when": 1449203257, 20:28:40 INFO - "number": 6742802, 20:28:40 INFO - "comments": "Bug 1215959 - (GeckoCarets2) - skip-if overlooked perma-orange test", 20:28:40 INFO - "project": "", 20:28:40 INFO - "at": "Thu 03 Dec 2015 20:27:37", 20:28:40 INFO - "branch": "fx-team-linux64-talos", 20:28:40 INFO - "revlink": "", 20:28:40 INFO - "properties": [ 20:28:40 INFO - [ 20:28:40 INFO - "buildid", 20:28:40 INFO - "20151203200117", 20:28:40 INFO - "Change" 20:28:40 INFO - ], 20:28:40 INFO - [ 20:28:40 INFO - "builduid", 20:28:40 INFO - "ffcaa872fc8e4a8cabb5747aa2f17fd5", 20:28:40 INFO - "Change" 20:28:40 INFO - ], 20:28:40 INFO - [ 20:28:40 INFO - "pgo_build", 20:28:40 INFO - "False", 20:28:40 INFO - "Change" 20:28:40 INFO - ] 20:28:40 INFO - ], 20:28:40 INFO - "revision": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272" 20:28:40 INFO - } 20:28:40 INFO - ], 20:28:40 INFO - "revision": "f70ee6e84e82ec22a16f33c6a3f3da3402a36272" 20:28:40 INFO - } 20:28:40 INFO - } 20:28:40 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:40 INFO - Running post-action listener: _resource_record_post_action 20:28:40 INFO - ##### 20:28:40 INFO - ##### Running download-and-extract step. 20:28:40 INFO - ##### 20:28:40 INFO - Running pre-action listener: _resource_record_pre_action 20:28:40 INFO - Running main action method: download_and_extract 20:28:40 INFO - mkdir: /builds/slave/test/build/tests 20:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:40 INFO - https://queue.taskcluster.net/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json 20:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFmwll7gQ02D9p89rre4AQ/artifacts/public/build/test_packages.json 20:28:40 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:40 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:42 INFO - Downloaded 1302 bytes. 20:28:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:28:42 INFO - Using the following test package requirements: 20:28:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:28:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'jsshell-linux-x86_64.zip'], 20:28:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:28:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:28:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:28:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:28:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:28:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:42 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:42 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:42 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:42 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:42 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:43 INFO - Downloaded 21791680 bytes. 20:28:43 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:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:43 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:44 INFO - Return code: 0 20:28:44 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:44 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:44 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:44 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:44 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:44 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:44 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:45 INFO - Downloaded 21791680 bytes. 20:28:45 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:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:28:45 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:47 INFO - Return code: 0 20:28:47 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:47 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:47 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:47 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:47 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:47 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:48 INFO - Downloaded 11132001 bytes. 20:28:48 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:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:28:48 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:48 INFO - Return code: 0 20:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:48 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:48 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:48 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:48 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:48 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:52 INFO - Downloaded 57698058 bytes. 20:28:52 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:52 INFO - mkdir: /builds/slave/test/properties 20:28:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:52 INFO - Contents: 20:28:52 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:52 INFO - Running post-action listener: _resource_record_post_action 20:28:52 INFO - Running post-action listener: set_extra_try_arguments 20:28:52 INFO - ##### 20:28:52 INFO - ##### Running populate-webroot step. 20:28:52 INFO - ##### 20:28:52 INFO - Running pre-action listener: _resource_record_pre_action 20:28:52 INFO - Running main action method: populate_webroot 20:28:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:28:52 INFO - '../fennec_ids.txt'], 20:28:52 INFO - 'tests': ['tcheck2']}, 20:28:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:52 INFO - '--tppagecycles', 20:28:52 INFO - '7'], 20:28:52 INFO - 'tests': ['tsvgm']}}, 20:28:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:28:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:28:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:28:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'tests': ['damp', 'tps']}, 20:28:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['damp', 'tps']}, 20:28:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:28:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:52 INFO - 'other': {'tests': ['a11yr', 20:28:52 INFO - 'ts_paint', 20:28:52 INFO - 'tpaint', 20:28:52 INFO - 'sessionrestore', 20:28:52 INFO - 'sessionrestore_no_auto_restore']}, 20:28:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['a11yr', 20:28:52 INFO - 'ts_paint', 20:28:52 INFO - 'tpaint', 20:28:52 INFO - 'sessionrestore', 20:28:52 INFO - 'sessionrestore_no_auto_restore']}, 20:28:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['a11yr', 20:28:52 INFO - 'ts_paint', 20:28:52 INFO - 'tpaint', 20:28:52 INFO - 'sessionrestore', 20:28:52 INFO - 'sessionrestore_no_auto_restore']}, 20:28:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['a11yr', 20:28:52 INFO - 'ts_paint', 20:28:52 INFO - 'tpaint', 20:28:52 INFO - 'sessionrestore', 20:28:52 INFO - 'sessionrestore_no_auto_restore']}, 20:28:52 INFO - 'other_l64': {'tests': ['a11yr', 20:28:52 INFO - 'ts_paint', 20:28:52 INFO - 'tpaint', 20:28:52 INFO - 'sessionrestore', 20:28:52 INFO - 'sessionrestore_no_auto_restore']}, 20:28:52 INFO - 'other_nol64': {'tests': ['a11yr', 20:28:52 INFO - 'ts_paint', 20:28:52 INFO - 'tpaint', 20:28:52 INFO - 'sessionrestore', 20:28:52 INFO - 'sessionrestore_no_auto_restore']}, 20:28:52 INFO - 'svgr': {'tests': ['tsvgx', 20:28:52 INFO - 'tsvgr_opacity', 20:28:52 INFO - 'tart', 20:28:52 INFO - 'tscrollx', 20:28:52 INFO - 'cart']}, 20:28:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['tsvgx', 20:28:52 INFO - 'tsvgr_opacity', 20:28:52 INFO - 'tart', 20:28:52 INFO - 'tscrollx', 20:28:52 INFO - 'cart']}, 20:28:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'tests': ['tp5o']}, 20:28:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'talos_options': ['--e10s'], 20:28:52 INFO - 'tests': ['tp5o']}, 20:28:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'talos_options': ['--xperf_path', 20:28:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:52 INFO - 'tests': ['tp5n']}, 20:28:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:52 INFO - 'talos_options': ['--e10s', 20:28:52 INFO - '--xperf_path', 20:28:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:52 INFO - 'tests': ['tp5n']}}, 20:28:52 INFO - 'talos.zip': {'path': '', 20:28:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:52 INFO - Running post-action listener: _resource_record_post_action 20:28:52 INFO - ##### 20:28:52 INFO - ##### Running create-virtualenv step. 20:28:52 INFO - ##### 20:28:52 INFO - Running pre-action listener: _resource_record_pre_action 20:28:52 INFO - Running main action method: create_virtualenv 20:28:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28:52 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:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:52 INFO - Using real prefix '/usr' 20:28:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:54 INFO - Installing pip.................done. 20:28:54 INFO - Return code: 0 20:28:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:54 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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 20:28:54 INFO - 'HOME': '/home/cltbld', 20:28:54 INFO - 'LANG': 'en_US.UTF-8', 20:28:54 INFO - 'LANGUAGE': 'en_US:en', 20:28:54 INFO - 'LOGNAME': 'cltbld', 20:28:54 INFO - 'MAIL': '/var/mail/cltbld', 20:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:54 INFO - 'MOZ_NO_REMOTE': '1', 20:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:54 INFO - 'NO_EM_RESTART': '1', 20:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:54 INFO - 'PWD': '/builds/slave/test', 20:28:54 INFO - 'SHELL': '/bin/bash', 20:28:54 INFO - 'SHLVL': '1', 20:28:54 INFO - 'TERM': 'linux', 20:28:54 INFO - 'TMOUT': '86400', 20:28:54 INFO - 'USER': 'cltbld', 20:28:54 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:54 INFO - '_': '/tools/buildbot/bin/python'} 20:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:55 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:55 INFO - Cleaning up... 20:28:55 INFO - Return code: 0 20:28:55 INFO - Installing psutil>=0.7.1 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', '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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:55 INFO - '_': '/tools/buildbot/bin/python'} 20:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:55 INFO - Downloading/unpacking psutil>=0.7.1 20:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:28:56 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:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:57 INFO - Installing collected packages: psutil 20:28:57 INFO - Running setup.py install for psutil 20:28:57 INFO - building 'psutil._psutil_linux' extension 20:28:57 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:57 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:57 INFO - building 'psutil._psutil_posix' extension 20:28:57 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:57 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:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:57 INFO - Successfully installed psutil 20:28:57 INFO - Cleaning up... 20:28:57 INFO - Return code: 0 20:28:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:28:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:57 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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 20:28:57 INFO - 'HOME': '/home/cltbld', 20:28:57 INFO - 'LANG': 'en_US.UTF-8', 20:28:57 INFO - 'LANGUAGE': 'en_US:en', 20:28:57 INFO - 'LOGNAME': 'cltbld', 20:28:57 INFO - 'MAIL': '/var/mail/cltbld', 20:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:57 INFO - 'MOZ_NO_REMOTE': '1', 20:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:57 INFO - 'NO_EM_RESTART': '1', 20:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:57 INFO - 'PWD': '/builds/slave/test', 20:28:57 INFO - 'SHELL': '/bin/bash', 20:28:57 INFO - 'SHLVL': '1', 20:28:57 INFO - 'TERM': 'linux', 20:28:57 INFO - 'TMOUT': '86400', 20:28:57 INFO - 'USER': 'cltbld', 20:28:57 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:57 INFO - '_': '/tools/buildbot/bin/python'} 20:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:28:59 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:28:59 INFO - Installing collected packages: mozsystemmonitor 20:28:59 INFO - Running setup.py install for mozsystemmonitor 20:28:59 INFO - Successfully installed mozsystemmonitor 20:28:59 INFO - Cleaning up... 20:28:59 INFO - Return code: 0 20:28:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:28:59 INFO - Using env: {'DISPLAY': ':0', 20:28:59 INFO - 'HOME': '/home/cltbld', 20:28:59 INFO - 'LANG': 'en_US.UTF-8', 20:28:59 INFO - 'LANGUAGE': 'en_US:en', 20:28:59 INFO - 'LOGNAME': 'cltbld', 20:28:59 INFO - 'MAIL': '/var/mail/cltbld', 20:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:59 INFO - 'MOZ_NO_REMOTE': '1', 20:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:59 INFO - 'NO_EM_RESTART': '1', 20:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:59 INFO - 'PWD': '/builds/slave/test', 20:28:59 INFO - 'SHELL': '/bin/bash', 20:28:59 INFO - 'SHLVL': '1', 20:28:59 INFO - 'TERM': 'linux', 20:28:59 INFO - 'TMOUT': '86400', 20:28:59 INFO - 'USER': 'cltbld', 20:28:59 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:59 INFO - '_': '/tools/buildbot/bin/python'} 20:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:29:01 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:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:29:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:01 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:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:29:02 INFO - Downloading/unpacking docopt==0.6.1 (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 - Downloading docopt-0.6.1.tar.gz 20:29:02 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:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:29:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:29:02 INFO - Running setup.py install for blobuploader 20:29:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:29:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:29:02 INFO - Running setup.py install for requests 20:29:02 INFO - Running setup.py install for docopt 20:29:02 INFO - Successfully installed blobuploader requests docopt 20:29:02 INFO - Cleaning up... 20:29:02 INFO - Return code: 0 20:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:02 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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 20:29:02 INFO - 'HOME': '/home/cltbld', 20:29:02 INFO - 'LANG': 'en_US.UTF-8', 20:29:02 INFO - 'LANGUAGE': 'en_US:en', 20:29:02 INFO - 'LOGNAME': 'cltbld', 20:29:02 INFO - 'MAIL': '/var/mail/cltbld', 20:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:02 INFO - 'MOZ_NO_REMOTE': '1', 20:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:02 INFO - 'NO_EM_RESTART': '1', 20:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:02 INFO - 'PWD': '/builds/slave/test', 20:29:02 INFO - 'SHELL': '/bin/bash', 20:29:02 INFO - 'SHLVL': '1', 20:29:02 INFO - 'TERM': 'linux', 20:29:02 INFO - 'TMOUT': '86400', 20:29:02 INFO - 'USER': 'cltbld', 20:29:02 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:02 INFO - '_': '/tools/buildbot/bin/python'} 20:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:29:03 INFO - Running setup.py (path:/tmp/pip-lkrcx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:29:03 INFO - Running setup.py (path:/tmp/pip-xI4oOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:29:03 INFO - Running setup.py (path:/tmp/pip-lzODP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:29:03 INFO - Running setup.py (path:/tmp/pip-R3eNqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:29:03 INFO - Running setup.py (path:/tmp/pip-yY3otL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:29:03 INFO - Running setup.py (path:/tmp/pip-c8Jo4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:29:03 INFO - Running setup.py (path:/tmp/pip-ir_FFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:29:03 INFO - Running setup.py (path:/tmp/pip-c1HwvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:29:03 INFO - Running setup.py (path:/tmp/pip-6HSfd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:29:03 INFO - Running setup.py (path:/tmp/pip-2KGAC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:29:03 INFO - Running setup.py (path:/tmp/pip-yKv_4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:29:03 INFO - Running setup.py (path:/tmp/pip-NwrW2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:29:04 INFO - Running setup.py (path:/tmp/pip-nbhvIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:29:04 INFO - Running setup.py (path:/tmp/pip-aZUepL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:04 INFO - Running setup.py (path:/tmp/pip-pUOVxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:29:04 INFO - Running setup.py (path:/tmp/pip-iVyyOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:29:04 INFO - Running setup.py (path:/tmp/pip-4kmxmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:29:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:29:04 INFO - Running setup.py install for manifestparser 20:29:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:29:04 INFO - Running setup.py install for mozcrash 20:29:04 INFO - Running setup.py install for mozdebug 20:29:04 INFO - Running setup.py install for mozdevice 20:29:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:29:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:29:04 INFO - Running setup.py install for mozfile 20:29:04 INFO - Running setup.py install for mozhttpd 20:29:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:29:04 INFO - Running setup.py install for mozinfo 20:29:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozInstall 20:29:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozleak 20:29:05 INFO - Running setup.py install for mozlog 20:29:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for moznetwork 20:29:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozprocess 20:29:05 INFO - Running setup.py install for mozprofile 20:29:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozrunner 20:29:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:29:05 INFO - Running setup.py install for mozscreenshot 20:29:05 INFO - Running setup.py install for moztest 20:29:06 INFO - Running setup.py install for mozversion 20:29:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:29:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:29:06 INFO - Cleaning up... 20:29:06 INFO - Return code: 0 20:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:06 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:06 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:06 INFO - Using env: {'DISPLAY': ':0', 20:29:06 INFO - 'HOME': '/home/cltbld', 20:29:06 INFO - 'LANG': 'en_US.UTF-8', 20:29:06 INFO - 'LANGUAGE': 'en_US:en', 20:29:06 INFO - 'LOGNAME': 'cltbld', 20:29:06 INFO - 'MAIL': '/var/mail/cltbld', 20:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:06 INFO - 'MOZ_NO_REMOTE': '1', 20:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:06 INFO - 'NO_EM_RESTART': '1', 20:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:06 INFO - 'PWD': '/builds/slave/test', 20:29:06 INFO - 'SHELL': '/bin/bash', 20:29:06 INFO - 'SHLVL': '1', 20:29:06 INFO - 'TERM': 'linux', 20:29:06 INFO - 'TMOUT': '86400', 20:29:06 INFO - 'USER': 'cltbld', 20:29:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:06 INFO - '_': '/tools/buildbot/bin/python'} 20:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:29:06 INFO - Running setup.py (path:/tmp/pip-Fr6xtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:29:06 INFO - Running setup.py (path:/tmp/pip-hYhJ5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:29:06 INFO - Running setup.py (path:/tmp/pip-51Goxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:29:06 INFO - Running setup.py (path:/tmp/pip-yjH29u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:29:06 INFO - Running setup.py (path:/tmp/pip-1JYuHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:29:06 INFO - Running setup.py (path:/tmp/pip-yMkmtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:29:06 INFO - Running setup.py (path:/tmp/pip-GUhq7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:29:06 INFO - Running setup.py (path:/tmp/pip-wxTVOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:29:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:29:06 INFO - Running setup.py (path:/tmp/pip-OHvY0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:29:07 INFO - Running setup.py (path:/tmp/pip-khRssu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:29:07 INFO - Running setup.py (path:/tmp/pip-w_7UcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:29:07 INFO - Running setup.py (path:/tmp/pip-CRoM20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:29:07 INFO - Running setup.py (path:/tmp/pip-EfquYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:29:07 INFO - Running setup.py (path:/tmp/pip-DEF5iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:07 INFO - Running setup.py (path:/tmp/pip-hGKBcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:29:07 INFO - Running setup.py (path:/tmp/pip-JbGGYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:29:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:29:07 INFO - Running setup.py (path:/tmp/pip-FZTypT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:29:07 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:07 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:07 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:07 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:07 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:07 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:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:09 INFO - Downloading blessings-1.5.1.tar.gz 20:29:09 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:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:29:09 INFO - Installing collected packages: blessings 20:29:09 INFO - Running setup.py install for blessings 20:29:09 INFO - Successfully installed blessings 20:29:09 INFO - Cleaning up... 20:29:09 INFO - Return code: 0 20:29:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:29:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:29:09 INFO - Reading from file tmpfile_stdout 20:29:09 INFO - Current package versions: 20:29:09 INFO - argparse == 1.2.1 20:29:09 INFO - blessings == 1.5.1 20:29:09 INFO - blobuploader == 1.2.4 20:29:09 INFO - docopt == 0.6.1 20:29:09 INFO - manifestparser == 1.1 20:29:09 INFO - mozInstall == 1.12 20:29:09 INFO - mozcrash == 0.16 20:29:09 INFO - mozdebug == 0.1 20:29:09 INFO - mozdevice == 0.47 20:29:09 INFO - mozfile == 1.2 20:29:09 INFO - mozhttpd == 0.7 20:29:09 INFO - mozinfo == 0.9 20:29:09 INFO - mozleak == 0.1 20:29:09 INFO - mozlog == 3.1 20:29:09 INFO - moznetwork == 0.27 20:29:09 INFO - mozprocess == 0.22 20:29:09 INFO - mozprofile == 0.27 20:29:09 INFO - mozrunner == 6.11 20:29:09 INFO - mozscreenshot == 0.1 20:29:09 INFO - mozsystemmonitor == 0.0 20:29:09 INFO - moztest == 0.7 20:29:09 INFO - mozversion == 1.4 20:29:09 INFO - psutil == 3.1.1 20:29:09 INFO - requests == 1.2.3 20:29:09 INFO - wsgiref == 0.1.2 20:29:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:29:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:09 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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 20:29:09 INFO - 'HOME': '/home/cltbld', 20:29:09 INFO - 'LANG': 'en_US.UTF-8', 20:29:09 INFO - 'LANGUAGE': 'en_US:en', 20:29:09 INFO - 'LOGNAME': 'cltbld', 20:29:09 INFO - 'MAIL': '/var/mail/cltbld', 20:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:09 INFO - 'MOZ_NO_REMOTE': '1', 20:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:09 INFO - 'NO_EM_RESTART': '1', 20:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:09 INFO - 'PWD': '/builds/slave/test', 20:29:09 INFO - 'SHELL': '/bin/bash', 20:29:09 INFO - 'SHLVL': '1', 20:29:09 INFO - 'TERM': 'linux', 20:29:09 INFO - 'TMOUT': '86400', 20:29:09 INFO - 'USER': 'cltbld', 20:29:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:09 INFO - '_': '/tools/buildbot/bin/python'} 20:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:29:09 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:09 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:09 INFO - Cleaning up... 20:29:09 INFO - Return code: 0 20:29:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:29:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:09 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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 20:29:09 INFO - 'HOME': '/home/cltbld', 20:29:09 INFO - 'LANG': 'en_US.UTF-8', 20:29:09 INFO - 'LANGUAGE': 'en_US:en', 20:29:09 INFO - 'LOGNAME': 'cltbld', 20:29:09 INFO - 'MAIL': '/var/mail/cltbld', 20:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:09 INFO - 'MOZ_NO_REMOTE': '1', 20:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:09 INFO - 'NO_EM_RESTART': '1', 20:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:09 INFO - 'PWD': '/builds/slave/test', 20:29:09 INFO - 'SHELL': '/bin/bash', 20:29:09 INFO - 'SHLVL': '1', 20:29:09 INFO - 'TERM': 'linux', 20:29:09 INFO - 'TMOUT': '86400', 20:29:09 INFO - 'USER': 'cltbld', 20:29:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:09 INFO - '_': '/tools/buildbot/bin/python'} 20:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:10 INFO - Downloading/unpacking jsonschema 20:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:29:11 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:11 INFO - Downloading/unpacking functools32 (from 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 functools32-3.2.3-2.tar.gz 20:29:12 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:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:29:12 INFO - warning: no files found matching '*.txt' 20:29:12 INFO - no previously-included directories found matching 'build' 20:29:12 INFO - no previously-included directories found matching 'dist' 20:29:12 INFO - no previously-included directories found matching '.git*' 20:29:12 INFO - Installing collected packages: jsonschema, functools32 20:29:12 INFO - Running setup.py install for functools32 20:29:12 INFO - warning: no files found matching '*.txt' 20:29:12 INFO - no previously-included directories found matching 'build' 20:29:12 INFO - no previously-included directories found matching 'dist' 20:29:12 INFO - no previously-included directories found matching '.git*' 20:29:12 INFO - Successfully installed jsonschema functools32 20:29:12 INFO - Cleaning up... 20:29:12 INFO - Return code: 0 20:29:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:29:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:12 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 0x7f1819e1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 20:29:12 INFO - 'HOME': '/home/cltbld', 20:29:12 INFO - 'LANG': 'en_US.UTF-8', 20:29:12 INFO - 'LANGUAGE': 'en_US:en', 20:29:12 INFO - 'LOGNAME': 'cltbld', 20:29:12 INFO - 'MAIL': '/var/mail/cltbld', 20:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:12 INFO - 'MOZ_NO_REMOTE': '1', 20:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:12 INFO - 'NO_EM_RESTART': '1', 20:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:12 INFO - 'PWD': '/builds/slave/test', 20:29:12 INFO - 'SHELL': '/bin/bash', 20:29:12 INFO - 'SHLVL': '1', 20:29:12 INFO - 'TERM': 'linux', 20:29:12 INFO - 'TMOUT': '86400', 20:29:12 INFO - 'USER': 'cltbld', 20:29:12 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 20:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:12 INFO - '_': '/tools/buildbot/bin/python'} 20:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:12 INFO - Downloading/unpacking flake8 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:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:29:14 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:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:29:14 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:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:14 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:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:14 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:29:14 INFO - no previously-included directories found matching 'docs/_build' 20:29:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:29:14 INFO - Running setup.py install for 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 pep8 script to /builds/slave/test/build/venv/bin 20:29:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:29:15 INFO - Cleaning up... 20:29:15 INFO - Return code: 0 20:29:15 INFO - Running post-action listener: _resource_record_post_action 20:29:15 INFO - Running post-action listener: _start_resource_monitoring 20:29:15 INFO - Starting resource monitoring. 20:29:15 INFO - ##### 20:29:15 INFO - ##### Running install step. 20:29:15 INFO - ##### 20:29:15 INFO - Running pre-action listener: _resource_record_pre_action 20:29:15 INFO - Running main action method: install 20:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:29:15 INFO - Reading from file tmpfile_stdout 20:29:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:29:15 INFO - Reading from file tmpfile_stdout 20:29:15 INFO - Output received: 20:29:15 INFO - Usage: mozinstall [options] installer 20:29:15 INFO - Options: 20:29:15 INFO - -h, --help show this help message and exit 20:29:15 INFO - -d DEST, --destination=DEST 20:29:15 INFO - Directory to install application into. [default: 20:29:15 INFO - "/builds/slave/test"] 20:29:15 INFO - --app=APP Application being installed. [default: firefox] 20:29:15 INFO - mkdir: /builds/slave/test/build/application 20:29:15 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:15 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 0x1cda0b0>, '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 0x1cdafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb440>, '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:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:29:30 INFO - Return code: 0 20:29:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:29:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:29:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:29:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:29:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:29:30 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', '--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-068', '--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 --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-068 --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': 'd7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446', 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', '--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-068', '--webServer', 'localhost'] with output_timeout 3600 20:29:31 INFO - mozversion INFO | application_buildid: 20151203200117 20:29:31 INFO - mozversion INFO | application_changeset: f70ee6e84e82ec22a16f33c6a3f3da3402a36272 20:29:31 INFO - mozversion INFO | application_display_name: Nightly 20:29:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:29:31 INFO - mozversion INFO | application_name: Firefox 20:29:31 INFO - mozversion INFO | application_remotingname: firefox 20:29:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:29:31 INFO - mozversion INFO | application_vendor: Mozilla 20:29:31 INFO - mozversion INFO | application_version: 45.0a1 20:29:31 INFO - mozversion INFO | platform_buildid: 20151203200117 20:29:31 INFO - mozversion INFO | platform_changeset: f70ee6e84e82ec22a16f33c6a3f3da3402a36272 20:29:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:29:31 INFO - mozversion INFO | platform_version: 45.0a1 20:29:31 INFO - 2015-12-03 20:29:31,271 DEBUG : using testdate: 1449203371 20:29:31 INFO - 2015-12-03 20:29:31,271 DEBUG : actual date: 1449203371 20:29:31 INFO - 2015-12-03 20:29:31,280 INFO : starting webserver on 'localhost:51851' 20:29:31 INFO - 2015-12-03 20:29:31,282 INFO : Starting test suite talos-linux64-ix-068 20:29:31 INFO - 2015-12-03 20:29:31,282 INFO : Starting test dromaeo_css 20:29:31 INFO - 2015-12-03 20:29:31,282 DEBUG : operating with platform_type : linux_ 20:29:31 INFO - 2015-12-03 20:29:31,282 INFO : Initialising browser for dromaeo_css test... 20:29:31 INFO - 2015-12-03 20:29:31,299 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9upK1M/profile http://localhost:51851/getInfo.html 20:29:35 INFO - 2015-12-03 20:29:35,598 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:29:35 INFO - 2015-12-03 20:29:35,598 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:29:35 INFO - 2015-12-03 20:29:35,598 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:29:35 INFO - 2015-12-03 20:29:35,598 DEBUG : BROWSER_OUTPUT: __metrics 20:29:35 INFO - 2015-12-03 20:29:35,787 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:35 INFO - 2015-12-03 20:29:35,855 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:29:36 INFO - 2015-12-03 20:29:36,669 INFO : Browser initialized. 20:29:36 INFO - 2015-12-03 20:29:36,669 INFO : Running cycle 1/1 for dromaeo_css test... 20:29:36 INFO - 2015-12-03 20:29:36,670 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9upK1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:29:48 INFO - 2015-12-03 20:29:48,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 142409728 20:29:48 INFO - 2015-12-03 20:29:48,705 DEBUG : BROWSER_OUTPUT: 20:30:40 INFO - 2015-12-03 20:30:40,163 DEBUG : BROWSER_OUTPUT: 1449203440159 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:52 INFO - 2015-12-03 20:32:52,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51851/tests/dromaeo/cssquery-ext.html) 20:32:53 INFO - 2015-12-03 20:32:53,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 253116416 20:32:53 INFO - 2015-12-03 20:32:53,344 DEBUG : BROWSER_OUTPUT: 20:35:56 INFO - 2015-12-03 20:35:56,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/dromaeo/cssquery-ext.html (next: http://localhost:51851/tests/dromaeo/cssquery-jquery.html) 20:35:56 INFO - 2015-12-03 20:35:56,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 219738112 20:35:56 INFO - 2015-12-03 20:35:56,625 DEBUG : BROWSER_OUTPUT: 20:38:58 INFO - 2015-12-03 20:38:58,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51851/tests/dromaeo/cssquery-mootools.html) 20:38:59 INFO - 2015-12-03 20:38:59,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 214609920 20:38:59 INFO - 2015-12-03 20:38:59,221 DEBUG : BROWSER_OUTPUT: 20:42:01 INFO - 2015-12-03 20:42:01,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51851/tests/dromaeo/cssquery-prototype.html) 20:42:01 INFO - 2015-12-03 20:42:01,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 203980800 20:42:01 INFO - 2015-12-03 20:42:01,737 DEBUG : BROWSER_OUTPUT: 20:45:04 INFO - 2015-12-03 20:45:04,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51851/tests/dromaeo/cssquery-yui.html) 20:45:05 INFO - 2015-12-03 20:45:05,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 184532992 20:45:05 INFO - 2015-12-03 20:45:05,046 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/dromaeo/cssquery-yui.html (next: http://localhost:51851/tests/dromaeo/cssquery-dojo.html) 20:48:07 INFO - 2015-12-03 20:48:07,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 249745408 20:48:07 INFO - 2015-12-03 20:48:07,814 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,814 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:48:07 INFO - 2015-12-03 20:48:07,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:48:07 INFO - 2015-12-03 20:48:07,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:48:07 INFO - 2015-12-03 20:48:07,815 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:48:07 INFO - 2015-12-03 20:48:07,816 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2613.4250464897723;2695.9865200674017;2698.217516920093;2710.146303914267;2722.428290059088;4390.18781525418;4507.6619253555955;4717.9056418871605;4745.4305483342005;4752.881177970548;4607.147677679632;4608.884777880555;4744.739039352834;4747.667663263573;4751.9762401187945;4313.02956834712;4352.564743525654;4353.151135528573;4391;4404.933925991113;4161.292580261363;4430.712003719764;4432.778361081933;4468.061707041526;4478.462584489866;4210.115875666113;4308.3537469379535;4409.581089796464;4411.955880441219;4443.37792709021;4387.034852332514;4402.097569998143;4410.867673969786;4416.80124394403;4468.888277793081;4162.791860406998;4242.172776308621;4357.259265924768;4369.4101296325225;4425.092855964552;4531.637469002505;4534.501204867462;4650.488446270908;4657.580817726387;4687.1328804171;5056.570191533724;5098.260752190911;5099;5139.357580302462;5143.3313669223135;4747;4876.439209490883;5127.589792816566;5128.897422051576;5139.049275883974;4592.173408786417;4663.300504924255;4747.786349614275;4764.761761911891;4808.110499557593;5177.896442071137;5187.19598462239;5190.195519694454;5199.1161502544655;5228.9738551307;4731.053789242165;4851.660383773173;4997;4998.175301075282;4998.375203099613;4904.239842824368;4918.827841025619;5013.724245166478;5016.322796422509;5039.748012599355;4993.201087825931;5071.847844564669;5080.517350851663;5085.415177254589;5113.948860511422;4714.269288260325;4821.2045012572535;5036.496350365008;5053.8736531587;5057.140286151363;4073.2260870434525;4107.938380924288;4141.565135660712;4152.397902304149;4158.812853421603;3656.067702735785;3696.77819330841;3702.81485925708;3705.7035437164964;3735.14091758897;3995.800209989489;4336.371226172188;4385.342198670161;4386.122775444924;4446.066326071496;4799.520047995173;4805.495422980606;4892.2661600760175;5023.497650234947;5033.79864805411;4315.546867578922;4380.255356589388;4383.364412160219;4385.364122202327;4417.690761646654;4195.181939521825;4486.641068714495;4487.326900964881;4494.438195225597;4515.751633660115;4573.588377046081;4588.518205588499;4611.815527379002;4673.228917228619;4688.601468875184;4961;5011.974940125422;5058.089543882136;5059.038782631288;5126.923096153635;4808.543188397097;4813.711177329372;4814.759262036954;4815.927761083657;4856.1987272099705;4725.10223057618;4861.222204447272;4862.635302352409;4864.197407427735;4989.950100499093;5045.445001049955;5091.516305950929;5114.207297868837;5114.207297868837;5116.360454943132;4930.5069493050405;4939.950600493949;4941.629377796751;4944.184209605375;4964.478729733471;4601.769911504478;4709.599684026896;4716.127516409475;4802.399700037496;4916.927044586506;4791.185498465339;4795.18481858078;4805.495422980537;4833.419989601271;4848.393950756155;4908.754562271801;4919.139150648551;4921.040397122527;4921.926171107508;4949.777260023379;4481.282994720959;4568.79440425175;4569.337446070368;4587.495375508624;4789.338515999211 20:48:07 INFO - 2015-12-03 20:48:07,817 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.8243688254665;568.1562879124497;572.5648507134578;582.2547139661233;584.1121495327103;27969.44061118779;28761.568576471345;37364.43953340702;38082;38372.80813595928;41308.380374294335;41826;41870.371944420855;41931.58068419315;41933.58066419335;7011.82470438238;7942.841143177133;8082.908807311026;8105.473144245635;8108.959455202716;7067.293270672943;7163.498555101145;7171.713131474735;7173.031640728487;9522.238220942309;9994.250431217652;10109.646162384319;10110.595576176944;10112.646057387992;10115.645952391667;10195.796084078314;10196.439195844225;10287.382757034602;10296;10296.176305895548;7183.317584829433;7381.151167615685;10047.145992590638;10330.690079297634;10621.150307975344;37157.81421092877;37747;37786.244275114615;37837;37855.810720946494;2830.745232929026;2890.1185138532737;2958.467475854345;2990.790644654875;3438.3123375324785;29046.854765726246;29280.560791588145;29319;29475.263118421997;29993.250168745955;3462.4041201511163;3528.065062758371;3528.576570811493;3625.6374362563797;3639.581448133472;232633;234398;234742.00466946178;236021;236617;50922.23616645753;52810.47189528133;57375.426245737006;57739;57864;66193;67598.3240167592;67871;67922.66038669775;67933.66033169802;13198.20810751358;13395.12931659439;13403.262820544769;13407.329633518286;13414.12808167466;8635.913640863511;9013.549322533847;9019.413738107001;9026;10009.64966226193;19133.2346706133;19777.802221977883;19832.40502784919;20595.176192952113;20608;7499.100107987077;7768.495047821873;7778.766637000899;7789.182135875765;7821.139674635786;845.4082142500151;874.4185116897193;886.6586364249811;915.9862602060974;1025.266934142092;23613.881930590236;23974.28077157688;24205.51588968211;24205.63691544628;24246.15138470145;921.5032332138691;941.0730430525927;942.4627962061696;964.3249725192394;1082.9025387714985;12928.870711292766;13140.60578182656;13254.072214944861;13303.534376296782;13311.134776239513;277066;281634;281970;282110;282494;46954.5304546957;47269;47364;47407.28889066667;47430.28854567184;1200.2056924897333;1213.5570516761495;1215.2283300104498;1216.793145165324;1221.3160630047025;24453.755462445148;25028;25519.489610208064;25606.871965640054;25676.229713108638;38908;39598.80200598978;39615.83073354182;39616.40575391429;39658.40512392259;253077;253287;253613;256074;256421;24608.753912460645;25029.624555631315;26270.474590508464;28446;29360;34850.30299394049;35057;35215.82392088023;35467.93596192118;38396;29701.702982969895;30000.399991999602;30132.69867301299;30714.232144196572;31043.913463028686;30950.53574196434;31102.68897310998;31136.22159446032;31391.529127062655;32203.194920127185;27862;28270.15189544317;33305.83347083249;33323.66676333303;33630.831845841596;25341.493170136862;30101.84949075328;30131.246718832204;30136.547951780303;30171.849140754155;23277.534449311257;23657.171998979953;23841;23914.760852391948;23981.640275395534 20:48:07 INFO - 2015-12-03 20:48:07,819 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.5888298509848;333.9198592337838;334.179589108738;334.84597085340744;336.03557789145157;12529.49882004721;12980.415881285342;15003.624909377271;15454;15881.682366352681;8647.221750042494;13864;14255.643608909757;14816.11103333798;14867.702645947074;4237.4279472271155;4541.114482675879;4696.50686677899;4706.10583989041;4847.5394837490385;5002.349694539705;5042.067217564744;5044.495550444963;5048.6465947383695;5049.419316778581;4606.769661516928;4992.350994370727;5001.874953126165;5009.148444764381;5015.322931404268;4535.206338890697;4536.9092618147615;4542.750148741818;4564;4568.291914753218;4436.977815110936;4444.444444444444;4448.132614140211;4449.065696203801;4455.509893911667;11979.700507487296;14515.564533064025;15727.74178065752;18931.716024259647;18940.810591894042;1723.7414387841925;1789.8031216566167;1803.3711757544663;1864.3195233739723;1905.3426567834076;8831.205191532792;9140.085991400807;9294.07059294072;9315.580798864068;11400.94299528497;1703.8381353771372;1739.6346767178907;1743.2155530011419;1743.415955654857;1811.7554130192518;53022.46977530214;54955.45044549583;55421.16868246939;56387.76159783557;56448;9552.665656701982;9700.320977531646;9840.409575425498;9850.60597576089;9922.40465572068;10658.040776330168;11001.119910407147;11579;12248.265104093784;12270.81593776094;6802.489813264025;6943.201531823804;6977.1278590176225;7009.61447120403;7052.894206586905;6744.393004629607;6749.831254218684;6767.763128290486;6789.6605169741315;6805.2173999989645;4010.3783913493453;4080.897977550585;4095.488063992001;4122.628963393309;4205.3271476563605;1635.9100249486155;1669.699454098274;1673.2972151696317;1677.563833403324;1690.7717458143238;852.2244757270854;857.5969294431607;858.2404571953741;963.8457846744487;974.084360700953;14790.334434950239;15684.607884802743;15826.76259856103;16247.675046499004;16254.674906501803;817.4073796497491;862.8144948836031;871.5685735560811;874.5364956573027;930.9674161404454;8699.913000870038;8822.647094116164;8864.8670269946;8993.640254389751;9022.278217742565;459102;466059;466304;469216;482225;70526.64736676283;70962.29037709661;71523.64238178775;71859;72847.63576182086;1061.7080302916606;1062.0070234330926;1062.2511129653576;1077.8598782158426;1081.8160912645026;13740.519081832088;14161.362738676578;14255.429782808571;14542.200178990257;14650.267486625839;23351.883240583687;25707.614385784604;29285.560716589694;29761.255968600093;29812.701872980993;35029.47455788216;36293.63706362902;36489.27021459503;37101.25797484089;38505.42241866318;8562.357823163413;8581.227689507725;8799.076097009978;8902.73291801247;8906.554672266231;15331.463398780988;15362.692746145238;15422.845771542141;15635.530934071996;15826.68346633084;13402.93298533501;13467.663308417368;13508.662283442993;13833.446662133401;13879.583612491642;13313.267770272729;13360;13787.172769633855;13916;14088.859111408754;10789.40658263803;13412.93293533526;13582.117162384413;14131.434742610181;14171.43314267459;8407.915920840958;8683.782905427162;8685.174908383693;8915.286777057949;8922.375433719577;11900.345480998629;13000.284984325954;13280.53518126861;13444.663883402993;13515.053946224063 20:48:07 INFO - 2015-12-03 20:48:07,822 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1409.880160186384;1413.0673755321484;1429.7212043651487;1637.8034635843699;1715.3910361821554;6048.48587870031;7102;7301.963490182555;7314;7317.048783658131;7090.468214883878;7235.89146162808;7241.1672657644385;7254.637268136598;7266.527675701076;2095.8113769760716;2148.709924160242;2149.5163588192686;2149.8602590831547;2151.5696860627936;2093.3405977117236;2123.6708310211943;2148.5488047510044;2157.223399576151;2158.3956492182215;2054.7158026233606;2079.781622929593;2080.5630817528263;2096.329174664108;2099.958000839982;2119.618468675638;2141.635921893274;2143.5605700831293;2147.3772605944337;2149.6668016457475;2095.235239137719;2179.2154824263253;2183.967240491394;2188.1356864038617;2191.057845126595;5836.503897168745;5988;7182.748603798842;7267.30960558746;7268.927310726878;4131.215069136884;4228.556001619816;4228.894277643053;4234.513031001444;4237.87286381409;2640.2343320437244;2714.5249581323387;2732.5491293936675;2759.806813523054;2760.2271364018106;887.5695287785419;891.9197272245464;919.1451949686789;920.9309301802392;950.8526178442353;9601.759956001086;9658.227341812639;9662.710118696381;9695.466749328783;9700.126988570992;4084.7753373564146;4085.9795701021303;4143.399207114951;4148.854790082393;4174.269502836992;8517.48895066298;8520.318374530023;8534;8537.274331681752;8544.18830211129;4481.3726078349055;4486.59620634138;4493.752843593634;4497.865064048084;4499.932501012488;4005.3591425372383;4013.3578627419474;4035.2534781065597;4035.576264492186;4040.474738284004;3375.4261775498226;3387.5596172497417;3397.133730898605;3421.9144521386665;3426.9485957710654;1084.728817795551;1088.1947358954476;1088.613542192526;1090.569225156059;1095.288062759197;1072.6942821295893;1075.8171110911164;1093.8413929980109;1099.455769394155;1104.5416152296707;6758.391744742997;6764.898526522106;6776.864462710718;6816.591004539743;6834.179898412222;422.89427643089226;431.0947011276295;436.03853503025755;436.3890553225446;438.24840398716356;4888.706677599355;5392.487713667196;5460.290162278879;5462.262594549765;5465.4261302563455;7480.476366654282;8302.128276530999;8527.189916958003;8602.655893764178;8607.354448416268;8384.916150838535;8438.873416898752;8467.153284671484;8470.195331443503;8478.109798471196;6436.935630643728;6519.282878883319;6554.737810487527;6565.573237739532;6565.901511477332;6569.047488114292;6572.34276572339;6572.638504882278;6584.901226481702;6596.868062638816;7309.159446663702;7519.887201692089;7603.809904752205;7608.885866712115;7647.426443016685;7682.7311044113185;7782.49413788102;7829.060512738508;7860.978072850493;7872.645730942007;6390.840228994312;6698.665066746546;6922.723091076301;6950.478714096362;6958.269381714847;7019.543729657556;7060.682269297791;7063.929360706327;7065.858682826418;7069.681864316015;6456.967715161394;6538.280789113099;6611.206655201407;6705.22889867652;6763.830904227434;6562.77030303937;6582.144321238208;6609.074729537965;6635.0710900473005;6682.832929176615;6522.673866306761;6535.771248006297;6556.409923106943;6564.80305590833;6575.4410875076155;5775.48020678141;5933.139694744152;5933.643981361132;5937.495312898279;5941.881162376641;6049.18336024631;6065.54508411862;6076.240469941257;6078.665673388006;6085.208922840003 20:48:07 INFO - 2015-12-03 20:48:07,823 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.7591223372368;289.56709718970137;295.82841951668036;297.24203281631833;303.2328209629635;5335.599830012755;5395.460453954607;5400.945990540094;5410.296661434018;5410.648307859987;5308.70802105884;5316.787328506855;5320.042392369372;5331.57347412207;5338.092524270874;4137.338025915854;4142.5650306717735;4144.523379811315;4148.045949431617;4149.813258403364;3877.2245550889934;3991.720579559432;4028.113814960704;4146.854860079898;4155.376693495969;4079.021034951605;4096.487939007624;4102.405151253067;4102.876913692594;4109;3831.731778775487;3945.5857135000697;4102.8974275643195;4104.979475102636;4105.486814148247;3496.8426420811124;3583.996480985328;3588.6052534221217;3593.874214402483;3604.0629436346476;5122.513361230677;5128.538431541179;5132.101882170643;5140.33175687162;5144.922826157611;4678.321643361727;4696.342512048316;4700.224462963607;4702.177119004161;4703.576678098988;5348.491893270133;5557.5831812613815;5560.666360018412;5571.8885622287735;5584.246126772874;3886.436466712311;3890.4164375343644;3894.2600905828085;3898.961010389888;3900.3759398496386;5784.450477204701;5793.333766616851;5860.648361098348;5867.794627188028;5878.853028674274;3941.940870886939;3947.644711975936;3947.940780888289;4007.6393124618926;4010.5187377514303;4056.9797151014645;4061;4068.8575899843363;4070.6946978976102;4072.2873497137884;4420.535843736426;4576.336431217454;4592.035672508744;4593.63250939924;4599.931001034987;5583.413741557078;5590.552755779528;5591.52472039873;5595.916061259084;5601.215829783833;1339.5847287340955;1372.8695773901463;1390.8400533938525;1393.9442422302993;1394.4770710983382;923.1276443760715;924.630147940829;933.8365785987561;941.8916824565263;944.7874228298577;4969.776360063805;4977.626677999092;4982.576480999083;4984.90030199394;4986.052649996562;5842.474177324061;5845.912311315334;5848.824535263949;5852.4440178183;5856.799356131983;4951.529604687549;4981.227909674007;4985.750712464363;4992.600591952635;4992.950070499249;3061.969380306168;3108.3938631967003;3141.371725654878;3143.795653282529;3150.6691797361404;5492.1212605982855;5504.0643090674685;5545.805896793593;5558.749856256478;5572.414896435897;6028.276606807123;6030.4572588467245;6041.697915104227;6046;6047.78832740852;5504.256925315111;5551.806361632269;5565.41563135873;5568.582356323211;5574.665520068809;5714.714264286686;5859.20900678403;5870.5010074142465;5876.706164691663;5886.587938844411;5733.31200255972;5735.0537161369575;5738.225339579103;5742.052561327334;5744.224529688606;5502.944970550243;5526.50261476469;5534.142207957773;5539.252200952981;5570.164475328733;3811.7903515306925;3894.084890050892;3933.3116704577155;3938.0548668318825;3969.0672691917953;5783.942160578508;5831.79588714393;5838;5841.532677385884;5848.122781582627;5600.943990560042;5608.635438696471;5610.018246806874;5615.691136987505;5618.719064046863;5508.20131080983;5617.662940223599;5619.466150715839;5624.803131890364;5627.662340259598;5436;5477.945220547744;5488.69812160335;5495.670259784426;5497.835064948058;5442.809501667581;5607.943920560905;5642.294713160855;5646.435356464321;5649.661020338793;5432.918506222489;5499.202615620793;5554.777808887599;5560.5829562783765;5562.443755624405 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.3096635612061;758.9051368578928;776.5107981971357;788.1802924958043;805.5770720371808;12217.328046957413;12368.319742414185;12370.814437783429;12407.193532420386;12447.626571202867;11912.940435297833;11953.521859125625;11978.760424791499;11991.980681642071;12033.819492707617;624.0265186309349;630.2846269484146;784.3293983643988;795.7413840501846;811.3955103447939;799.816042310269;801.2028032108061;810.6392655268407;811.140191397118;811.3874025111033;840.7267638017669;852.5098068610574;852.5140669818206;852.6589364254286;853.1042405474227;645.6448953075814;650.073645055796;813.5281536708695;827.1025936858516;829.4442723375353;615.0466776496413;616.9136320915076;617.4473845907887;617.4720613875116;617.478230894893;11470.942645286803;11664.591739289084;11697;11719.296842189497;11734.941325293405;11349.489272982735;11991.580294689644;12042.09684273683;12211.511539538407;12266.26402415849;9266;9269.768255793591;9353.345265831394;9424.717258482257;9466.432014079177;3202.6316973548105;3256.0394683568406;3289.8848540301215;3293.7035666790102;3336.51620515024;42390.36414453786;42399.364009539575;42400.78799605982;42416;42452.15095698099;9307.898439403189;9506.857397139049;9563;9858.162056225157;9977.700668979942;17365;17655.823441765675;17672.11639418024;17673.381431649832;17677.911610441864;6516.967415162894;6523.18460192476;6604.900926486011;6634.86730265392;6840.589564626139;3414.163529935182;3444.397230484655;3518.489818976234;3550.343186510504;3608;2669.3726974161054;2686.8119231653986;2688.3144798076364;2693.676758788958;2694.770944469703;465.76478878166307;477.6035890211186;499.400719137037;501.4609295007881;503.02664344493525;572.6077636818792;595.4492094812281;597.7459579678706;601.7833579911229;614.830921496592;8095.635696393676;8702.201737846552;8750.062272704552;8895.199432051017;8909;612.5008118383503;644.8645784385332;654.4044919123575;655.4363247607054;663.3068443476482;3704.7221458390727;3942.448057271984;4030.314846476106;4133.958660413357;4147.294959856831;47906;52883.735581321846;52913.47086529085;52954.735226323624;53040;46574.534254657694;47032.294515582296;47180.7640961793;47407.52592474031;47472.05055898862;39528.20943581112;39788.60211397907;40318.193636127115;40621.39067913983;42811.35782963258;7884.250996155585;7908.248716371935;8075.83848323042;8161.959190204011;8343.123971982854;29925.55111673283;30124.698753012188;32241;32815.34369312553;32913.83543082269;38761.6123838758;38868;39426.40860387154;39460;39835.80082099571;10458.843117353093;10515.421651809223;10535.104516116216;10940.12479001662;11343.716407089889;11344.262622929484;11499.482523286639;11559.653210403701;11609;11910.166288359731;10369.377837329785;10788.514516846917;10977.725556861142;11034.117270618171;11110.833337499782;10386.740331491774;10541.367517948947;10616.363018218932;10848.403337816495;11075;10223.284370094021;10417.47912604382;10561.841572376266;10655.786884262116;10912.399818010086;8879.355821198558;9022.639094436412;9034.954825225832;9238.16856482893;9261.768455788659;9195.35632505745;9446.24430045581;9459.432434053979;9493.335466517277;9536.666216682383 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: __startTimestamp1449204487812__endTimestamp 20:48:07 INFO - 2015-12-03 20:48:07,825 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4627.89 Median:4744.74 stddev:482.90 (10.2%) stddev-sans-first:457.79 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: Values: 2613.4 2696.0 2698.2 2710.1 2722.4 4390.2 4507.7 4717.9 4745.4 4752.9 4607.1 4608.9 4744.7 4747.7 4752.0 4313.0 4352.6 4353.2 4391.0 4404.9 4161.3 4430.7 4432.8 4468.1 4478.5 4210.1 4308.4 4409.6 4412.0 4443.4 4387.0 4402.1 4410.9 4416.8 4468.9 4162.8 4242.2 4357.3 4369.4 4425.1 4531.6 4534.5 4650.5 4657.6 4687.1 5056.6 5098.3 5099.0 5139.4 5143.3 4747.0 4876.4 5127.6 5128.9 5139.0 4592.2 4663.3 4747.8 4764.8 4808.1 5177.9 5187.2 5190.2 5199.1 5229.0 4731.1 4851.7 4997.0 4998.2 4998.4 4904.2 4918.8 5013.7 5016.3 5039.7 4993.2 5071.8 5080.5 5085.4 5113.9 4714.3 4821.2 5036.5 5053.9 5057.1 4073.2 4107.9 4141.6 4152.4 4158.8 3656.1 3696.8 3702.8 3705.7 3735.1 3995.8 4336.4 4385.3 4386.1 4446.1 4799.5 4805.5 4892.3 5023.5 5033.8 4315.5 4380.3 4383.4 4385.4 4417.7 4195.2 4486.6 4487.3 4494.4 4515.8 4573.6 4588.5 4611.8 4673.2 4688.6 4961.0 5012.0 5058.1 5059.0 5126.9 4808.5 4813.7 4814.8 4815.9 4856.2 4725.1 4861.2 4862.6 4864.2 4990.0 5045.4 5091.5 5114.2 5114.2 5116.4 4930.5 4940.0 4941.6 4944.2 4964.5 4601.8 4709.6 4716.1 4802.4 4916.9 4791.2 4795.2 4805.5 4833.4 4848.4 4908.8 4919.1 4921.0 4921.9 4949.8 4481.3 4568.8 4569.3 4587.5 4789.3 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,826 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41647.80 Median:30443.04 stddev:67267.50 (221.0%) stddev-sans-first:67385.46 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: Values: 559.8 568.2 572.6 582.3 584.1 27969.4 28761.6 37364.4 38082.0 38372.8 41308.4 41826.0 41870.4 41931.6 41933.6 7011.8 7942.8 8082.9 8105.5 8109.0 7067.3 7163.5 7171.7 7173.0 9522.2 9994.3 10109.6 10110.6 10112.6 10115.6 10195.8 10196.4 10287.4 10296.0 10296.2 7183.3 7381.2 10047.1 10330.7 10621.2 37157.8 37747.0 37786.2 37837.0 37855.8 2830.7 2890.1 2958.5 2990.8 3438.3 29046.9 29280.6 29319.0 29475.3 29993.3 3462.4 3528.1 3528.6 3625.6 3639.6 232633.0 234398.0 234742.0 236021.0 236617.0 50922.2 52810.5 57375.4 57739.0 57864.0 66193.0 67598.3 67871.0 67922.7 67933.7 13198.2 13395.1 13403.3 13407.3 13414.1 8635.9 9013.5 9019.4 9026.0 10009.6 19133.2 19777.8 19832.4 20595.2 20608.0 7499.1 7768.5 7778.8 7789.2 7821.1 845.4 874.4 886.7 916.0 1025.3 23613.9 23974.3 24205.5 24205.6 24246.2 921.5 941.1 942.5 964.3 1082.9 12928.9 13140.6 13254.1 13303.5 13311.1 277066.0 281634.0 281970.0 282110.0 282494.0 46954.5 47269.0 47364.0 47407.3 47430.3 1200.2 1213.6 1215.2 1216.8 1221.3 24453.8 25028.0 25519.5 25606.9 25676.2 38908.0 39598.8 39615.8 39616.4 39658.4 253077.0 253287.0 253613.0 256074.0 256421.0 24608.8 25029.6 26270.5 28446.0 29360.0 34850.3 35057.0 35215.8 35467.9 38396.0 29701.7 30000.4 30132.7 30714.2 31043.9 30950.5 31102.7 31136.2 31391.5 32203.2 27862.0 28270.2 33305.8 33323.7 33630.8 25341.5 30101.8 30131.2 30136.5 30171.8 23277.5 23657.2 23841.0 23914.8 23981.6 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25264.01 Median:4045.64 stddev:76551.20 (1892.2%) stddev-sans-first:76743.05 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: Values: 331.6 333.9 334.2 334.8 336.0 12529.5 12980.4 15003.6 15454.0 15881.7 8647.2 13864.0 14255.6 14816.1 14867.7 4237.4 4541.1 4696.5 4706.1 4847.5 5002.3 5042.1 5044.5 5048.6 5049.4 4606.8 4992.4 5001.9 5009.1 5015.3 4535.2 4536.9 4542.8 4564.0 4568.3 4437.0 4444.4 4448.1 4449.1 4455.5 11979.7 14515.6 15727.7 18931.7 18940.8 1723.7 1789.8 1803.4 1864.3 1905.3 8831.2 9140.1 9294.1 9315.6 11400.9 1703.8 1739.6 1743.2 1743.4 1811.8 53022.5 54955.5 55421.2 56387.8 56448.0 9552.7 9700.3 9840.4 9850.6 9922.4 10658.0 11001.1 11579.0 12248.3 12270.8 6802.5 6943.2 6977.1 7009.6 7052.9 6744.4 6749.8 6767.8 6789.7 6805.2 4010.4 4080.9 4095.5 4122.6 4205.3 1635.9 1669.7 1673.3 1677.6 1690.8 852.2 857.6 858.2 963.8 974.1 14790.3 15684.6 15826.8 16247.7 16254.7 817.4 862.8 871.6 874.5 931.0 8699.9 8822.6 8864.9 8993.6 9022.3 459102.0 466059.0 466304.0 469216.0 482225.0 70526.6 70962.3 71523.6 71859.0 72847.6 1061.7 1062.0 1062.3 1077.9 1081.8 13740.5 14161.4 14255.4 14542.2 14650.3 23351.9 25707.6 29285.6 29761.3 29812.7 35029.5 36293.6 36489.3 37101.3 38505.4 8562.4 8581.2 8799.1 8902.7 8906.6 15331.5 15362.7 15422.8 15635.5 15826.7 13402.9 13467.7 13508.7 13833.4 13879.6 13313.3 13360.0 13787.2 13916.0 14088.9 10789.4 13412.9 13582.1 14131.4 14171.4 8407.9 8683.8 8685.2 8915.3 8922.4 11900.3 13000.3 13280.5 13444.7 13515.1 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5020.93 Median:6077.45 stddev:2594.90 (42.7%) stddev-sans-first:2587.98 20:48:07 INFO - 2015-12-03 20:48:07,828 DEBUG : BROWSER_OUTPUT: Values: 1409.9 1413.1 1429.7 1637.8 1715.4 6048.5 7102.0 7302.0 7314.0 7317.0 7090.5 7235.9 7241.2 7254.6 7266.5 2095.8 2148.7 2149.5 2149.9 2151.6 2093.3 2123.7 2148.5 2157.2 2158.4 2054.7 2079.8 2080.6 2096.3 2100.0 2119.6 2141.6 2143.6 2147.4 2149.7 2095.2 2179.2 2184.0 2188.1 2191.1 5836.5 5988.0 7182.7 7267.3 7268.9 4131.2 4228.6 4228.9 4234.5 4237.9 2640.2 2714.5 2732.5 2759.8 2760.2 887.6 891.9 919.1 920.9 950.9 9601.8 9658.2 9662.7 9695.5 9700.1 4084.8 4086.0 4143.4 4148.9 4174.3 8517.5 8520.3 8534.0 8537.3 8544.2 4481.4 4486.6 4493.8 4497.9 4499.9 4005.4 4013.4 4035.3 4035.6 4040.5 3375.4 3387.6 3397.1 3421.9 3426.9 1084.7 1088.2 1088.6 1090.6 1095.3 1072.7 1075.8 1093.8 1099.5 1104.5 6758.4 6764.9 6776.9 6816.6 6834.2 422.9 431.1 436.0 436.4 438.2 4888.7 5392.5 5460.3 5462.3 5465.4 7480.5 8302.1 8527.2 8602.7 8607.4 8384.9 8438.9 8467.2 8470.2 8478.1 6436.9 6519.3 6554.7 6565.6 6565.9 6569.0 6572.3 6572.6 6584.9 6596.9 7309.2 7519.9 7603.8 7608.9 7647.4 7682.7 7782.5 7829.1 7861.0 7872.6 6390.8 6698.7 6922.7 6950.5 6958.3 7019.5 7060.7 7063.9 7065.9 7069.7 6457.0 6538.3 6611.2 6705.2 6763.8 6562.8 6582.1 6609.1 6635.1 6682.8 6522.7 6535.8 6556.4 6564.8 6575.4 5775.5 5933.1 5933.6 5937.5 5941.9 6049.2 6065.5 6076.2 6078.7 6085.2 20:48:07 INFO - 2015-12-03 20:48:07,829 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,829 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4644.05 Median:5343.29 stddev:1385.66 (25.9%) stddev-sans-first:1350.40 20:48:07 INFO - 2015-12-03 20:48:07,830 DEBUG : BROWSER_OUTPUT: Values: 286.8 289.6 295.8 297.2 303.2 5335.6 5395.5 5400.9 5410.3 5410.6 5308.7 5316.8 5320.0 5331.6 5338.1 4137.3 4142.6 4144.5 4148.0 4149.8 3877.2 3991.7 4028.1 4146.9 4155.4 4079.0 4096.5 4102.4 4102.9 4109.0 3831.7 3945.6 4102.9 4105.0 4105.5 3496.8 3584.0 3588.6 3593.9 3604.1 5122.5 5128.5 5132.1 5140.3 5144.9 4678.3 4696.3 4700.2 4702.2 4703.6 5348.5 5557.6 5560.7 5571.9 5584.2 3886.4 3890.4 3894.3 3899.0 3900.4 5784.5 5793.3 5860.6 5867.8 5878.9 3941.9 3947.6 3947.9 4007.6 4010.5 4057.0 4061.0 4068.9 4070.7 4072.3 4420.5 4576.3 4592.0 4593.6 4599.9 5583.4 5590.6 5591.5 5595.9 5601.2 1339.6 1372.9 1390.8 1393.9 1394.5 923.1 924.6 933.8 941.9 944.8 4969.8 4977.6 4982.6 4984.9 4986.1 5842.5 5845.9 5848.8 5852.4 5856.8 4951.5 4981.2 4985.8 4992.6 4993.0 3062.0 3108.4 3141.4 3143.8 3150.7 5492.1 5504.1 5545.8 5558.7 5572.4 6028.3 6030.5 6041.7 6046.0 6047.8 5504.3 5551.8 5565.4 5568.6 5574.7 5714.7 5859.2 5870.5 5876.7 5886.6 5733.3 5735.1 5738.2 5742.1 5744.2 5502.9 5526.5 5534.1 5539.3 5570.2 3811.8 3894.1 3933.3 3938.1 3969.1 5783.9 5831.8 5838.0 5841.5 5848.1 5600.9 5608.6 5610.0 5615.7 5618.7 5508.2 5617.7 5619.5 5624.8 5627.7 5436.0 5477.9 5488.7 5495.7 5497.8 5442.8 5607.9 5642.3 5646.4 5649.7 5432.9 5499.2 5554.8 5560.6 5562.4 20:48:07 INFO - 2015-12-03 20:48:07,830 DEBUG : BROWSER_OUTPUT: 20:48:07 INFO - 2015-12-03 20:48:07,831 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12600.02 Median:23520.15 stddev:14247.58 (60.6%) stddev-sans-first:14259.74 20:48:07 INFO - 2015-12-03 20:48:07,831 DEBUG : BROWSER_OUTPUT: Values: 746.3 758.9 776.5 788.2 805.6 12217.3 12368.3 12370.8 12407.2 12447.6 11912.9 11953.5 11978.8 11992.0 12033.8 624.0 630.3 784.3 795.7 811.4 799.8 801.2 810.6 811.1 811.4 840.7 852.5 852.5 852.7 853.1 645.6 650.1 813.5 827.1 829.4 615.0 616.9 617.4 617.5 617.5 11470.9 11664.6 11697.0 11719.3 11734.9 11349.5 11991.6 12042.1 12211.5 12266.3 9266.0 9269.8 9353.3 9424.7 9466.4 3202.6 3256.0 3289.9 3293.7 3336.5 42390.4 42399.4 42400.8 42416.0 42452.2 9307.9 9506.9 9563.0 9858.2 9977.7 17365.0 17655.8 17672.1 17673.4 17677.9 6517.0 6523.2 6604.9 6634.9 6840.6 3414.2 3444.4 3518.5 3550.3 3608.0 2669.4 2686.8 2688.3 2693.7 2694.8 465.8 477.6 499.4 501.5 503.0 572.6 595.4 597.7 601.8 614.8 8095.6 8702.2 8750.1 8895.2 8909.0 612.5 644.9 654.4 655.4 663.3 3704.7 3942.4 4030.3 4134.0 4147.3 47906.0 52883.7 52913.5 52954.7 53040.0 46574.5 47032.3 47180.8 47407.5 47472.1 39528.2 39788.6 40318.2 40621.4 42811.4 7884.3 7908.2 8075.8 8162.0 8343.1 29925.6 30124.7 32241.0 32815.3 32913.8 38761.6 38868.0 39426.4 39460.0 39835.8 10458.8 10515.4 10535.1 10940.1 11343.7 11344.3 11499.5 11559.7 11609.0 11910.2 10369.4 10788.5 10977.7 11034.1 11110.8 10386.7 10541.4 10616.4 10848.4 11075.0 10223.3 10417.5 10561.8 10655.8 10912.4 8879.4 9022.6 9035.0 9238.2 9261.8 9195.4 9446.2 9459.4 9493.3 9536.7 20:48:07 INFO - 2015-12-03 20:48:07,831 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:48:07 INFO - 2015-12-03 20:48:07,831 DEBUG : BROWSER_OUTPUT: 20:48:08 INFO - 2015-12-03 20:48:08,622 INFO : Browser exited with error code: 0 20:48:08 INFO - 2015-12-03 20:48:08,645 INFO : Completed test dromaeo_css (00:18:37) 20:48:08 INFO - 2015-12-03 20:48:08,645 INFO : Starting test kraken 20:48:08 INFO - 2015-12-03 20:48:08,645 DEBUG : operating with platform_type : linux_ 20:48:08 INFO - 2015-12-03 20:48:08,645 INFO : Initialising browser for kraken test... 20:48:08 INFO - 2015-12-03 20:48:08,652 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyuAre/profile http://localhost:51851/getInfo.html 20:48:12 INFO - 2015-12-03 20:48:12,842 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:48:12 INFO - 2015-12-03 20:48:12,842 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:48:12 INFO - 2015-12-03 20:48:12,843 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:48:12 INFO - 2015-12-03 20:48:12,843 DEBUG : BROWSER_OUTPUT: __metrics 20:48:12 INFO - 2015-12-03 20:48:12,899 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:48:12 INFO - 2015-12-03 20:48:12,975 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:48:12 ERROR - 2015-12-03 20:48:12,983 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 20:48:13 INFO - 2015-12-03 20:48:13,921 INFO : Browser initialized. 20:48:13 INFO - 2015-12-03 20:48:13,921 INFO : Running cycle 1/1 for kraken test... 20:48:13 INFO - 2015-12-03 20:48:13,921 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyuAre/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:48:25 INFO - 2015-12-03 20:48:25,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 142860288 20:48:25 INFO - 2015-12-03 20:48:25,951 DEBUG : BROWSER_OUTPUT: 20:48:28 INFO - 2015-12-03 20:48:28,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51851/tests/kraken/driver.html?testName=audio-beat-detection) 20:48:29 INFO - 2015-12-03 20:48:29,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 178450432 20:48:29 INFO - 2015-12-03 20:48:29,189 DEBUG : BROWSER_OUTPUT: 20:48:31 INFO - 2015-12-03 20:48:31,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51851/tests/kraken/driver.html?testName=audio-dft) 20:48:32 INFO - 2015-12-03 20:48:32,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 167510016 20:48:32 INFO - 2015-12-03 20:48:32,524 DEBUG : BROWSER_OUTPUT: 20:48:35 INFO - 2015-12-03 20:48:35,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51851/tests/kraken/driver.html?testName=audio-fft) 20:48:36 INFO - 2015-12-03 20:48:36,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 152784896 20:48:36 INFO - 2015-12-03 20:48:36,081 DEBUG : BROWSER_OUTPUT: 20:48:38 INFO - 2015-12-03 20:48:38,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51851/tests/kraken/driver.html?testName=audio-oscillator) 20:48:38 INFO - 2015-12-03 20:48:38,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 155185152 20:48:38 INFO - 2015-12-03 20:48:38,713 DEBUG : BROWSER_OUTPUT: 20:48:40 INFO - 2015-12-03 20:48:40,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:48:41 INFO - 2015-12-03 20:48:41,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 157687808 20:48:41 INFO - 2015-12-03 20:48:41,541 DEBUG : BROWSER_OUTPUT: 20:48:44 INFO - 2015-12-03 20:48:44,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51851/tests/kraken/driver.html?testName=imaging-darkroom) 20:48:45 INFO - 2015-12-03 20:48:45,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 156413952 20:48:45 INFO - 2015-12-03 20:48:45,127 DEBUG : BROWSER_OUTPUT: 20:48:48 INFO - 2015-12-03 20:48:48,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51851/tests/kraken/driver.html?testName=imaging-desaturate) 20:48:49 INFO - 2015-12-03 20:48:49,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 156626944 20:48:49 INFO - 2015-12-03 20:48:49,102 DEBUG : BROWSER_OUTPUT: 20:48:52 INFO - 2015-12-03 20:48:52,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51851/tests/kraken/driver.html?testName=json-parse-financial) 20:48:52 INFO - 2015-12-03 20:48:52,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 157270016 20:48:52 INFO - 2015-12-03 20:48:52,584 DEBUG : BROWSER_OUTPUT: 20:48:54 INFO - 2015-12-03 20:48:54,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:54 INFO - 2015-12-03 20:48:54,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 167378944 20:48:54 INFO - 2015-12-03 20:48:54,920 DEBUG : BROWSER_OUTPUT: 20:48:56 INFO - 2015-12-03 20:48:56,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:57 INFO - 2015-12-03 20:48:57,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 167424000 20:48:57 INFO - 2015-12-03 20:48:57,425 DEBUG : BROWSER_OUTPUT: 20:48:59 INFO - 2015-12-03 20:48:59,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:49:00 INFO - 2015-12-03 20:49:00,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 178753536 20:49:00 INFO - 2015-12-03 20:49:00,170 DEBUG : BROWSER_OUTPUT: 20:49:02 INFO - 2015-12-03 20:49:02,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:49:03 INFO - 2015-12-03 20:49:03,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 182427648 20:49:03 INFO - 2015-12-03 20:49:03,324 DEBUG : BROWSER_OUTPUT: 20:49:05 INFO - 2015-12-03 20:49:05,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:49:06 INFO - 2015-12-03 20:49:06,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 181268480 20:49:06 INFO - 2015-12-03 20:49:06,539 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51851/tests/kraken/driver.html?testName=ai-astar) 20:49:08 INFO - 2015-12-03 20:49:08,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 239017984 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;112;111;114;100;111;113;117 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;135;153;182;134;159;156;129;169;130 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;162;160;161;164;162;161;161 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;84;93;73;78;72;89;94;73 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;129;95;95;95;128;94;94;130 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;110;109 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;147;146;146;146;146;146 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;96;96;95;96;96 20:49:08 INFO - 2015-12-03 20:49:08,558 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;73;71;71;71;71;70;71;71;70 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;70;70;72;70;68;71 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;91;84;85;84;85;84;85;85 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;126;124;130;126;121;131;121;139;130 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;143;144;145;152;140;147;145;156;140 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;68;69;70;69;69;69;68 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1002 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: __startTimestamp1449204548552__endTimestamp 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,559 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:4.79 (4.3%) stddev-sans-first:5.08 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 112.0 111.0 114.0 100.0 111.0 113.0 117.0 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.50 stddev:17.89 (11.4%) stddev-sans-first:18.81 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: Values: 157.0 135.0 153.0 182.0 134.0 159.0 156.0 129.0 169.0 130.0 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 162.0 160.0 161.0 164.0 162.0 161.0 161.0 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,561 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:81.00 stddev:8.99 (11.1%) stddev-sans-first:9.03 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 84.0 93.0 73.0 78.0 72.0 89.0 94.0 73.0 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:95.00 stddev:16.57 (17.4%) stddev-sans-first:17.18 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 129.0 95.0 95.0 95.0 128.0 94.0 94.0 130.0 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,562 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:71.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 71.0 71.0 71.0 70.0 71.0 71.0 70.0 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.17 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 70.0 70.0 72.0 70.0 68.0 71.0 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.18 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 91.0 84.0 85.0 84.0 85.0 84.0 85.0 85.0 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:128.50 stddev:5.36 (4.2%) stddev-sans-first:5.68 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 124.0 130.0 126.0 121.0 131.0 121.0 139.0 130.0 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:145.00 stddev:6.22 (4.3%) stddev-sans-first:5.29 20:49:08 INFO - 2015-12-03 20:49:08,563 DEBUG : BROWSER_OUTPUT: Values: 134.0 143.0 144.0 145.0 152.0 140.0 147.0 145.0 156.0 140.0 20:49:08 INFO - 2015-12-03 20:49:08,564 DEBUG : BROWSER_OUTPUT: 20:49:08 INFO - 2015-12-03 20:49:08,564 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 20:49:08 INFO - 2015-12-03 20:49:08,564 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 68.0 69.0 70.0 69.0 69.0 69.0 68.0 20:49:08 INFO - 2015-12-03 20:49:08,564 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:49:08 INFO - 2015-12-03 20:49:08,564 DEBUG : BROWSER_OUTPUT: 20:49:09 INFO - 2015-12-03 20:49:09,450 INFO : Browser exited with error code: 0 20:49:09 INFO - 2015-12-03 20:49:09,499 INFO : Completed test kraken (00:01:00) 20:49:09 INFO - 2015-12-03 20:49:09,499 INFO : Starting test v8_7 20:49:09 INFO - 2015-12-03 20:49:09,499 DEBUG : operating with platform_type : linux_ 20:49:09 INFO - 2015-12-03 20:49:09,499 INFO : Initialising browser for v8_7 test... 20:49:09 INFO - 2015-12-03 20:49:09,505 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu0mxcn/profile http://localhost:51851/getInfo.html 20:49:13 INFO - 2015-12-03 20:49:13,358 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:49:13 INFO - 2015-12-03 20:49:13,358 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:49:13 INFO - 2015-12-03 20:49:13,358 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:49:13 INFO - 2015-12-03 20:49:13,358 DEBUG : BROWSER_OUTPUT: __metrics 20:49:13 INFO - 2015-12-03 20:49:13,499 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,560 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:49:14 INFO - 2015-12-03 20:49:14,674 INFO : Browser initialized. 20:49:14 INFO - 2015-12-03 20:49:14,674 INFO : Running cycle 1/1 for v8_7 test... 20:49:14 INFO - 2015-12-03 20:49:14,675 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu0mxcn/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,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 142802944 20:49:26 INFO - 2015-12-03 20:49:26,698 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51851/tests/v8_7/run.html (next: http://localhost:51851/tests/v8_7/run.html) 20:49:48 INFO - 2015-12-03 20:49:48,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 442187776 20:49:48 INFO - 2015-12-03 20:49:48,307 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,307 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:49:48 INFO - 2015-12-03 20:49:48,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:49:48 INFO - 2015-12-03 20:49:48,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |0;Richards;167.44809109176154 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.70649738610905 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2059.670781893004 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |5;Earley;798.0845969672786 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 20:49:48 INFO - 2015-12-03 20:49:48,308 DEBUG : BROWSER_OUTPUT: |8;Splay;609.7560975609756 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: __startTimestamp1449204588306__endTimestamp 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,309 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,310 DEBUG : BROWSER_OUTPUT: Values: 167.4 20:49:48 INFO - 2015-12-03 20:49:48,310 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,310 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.71 Median:186.71 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,310 DEBUG : BROWSER_OUTPUT: Values: 186.7 20:49:48 INFO - 2015-12-03 20:49:48,310 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,310 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,311 DEBUG : BROWSER_OUTPUT: Values: 278.3 20:49:48 INFO - 2015-12-03 20:49:48,311 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,311 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,311 DEBUG : BROWSER_OUTPUT: Values: 5133.3 20:49:48 INFO - 2015-12-03 20:49:48,311 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,311 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2059.67 Median:2059.67 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,312 DEBUG : BROWSER_OUTPUT: Values: 2059.7 20:49:48 INFO - 2015-12-03 20:49:48,312 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,312 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,312 DEBUG : BROWSER_OUTPUT: Values: 798.1 20:49:48 INFO - 2015-12-03 20:49:48,312 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,312 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: Values: 12180.7 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: Values: 26868.4 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.76 Median:609.76 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: Values: 609.8 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: 20:49:48 INFO - 2015-12-03 20:49:48,313 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:49:48 INFO - 2015-12-03 20:49:48,314 DEBUG : BROWSER_OUTPUT: Values: 4840.6 20:49:48 INFO - 2015-12-03 20:49:48,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:49:48 INFO - 2015-12-03 20:49:48,314 DEBUG : BROWSER_OUTPUT: 20:49:49 INFO - 2015-12-03 20:49:49,206 INFO : Browser exited with error code: 0 20:49:49 INFO - 2015-12-03 20:49:49,224 INFO : Completed test v8_7 (00:00:39) 20:49:49 INFO - 2015-12-03 20:49:49,372 INFO : Completed test suite (00:20:18) 20:49:49 INFO - 2015-12-03 20:49:49,372 DEBUG : Working with test: dromaeo_css 20:49:49 INFO - 2015-12-03 20:49:49,372 DEBUG : Generating results file: dromaeo_css 20:49:49 INFO - 2015-12-03 20:49:49,374 DEBUG : Working with test: kraken 20:49:49 INFO - 2015-12-03 20:49:49,374 DEBUG : Generating results file: kraken 20:49:49 INFO - 2015-12-03 20:49:49,374 INFO : javascript benchmark 20:49:49 INFO - 2015-12-03 20:49:49,374 DEBUG : Working with test: v8_7 20:49:49 INFO - 2015-12-03 20:49:49,374 DEBUG : Generating results file: v8_7 20:49:49 INFO - 2015-12-03 20:49:49,375 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:49:49 INFO - 2015-12-03 20:49:49,429 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 20:49:49 INFO - 2015-12-03 20:49:49,430 DEBUG : process_Request line: dromaeo_css 6298.02 graph.html#tests=[[72,132,35]] 20:49:49 INFO - 2015-12-03 20:49:49,430 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:49:49 INFO - 2015-12-03 20:49:49,458 DEBUG : process_Request line: kraken 1525.70 graph.html#tests=[[232,132,35]] 20:49:49 INFO - 2015-12-03 20:49:49,458 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:49:49 INFO - 2015-12-03 20:49:49,493 DEBUG : process_Request line: v8_7 19694.32 graph.html#tests=[[230,132,35]] 20:49:49 INFO - 2015-12-03 20:49:49,494 INFO : javascript benchmark 20:49:49 INFO - 2015-12-03 20:49:49,498 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2613.4250464897723, 2695.9865200674017, 2698.217516920093, 2710.146303914267, 2722.428290059088, 4390.18781525418, 4507.6619253555955, 4717.9056418871605, 4745.4305483342005, 4752.881177970548, 4607.147677679632, 4608.884777880555, 4744.739039352834, 4747.667663263573, 4751.9762401187945, 4313.02956834712, 4352.564743525654, 4353.151135528573, 4391.0, 4404.933925991113, 4161.292580261363, 4430.712003719764, 4432.778361081933, 4468.061707041526, 4478.462584489866, 4210.115875666113, 4308.3537469379535, 4409.581089796464, 4411.955880441219, 4443.37792709021, 4387.034852332514, 4402.097569998143, 4410.867673969786, 4416.80124394403, 4468.888277793081, 4162.791860406998, 4242.172776308621, 4357.259265924768, 4369.4101296325225, 4425.092855964552, 4531.637469002505, 4534.501204867462, 4650.488446270908, 4657.580817726387, 4687.1328804171, 5056.570191533724, 5098.260752190911, 5099.0, 5139.357580302462, 5143.3313669223135, 4747.0, 4876.439209490883, 5127.589792816566, 5128.897422051576, 5139.049275883974, 4592.173408786417, 4663.300504924255, 4747.786349614275, 4764.761761911891, 4808.110499557593, 5177.896442071137, 5187.19598462239, 5190.195519694454, 5199.1161502544655, 5228.9738551307, 4731.053789242165, 4851.660383773173, 4997.0, 4998.175301075282, 4998.375203099613, 4904.239842824368, 4918.827841025619, 5013.724245166478, 5016.322796422509, 5039.748012599355, 4993.201087825931, 5071.847844564669, 5080.517350851663, 5085.415177254589, 5113.948860511422, 4714.269288260325, 4821.2045012572535, 5036.496350365008, 5053.8736531587, 5057.140286151363, 4073.2260870434525, 4107.938380924288, 4141.565135660712, 4152.397902304149, 4158.812853421603, 3656.067702735785, 3696.77819330841, 3702.81485925708, 3705.7035437164964, 3735.14091758897, 3995.800209989489, 4336.371226172188, 4385.342198670161, 4386.122775444924, 4446.066326071496, 4799.520047995173, 4805.495422980606, 4892.2661600760175, 5023.497650234947, 5033.79864805411, 4315.546867578922, 4380.255356589388, 4383.364412160219, 4385.364122202327, 4417.690761646654, 4195.181939521825, 4486.641068714495, 4487.326900964881, 4494.438195225597, 4515.751633660115, 4573.588377046081, 4588.518205588499, 4611.815527379002, 4673.228917228619, 4688.601468875184, 4961.0, 5011.974940125422, 5058.089543882136, 5059.038782631288, 5126.923096153635, 4808.543188397097, 4813.711177329372, 4814.759262036954, 4815.927761083657, 4856.1987272099705, 4725.10223057618, 4861.222204447272, 4862.635302352409, 4864.197407427735, 4989.950100499093, 5045.445001049955, 5091.516305950929, 5114.207297868837, 5114.207297868837, 5116.360454943132, 4930.5069493050405, 4939.950600493949, 4941.629377796751, 4944.184209605375, 4964.478729733471, 4601.769911504478, 4709.599684026896, 4716.127516409475, 4802.399700037496, 4916.927044586506, 4791.185498465339, 4795.18481858078, 4805.495422980537, 4833.419989601271, 4848.393950756155, 4908.754562271801, 4919.139150648551, 4921.040397122527, 4921.926171107508, 4949.777260023379, 4481.282994720959, 4568.79440425175, 4569.337446070368, 4587.495375508624, 4789.338515999211], "unit": "ms", "name": "dojo.html", "value": 4598.36764125647}, {"lowerIsBetter": false, "replicates": [559.8243688254665, 568.1562879124497, 572.5648507134578, 582.2547139661233, 584.1121495327103, 27969.44061118779, 28761.568576471345, 37364.43953340702, 38082.0, 38372.80813595928, 41308.380374294335, 41826.0, 41870.371944420855, 41931.58068419315, 41933.58066419335, 7011.82470438238, 7942.841143177133, 8082.908807311026, 8105.473144245635, 8108.959455202716, 7067.293270672943, 7163.498555101145, 7171.713131474735, 7173.031640728487, 9522.238220942309, 9994.250431217652, 10109.646162384319, 10110.595576176944, 10112.646057387992, 10115.645952391667, 10195.796084078314, 10196.439195844225, 10287.382757034602, 10296.0, 10296.176305895548, 7183.317584829433, 7381.151167615685, 10047.145992590638, 10330.690079297634, 10621.150307975344, 37157.81421092877, 37747.0, 37786.244275114615, 37837.0, 37855.810720946494, 2830.745232929026, 2890.1185138532737, 2958.467475854345, 2990.790644654875, 3438.3123375324785, 29046.854765726246, 29280.560791588145, 29319.0, 29475.263118421997, 29993.250168745955, 3462.4041201511163, 3528.065062758371, 3528.576570811493, 3625.6374362563797, 3639.581448133472, 232633.0, 234398.0, 234742.00466946178, 236021.0, 236617.0, 50922.23616645753, 52810.47189528133, 57375.426245737006, 57739.0, 57864.0, 66193.0, 67598.3240167592, 67871.0, 67922.66038669775, 67933.66033169802, 13198.20810751358, 13395.12931659439, 13403.262820544769, 13407.329633518286, 13414.12808167466, 8635.913640863511, 9013.549322533847, 9019.413738107001, 9026.0, 10009.64966226193, 19133.2346706133, 19777.802221977883, 19832.40502784919, 20595.176192952113, 20608.0, 7499.100107987077, 7768.495047821873, 7778.766637000899, 7789.182135875765, 7821.139674635786, 845.4082142500151, 874.4185116897193, 886.6586364249811, 915.9862602060974, 1025.266934142092, 23613.881930590236, 23974.28077157688, 24205.51588968211, 24205.63691544628, 24246.15138470145, 921.5032332138691, 941.0730430525927, 942.4627962061696, 964.3249725192394, 1082.9025387714985, 12928.870711292766, 13140.60578182656, 13254.072214944861, 13303.534376296782, 13311.134776239513, 277066.0, 281634.0, 281970.0, 282110.0, 282494.0, 46954.5304546957, 47269.0, 47364.0, 47407.28889066667, 47430.28854567184, 1200.2056924897333, 1213.5570516761495, 1215.2283300104498, 1216.793145165324, 1221.3160630047025, 24453.755462445148, 25028.0, 25519.489610208064, 25606.871965640054, 25676.229713108638, 38908.0, 39598.80200598978, 39615.83073354182, 39616.40575391429, 39658.40512392259, 253077.0, 253287.0, 253613.0, 256074.0, 256421.0, 24608.753912460645, 25029.624555631315, 26270.474590508464, 28446.0, 29360.0, 34850.30299394049, 35057.0, 35215.82392088023, 35467.93596192118, 38396.0, 29701.702982969895, 30000.399991999602, 30132.69867301299, 30714.232144196572, 31043.913463028686, 30950.53574196434, 31102.68897310998, 31136.22159446032, 31391.529127062655, 32203.194920127185, 27862.0, 28270.15189544317, 33305.83347083249, 33323.66676333303, 33630.831845841596, 25341.493170136862, 30101.84949075328, 30131.246718832204, 30136.547951780303, 30171.849140754155, 23277.534449311257, 23657.171998979953, 23841.0, 23914.760852391948, 23981.640275395534], "unit": "ms", "name": "ext.html", "value": 17020.003712062382}, {"lowerIsBetter": false, "replicates": [331.5888298509848, 333.9198592337838, 334.179589108738, 334.84597085340744, 336.03557789145157, 12529.49882004721, 12980.415881285342, 15003.624909377271, 15454.0, 15881.682366352681, 8647.221750042494, 13864.0, 14255.643608909757, 14816.11103333798, 14867.702645947074, 4237.4279472271155, 4541.114482675879, 4696.50686677899, 4706.10583989041, 4847.5394837490385, 5002.349694539705, 5042.067217564744, 5044.495550444963, 5048.6465947383695, 5049.419316778581, 4606.769661516928, 4992.350994370727, 5001.874953126165, 5009.148444764381, 5015.322931404268, 4535.206338890697, 4536.9092618147615, 4542.750148741818, 4564.0, 4568.291914753218, 4436.977815110936, 4444.444444444444, 4448.132614140211, 4449.065696203801, 4455.509893911667, 11979.700507487296, 14515.564533064025, 15727.74178065752, 18931.716024259647, 18940.810591894042, 1723.7414387841925, 1789.8031216566167, 1803.3711757544663, 1864.3195233739723, 1905.3426567834076, 8831.205191532792, 9140.085991400807, 9294.07059294072, 9315.580798864068, 11400.94299528497, 1703.8381353771372, 1739.6346767178907, 1743.2155530011419, 1743.415955654857, 1811.7554130192518, 53022.46977530214, 54955.45044549583, 55421.16868246939, 56387.76159783557, 56448.0, 9552.665656701982, 9700.320977531646, 9840.409575425498, 9850.60597576089, 9922.40465572068, 10658.040776330168, 11001.119910407147, 11579.0, 12248.265104093784, 12270.81593776094, 6802.489813264025, 6943.201531823804, 6977.1278590176225, 7009.61447120403, 7052.894206586905, 6744.393004629607, 6749.831254218684, 6767.763128290486, 6789.6605169741315, 6805.2173999989645, 4010.3783913493453, 4080.897977550585, 4095.488063992001, 4122.628963393309, 4205.3271476563605, 1635.9100249486155, 1669.699454098274, 1673.2972151696317, 1677.563833403324, 1690.7717458143238, 852.2244757270854, 857.5969294431607, 858.2404571953741, 963.8457846744487, 974.084360700953, 14790.334434950239, 15684.607884802743, 15826.76259856103, 16247.675046499004, 16254.674906501803, 817.4073796497491, 862.8144948836031, 871.5685735560811, 874.5364956573027, 930.9674161404454, 8699.913000870038, 8822.647094116164, 8864.8670269946, 8993.640254389751, 9022.278217742565, 459102.0, 466059.0, 466304.0, 469216.0, 482225.0, 70526.64736676283, 70962.29037709661, 71523.64238178775, 71859.0, 72847.63576182086, 1061.7080302916606, 1062.0070234330926, 1062.2511129653576, 1077.8598782158426, 1081.8160912645026, 13740.519081832088, 14161.362738676578, 14255.429782808571, 14542.200178990257, 14650.267486625839, 23351.883240583687, 25707.614385784604, 29285.560716589694, 29761.255968600093, 29812.701872980993, 35029.47455788216, 36293.63706362902, 36489.27021459503, 37101.25797484089, 38505.42241866318, 8562.357823163413, 8581.227689507725, 8799.076097009978, 8902.73291801247, 8906.554672266231, 15331.463398780988, 15362.692746145238, 15422.845771542141, 15635.530934071996, 15826.68346633084, 13402.93298533501, 13467.663308417368, 13508.662283442993, 13833.446662133401, 13879.583612491642, 13313.267770272729, 13360.0, 13787.172769633855, 13916.0, 14088.859111408754, 10789.40658263803, 13412.93293533526, 13582.117162384413, 14131.434742610181, 14171.43314267459, 8407.915920840958, 8683.782905427162, 8685.174908383693, 8915.286777057949, 8922.375433719577, 11900.345480998629, 13000.284984325954, 13280.53518126861, 13444.663883402993, 13515.053946224063], "unit": "ms", "name": "jquery.html", "value": 7993.901778174524}, {"lowerIsBetter": false, "replicates": [1409.880160186384, 1413.0673755321484, 1429.7212043651487, 1637.8034635843699, 1715.3910361821554, 6048.48587870031, 7102.0, 7301.963490182555, 7314.0, 7317.048783658131, 7090.468214883878, 7235.89146162808, 7241.1672657644385, 7254.637268136598, 7266.527675701076, 2095.8113769760716, 2148.709924160242, 2149.5163588192686, 2149.8602590831547, 2151.5696860627936, 2093.3405977117236, 2123.6708310211943, 2148.5488047510044, 2157.223399576151, 2158.3956492182215, 2054.7158026233606, 2079.781622929593, 2080.5630817528263, 2096.329174664108, 2099.958000839982, 2119.618468675638, 2141.635921893274, 2143.5605700831293, 2147.3772605944337, 2149.6668016457475, 2095.235239137719, 2179.2154824263253, 2183.967240491394, 2188.1356864038617, 2191.057845126595, 5836.503897168745, 5988.0, 7182.748603798842, 7267.30960558746, 7268.927310726878, 4131.215069136884, 4228.556001619816, 4228.894277643053, 4234.513031001444, 4237.87286381409, 2640.2343320437244, 2714.5249581323387, 2732.5491293936675, 2759.806813523054, 2760.2271364018106, 887.5695287785419, 891.9197272245464, 919.1451949686789, 920.9309301802392, 950.8526178442353, 9601.759956001086, 9658.227341812639, 9662.710118696381, 9695.466749328783, 9700.126988570992, 4084.7753373564146, 4085.9795701021303, 4143.399207114951, 4148.854790082393, 4174.269502836992, 8517.48895066298, 8520.318374530023, 8534.0, 8537.274331681752, 8544.18830211129, 4481.3726078349055, 4486.59620634138, 4493.752843593634, 4497.865064048084, 4499.932501012488, 4005.3591425372383, 4013.3578627419474, 4035.2534781065597, 4035.576264492186, 4040.474738284004, 3375.4261775498226, 3387.5596172497417, 3397.133730898605, 3421.9144521386665, 3426.9485957710654, 1084.728817795551, 1088.1947358954476, 1088.613542192526, 1090.569225156059, 1095.288062759197, 1072.6942821295893, 1075.8171110911164, 1093.8413929980109, 1099.455769394155, 1104.5416152296707, 6758.391744742997, 6764.898526522106, 6776.864462710718, 6816.591004539743, 6834.179898412222, 422.89427643089226, 431.0947011276295, 436.03853503025755, 436.3890553225446, 438.24840398716356, 4888.706677599355, 5392.487713667196, 5460.290162278879, 5462.262594549765, 5465.4261302563455, 7480.476366654282, 8302.128276530999, 8527.189916958003, 8602.655893764178, 8607.354448416268, 8384.916150838535, 8438.873416898752, 8467.153284671484, 8470.195331443503, 8478.109798471196, 6436.935630643728, 6519.282878883319, 6554.737810487527, 6565.573237739532, 6565.901511477332, 6569.047488114292, 6572.34276572339, 6572.638504882278, 6584.901226481702, 6596.868062638816, 7309.159446663702, 7519.887201692089, 7603.809904752205, 7608.885866712115, 7647.426443016685, 7682.7311044113185, 7782.49413788102, 7829.060512738508, 7860.978072850493, 7872.645730942007, 6390.840228994312, 6698.665066746546, 6922.723091076301, 6950.478714096362, 6958.269381714847, 7019.543729657556, 7060.682269297791, 7063.929360706327, 7065.858682826418, 7069.681864316015, 6456.967715161394, 6538.280789113099, 6611.206655201407, 6705.22889867652, 6763.830904227434, 6562.77030303937, 6582.144321238208, 6609.074729537965, 6635.0710900473005, 6682.832929176615, 6522.673866306761, 6535.771248006297, 6556.409923106943, 6564.80305590833, 6575.4410875076155, 5775.48020678141, 5933.139694744152, 5933.643981361132, 5937.495312898279, 5941.881162376641, 6049.18336024631, 6065.54508411862, 6076.240469941257, 6078.665673388006, 6085.208922840003], "unit": "ms", "name": "mootools.html", "value": 4061.104580346265}, {"lowerIsBetter": false, "replicates": [286.7591223372368, 289.56709718970137, 295.82841951668036, 297.24203281631833, 303.2328209629635, 5335.599830012755, 5395.460453954607, 5400.945990540094, 5410.296661434018, 5410.648307859987, 5308.70802105884, 5316.787328506855, 5320.042392369372, 5331.57347412207, 5338.092524270874, 4137.338025915854, 4142.5650306717735, 4144.523379811315, 4148.045949431617, 4149.813258403364, 3877.2245550889934, 3991.720579559432, 4028.113814960704, 4146.854860079898, 4155.376693495969, 4079.021034951605, 4096.487939007624, 4102.405151253067, 4102.876913692594, 4109.0, 3831.731778775487, 3945.5857135000697, 4102.8974275643195, 4104.979475102636, 4105.486814148247, 3496.8426420811124, 3583.996480985328, 3588.6052534221217, 3593.874214402483, 3604.0629436346476, 5122.513361230677, 5128.538431541179, 5132.101882170643, 5140.33175687162, 5144.922826157611, 4678.321643361727, 4696.342512048316, 4700.224462963607, 4702.177119004161, 4703.576678098988, 5348.491893270133, 5557.5831812613815, 5560.666360018412, 5571.8885622287735, 5584.246126772874, 3886.436466712311, 3890.4164375343644, 3894.2600905828085, 3898.961010389888, 3900.3759398496386, 5784.450477204701, 5793.333766616851, 5860.648361098348, 5867.794627188028, 5878.853028674274, 3941.940870886939, 3947.644711975936, 3947.940780888289, 4007.6393124618926, 4010.5187377514303, 4056.9797151014645, 4061.0, 4068.8575899843363, 4070.6946978976102, 4072.2873497137884, 4420.535843736426, 4576.336431217454, 4592.035672508744, 4593.63250939924, 4599.931001034987, 5583.413741557078, 5590.552755779528, 5591.52472039873, 5595.916061259084, 5601.215829783833, 1339.5847287340955, 1372.8695773901463, 1390.8400533938525, 1393.9442422302993, 1394.4770710983382, 923.1276443760715, 924.630147940829, 933.8365785987561, 941.8916824565263, 944.7874228298577, 4969.776360063805, 4977.626677999092, 4982.576480999083, 4984.90030199394, 4986.052649996562, 5842.474177324061, 5845.912311315334, 5848.824535263949, 5852.4440178183, 5856.799356131983, 4951.529604687549, 4981.227909674007, 4985.750712464363, 4992.600591952635, 4992.950070499249, 3061.969380306168, 3108.3938631967003, 3141.371725654878, 3143.795653282529, 3150.6691797361404, 5492.1212605982855, 5504.0643090674685, 5545.805896793593, 5558.749856256478, 5572.414896435897, 6028.276606807123, 6030.4572588467245, 6041.697915104227, 6046.0, 6047.78832740852, 5504.256925315111, 5551.806361632269, 5565.41563135873, 5568.582356323211, 5574.665520068809, 5714.714264286686, 5859.20900678403, 5870.5010074142465, 5876.706164691663, 5886.587938844411, 5733.31200255972, 5735.0537161369575, 5738.225339579103, 5742.052561327334, 5744.224529688606, 5502.944970550243, 5526.50261476469, 5534.142207957773, 5539.252200952981, 5570.164475328733, 3811.7903515306925, 3894.084890050892, 3933.3116704577155, 3938.0548668318825, 3969.0672691917953, 5783.942160578508, 5831.79588714393, 5838.0, 5841.532677385884, 5848.122781582627, 5600.943990560042, 5608.635438696471, 5610.018246806874, 5615.691136987505, 5618.719064046863, 5508.20131080983, 5617.662940223599, 5619.466150715839, 5624.803131890364, 5627.662340259598, 5436.0, 5477.945220547744, 5488.69812160335, 5495.670259784426, 5497.835064948058, 5442.809501667581, 5607.943920560905, 5642.294713160855, 5646.435356464321, 5649.661020338793, 5432.918506222489, 5499.202615620793, 5554.777808887599, 5560.5829562783765, 5562.443755624405], "unit": "ms", "name": "prototype.html", "value": 4191.012676942407}, {"lowerIsBetter": false, "replicates": [746.3096635612061, 758.9051368578928, 776.5107981971357, 788.1802924958043, 805.5770720371808, 12217.328046957413, 12368.319742414185, 12370.814437783429, 12407.193532420386, 12447.626571202867, 11912.940435297833, 11953.521859125625, 11978.760424791499, 11991.980681642071, 12033.819492707617, 624.0265186309349, 630.2846269484146, 784.3293983643988, 795.7413840501846, 811.3955103447939, 799.816042310269, 801.2028032108061, 810.6392655268407, 811.140191397118, 811.3874025111033, 840.7267638017669, 852.5098068610574, 852.5140669818206, 852.6589364254286, 853.1042405474227, 645.6448953075814, 650.073645055796, 813.5281536708695, 827.1025936858516, 829.4442723375353, 615.0466776496413, 616.9136320915076, 617.4473845907887, 617.4720613875116, 617.478230894893, 11470.942645286803, 11664.591739289084, 11697.0, 11719.296842189497, 11734.941325293405, 11349.489272982735, 11991.580294689644, 12042.09684273683, 12211.511539538407, 12266.26402415849, 9266.0, 9269.768255793591, 9353.345265831394, 9424.717258482257, 9466.432014079177, 3202.6316973548105, 3256.0394683568406, 3289.8848540301215, 3293.7035666790102, 3336.51620515024, 42390.36414453786, 42399.364009539575, 42400.78799605982, 42416.0, 42452.15095698099, 9307.898439403189, 9506.857397139049, 9563.0, 9858.162056225157, 9977.700668979942, 17365.0, 17655.823441765675, 17672.11639418024, 17673.381431649832, 17677.911610441864, 6516.967415162894, 6523.18460192476, 6604.900926486011, 6634.86730265392, 6840.589564626139, 3414.163529935182, 3444.397230484655, 3518.489818976234, 3550.343186510504, 3608.0, 2669.3726974161054, 2686.8119231653986, 2688.3144798076364, 2693.676758788958, 2694.770944469703, 465.76478878166307, 477.6035890211186, 499.400719137037, 501.4609295007881, 503.02664344493525, 572.6077636818792, 595.4492094812281, 597.7459579678706, 601.7833579911229, 614.830921496592, 8095.635696393676, 8702.201737846552, 8750.062272704552, 8895.199432051017, 8909.0, 612.5008118383503, 644.8645784385332, 654.4044919123575, 655.4363247607054, 663.3068443476482, 3704.7221458390727, 3942.448057271984, 4030.314846476106, 4133.958660413357, 4147.294959856831, 47906.0, 52883.735581321846, 52913.47086529085, 52954.735226323624, 53040.0, 46574.534254657694, 47032.294515582296, 47180.7640961793, 47407.52592474031, 47472.05055898862, 39528.20943581112, 39788.60211397907, 40318.193636127115, 40621.39067913983, 42811.35782963258, 7884.250996155585, 7908.248716371935, 8075.83848323042, 8161.959190204011, 8343.123971982854, 29925.55111673283, 30124.698753012188, 32241.0, 32815.34369312553, 32913.83543082269, 38761.6123838758, 38868.0, 39426.40860387154, 39460.0, 39835.80082099571, 10458.843117353093, 10515.421651809223, 10535.104516116216, 10940.12479001662, 11343.716407089889, 11344.262622929484, 11499.482523286639, 11559.653210403701, 11609.0, 11910.166288359731, 10369.377837329785, 10788.514516846917, 10977.725556861142, 11034.117270618171, 11110.833337499782, 10386.740331491774, 10541.367517948947, 10616.363018218932, 10848.403337816495, 11075.0, 10223.284370094021, 10417.47912604382, 10561.841572376266, 10655.786884262116, 10912.399818010086, 8879.355821198558, 9022.639094436412, 9034.954825225832, 9238.16856482893, 9261.768455788659, 9195.35632505745, 9446.24430045581, 9459.432434053979, 9493.335466517277, 9536.666216682383], "unit": "ms", "name": "yui.html", "value": 5859.92751959779}], "name": "dromaeo_css", "value": 6298.016468162954}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 112.0, 111.0, 114.0, 100.0, 111.0, 113.0, 117.0], "unit": "ms", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 153.0, 182.0, 134.0, 159.0, 156.0, 129.0, 169.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 164.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 84.0, 93.0, 73.0, 78.0, 72.0, 89.0, 94.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 129.0, 95.0, 95.0, 95.0, 128.0, 94.0, 94.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 71.0, 71.0, 71.0, 70.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 72.0, 70.0, 68.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 91.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 124.0, 130.0, 126.0, 121.0, 131.0, 121.0, 139.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [134.0, 143.0, 144.0, 145.0, 152.0, 140.0, 147.0, 145.0, 156.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1525.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [186.70649738610905], "unit": "score", "name": "DeltaBlue", "value": 354.12800799999997}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2059.670781893004], "unit": "score", "name": "RayTrace", "value": 359.27537862137854}, {"lowerIsBetter": false, "replicates": [798.0845969672786], "unit": "score", "name": "Earley", "value": 835.078139}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [609.7560975609756], "unit": "score", "name": "Splay", "value": 133.64524}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19694.31799792998}]} 20:49:49 INFO - RETURN: dromaeo_css: 6298.02 20:49:49 INFO - RETURN: kraken: 1525.70 20:49:49 INFO - RETURN: v8_7: 19694.32 20:49:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19694.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6298.02"}}} 20:49:49 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 ERROR - # 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: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520556544; Read time: 12; Write time: 650576 20:49:50 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 244469760; Read time: 0; Write time: 442644 20:49:50 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275791872; Read time: 12; Write time: 207900 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.129680 ========= master_lag: 0.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 20:49:51.136042) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:51.140579) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 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.009933 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.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:51.171819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:51.172230) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1449200492.675243-1564663446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004730 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 20:49:51.223725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 20:49:51.224134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 20:49:51.224498) ========= ========= Total master_lag: 0.95 =========