builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1469893200.11 results: success (0) buildid: 20160730072226 builduid: d4734284d46846a0a3779bed7576fe6f revision: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.113057) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.113717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.114061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.169216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.169519) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 08:40:00-- 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% 113M=0s 2016-07-30 08:40:00 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179099 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.379763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.380083) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017870 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.431743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:00.432521) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 --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=a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 08:40:00,562 truncating revision to first 12 chars 2016-07-30 08:40:00,562 Setting DEBUG logging. 2016-07-30 08:40:00,562 attempt 1/10 2016-07-30 08:40:00,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e5859dfe0bcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 08:40:00,899 unpacking tar archive at: mozilla-central-e5859dfe0bcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:01.124969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:01.125697) ========= script_repo_revision: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:01.126637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:01.127125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 08:40:01.137419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-30 08:40:01.137725) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:01 INFO - MultiFileLogger online at 20160730 08:40:01 in /builds/slave/test 08:40:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:40:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:01 INFO - {'append_to_log': False, 08:40:01 INFO - 'base_work_dir': '/builds/slave/test', 08:40:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:40:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:01 INFO - 'branch': 'Firefox-Non-PGO', 08:40:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:01 INFO - 'config_files': ('talos/linux_config.py',), 08:40:01 INFO - 'default_actions': ('clobber', 08:40:01 INFO - 'read-buildbot-config', 08:40:01 INFO - 'download-and-extract', 08:40:01 INFO - 'populate-webroot', 08:40:01 INFO - 'create-virtualenv', 08:40:01 INFO - 'install', 08:40:01 INFO - 'run-tests'), 08:40:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:01 INFO - 'download_minidump_stackwalk': True, 08:40:01 INFO - 'download_symbols': 'ondemand', 08:40:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:01 INFO - 'installer_path': 'installer.exe', 08:40:01 INFO - 'log_level': 'info', 08:40:01 INFO - 'log_name': 'talos', 08:40:01 INFO - 'log_to_console': True, 08:40:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:01 INFO - 'opt_config_files': (), 08:40:01 INFO - 'pip_index': False, 08:40:01 INFO - 'sps_profile': False, 08:40:01 INFO - 'sps_profile_interval': 0, 08:40:01 INFO - 'suite': 'dromaeojs', 08:40:01 INFO - 'system_bits': '32', 08:40:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:01 INFO - 'title': 'talos-linux64-ix-002', 08:40:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:01 INFO - 'use_talos_json': True, 08:40:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:01 INFO - 'work_dir': 'build'} 08:40:01 INFO - [mozharness: 2016-07-30 15:40:01.453691Z] Running clobber step. 08:40:01 INFO - Running pre-action listener: _resource_record_pre_action 08:40:01 INFO - Running main action method: clobber 08:40:01 INFO - rmtree: /builds/slave/test/build 08:40:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:01 INFO - Running post-action listener: _resource_record_post_action 08:40:01 INFO - [mozharness: 2016-07-30 15:40:01.868487Z] Finished clobber step (success) 08:40:01 INFO - [mozharness: 2016-07-30 15:40:01.868586Z] Running read-buildbot-config step. 08:40:01 INFO - Running pre-action listener: _resource_record_pre_action 08:40:01 INFO - Running main action method: read_buildbot_config 08:40:01 INFO - Using buildbot properties: 08:40:01 INFO - { 08:40:01 INFO - "project": "", 08:40:01 INFO - "product": "firefox", 08:40:01 INFO - "script_repo_revision": "production", 08:40:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:40:01 INFO - "repository": "", 08:40:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:40:01 INFO - "buildid": "20160730072226", 08:40:01 INFO - "pgo_build": "False", 08:40:01 INFO - "basedir": "/builds/slave/test", 08:40:01 INFO - "buildnumber": 168, 08:40:01 INFO - "slavename": "talos-linux64-ix-002", 08:40:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:40:01 INFO - "platform": "ubuntu64_hw", 08:40:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:40:01 INFO - "branch": "mozilla-central", 08:40:01 INFO - "repo_path": "mozilla-central", 08:40:01 INFO - "revision": "e5859dfe0bcbd40f4e33f4a633f73ea3473a7849", 08:40:01 INFO - "stage_platform": "linux64", 08:40:01 INFO - "builduid": "d4734284d46846a0a3779bed7576fe6f", 08:40:01 INFO - "slavebuilddir": "test" 08:40:01 INFO - } 08:40:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:40:01 INFO - Running post-action listener: _resource_record_post_action 08:40:01 INFO - [mozharness: 2016-07-30 15:40:01.871030Z] Finished read-buildbot-config step (success) 08:40:01 INFO - [mozharness: 2016-07-30 15:40:01.871119Z] Running download-and-extract step. 08:40:01 INFO - Running pre-action listener: _resource_record_pre_action 08:40:01 INFO - Running main action method: download_and_extract 08:40:01 INFO - mkdir: /builds/slave/test/build/tests 08:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:01 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:40:04 INFO - Downloaded 1361 bytes. 08:40:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:04 INFO - Using the following test package requirements: 08:40:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'jsshell-linux-x86_64.zip'], 08:40:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:04 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:06 INFO - Downloaded 20231949 bytes. 08:40:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:07 INFO - Return code: 0 08:40:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:07 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:19 INFO - Downloaded 20231949 bytes. 08:40:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:40:20 INFO - Return code: 0 08:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:20 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:40:22 INFO - Downloaded 14413723 bytes. 08:40:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:40:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:40:22 INFO - Return code: 0 08:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:22 INFO - https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:40:24 INFO - Downloaded 55603721 bytes. 08:40:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:24 INFO - mkdir: /builds/slave/test/properties 08:40:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:24 INFO - Contents: 08:40:24 INFO - build_url:https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:24 INFO - Running post-action listener: _resource_record_post_action 08:40:24 INFO - Running post-action listener: set_extra_try_arguments 08:40:24 INFO - [mozharness: 2016-07-30 15:40:24.861422Z] Finished download-and-extract step (success) 08:40:24 INFO - [mozharness: 2016-07-30 15:40:24.861659Z] Running populate-webroot step. 08:40:24 INFO - Running pre-action listener: _resource_record_pre_action 08:40:24 INFO - Running main action method: populate_webroot 08:40:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:24 INFO - '--tppagecycles', 08:40:24 INFO - '7'], 08:40:24 INFO - 'tests': ['tsvgm']}}, 08:40:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['damp', 'tps']}, 08:40:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'tests': ['damp', 'tps']}, 08:40:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['dromaeo_dom']}, 08:40:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['basic_compositor_video']}, 08:40:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['a11yr', 08:40:24 INFO - 'ts_paint', 08:40:24 INFO - 'tpaint', 08:40:24 INFO - 'sessionrestore', 08:40:24 INFO - 'sessionrestore_no_auto_restore', 08:40:24 INFO - 'tabpaint']}, 08:40:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:24 INFO - 'ts_paint', 08:40:24 INFO - 'tpaint', 08:40:24 INFO - 'sessionrestore', 08:40:24 INFO - 'sessionrestore_no_auto_restore', 08:40:24 INFO - 'tabpaint']}, 08:40:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:24 INFO - 'ts_paint', 08:40:24 INFO - 'tpaint', 08:40:24 INFO - 'sessionrestore', 08:40:24 INFO - 'sessionrestore_no_auto_restore', 08:40:24 INFO - 'tabpaint']}, 08:40:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:24 INFO - 'ts_paint', 08:40:24 INFO - 'tpaint', 08:40:24 INFO - 'sessionrestore', 08:40:24 INFO - 'sessionrestore_no_auto_restore', 08:40:24 INFO - 'tabpaint']}, 08:40:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['a11yr', 08:40:24 INFO - 'ts_paint', 08:40:24 INFO - 'tpaint', 08:40:24 INFO - 'sessionrestore', 08:40:24 INFO - 'sessionrestore_no_auto_restore', 08:40:24 INFO - 'tabpaint']}, 08:40:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['a11yr', 08:40:24 INFO - 'ts_paint', 08:40:24 INFO - 'tpaint', 08:40:24 INFO - 'sessionrestore', 08:40:24 INFO - 'sessionrestore_no_auto_restore', 08:40:24 INFO - 'tabpaint']}, 08:40:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['tsvgx', 08:40:24 INFO - 'tsvgr_opacity', 08:40:24 INFO - 'tart', 08:40:24 INFO - 'tscrollx', 08:40:24 INFO - 'cart']}, 08:40:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:24 INFO - 'tsvgr_opacity', 08:40:24 INFO - 'tart', 08:40:24 INFO - 'tscrollx', 08:40:24 INFO - 'cart']}, 08:40:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'talos_options': ['--disable-e10s'], 08:40:24 INFO - 'tests': ['tp5o']}, 08:40:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'tests': ['tp5o']}, 08:40:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'talos_options': ['--disable-e10s', 08:40:24 INFO - '--xperf_path', 08:40:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:24 INFO - 'tests': ['tp5n']}, 08:40:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:24 INFO - 'talos_options': ['--xperf_path', 08:40:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:24 INFO - 'tests': ['tp5n']}}, 08:40:24 INFO - 'talos.zip': {'path': '', 08:40:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:24 INFO - Running post-action listener: _resource_record_post_action 08:40:24 INFO - [mozharness: 2016-07-30 15:40:24.877366Z] Finished populate-webroot step (success) 08:40:24 INFO - [mozharness: 2016-07-30 15:40:24.877456Z] Running create-virtualenv step. 08:40:24 INFO - Running pre-action listener: _resource_record_pre_action 08:40:24 INFO - Running main action method: create_virtualenv 08:40:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:25 INFO - Using real prefix '/usr' 08:40:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:27 INFO - Installing pip.................done. 08:40:27 INFO - Return code: 0 08:40:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:27 INFO - Using env: {'DISPLAY': ':0', 08:40:27 INFO - 'HOME': '/home/cltbld', 08:40:27 INFO - 'LANG': 'en_US.UTF-8', 08:40:27 INFO - 'LANGUAGE': 'en_US:en', 08:40:27 INFO - 'LOGNAME': 'cltbld', 08:40:27 INFO - 'MAIL': '/var/mail/cltbld', 08:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:27 INFO - 'MOZ_NO_REMOTE': '1', 08:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:27 INFO - 'NO_EM_RESTART': '1', 08:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:27 INFO - 'PWD': '/builds/slave/test', 08:40:27 INFO - 'SHELL': '/bin/bash', 08:40:27 INFO - 'SHLVL': '1', 08:40:27 INFO - 'TERM': 'linux', 08:40:27 INFO - 'TMOUT': '86400', 08:40:27 INFO - 'USER': 'cltbld', 08:40:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:27 INFO - '_': '/tools/buildbot/bin/python'} 08:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:27 INFO - Cleaning up... 08:40:27 INFO - Return code: 0 08:40:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 08:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 08:40:27 INFO - Using env: {'DISPLAY': ':0', 08:40:27 INFO - 'HOME': '/home/cltbld', 08:40:27 INFO - 'LANG': 'en_US.UTF-8', 08:40:27 INFO - 'LANGUAGE': 'en_US:en', 08:40:27 INFO - 'LOGNAME': 'cltbld', 08:40:27 INFO - 'MAIL': '/var/mail/cltbld', 08:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:27 INFO - 'MOZ_NO_REMOTE': '1', 08:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:27 INFO - 'NO_EM_RESTART': '1', 08:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:27 INFO - 'PWD': '/builds/slave/test', 08:40:27 INFO - 'SHELL': '/bin/bash', 08:40:27 INFO - 'SHLVL': '1', 08:40:27 INFO - 'TERM': 'linux', 08:40:27 INFO - 'TMOUT': '86400', 08:40:27 INFO - 'USER': 'cltbld', 08:40:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:27 INFO - '_': '/tools/buildbot/bin/python'} 08:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:28 INFO - Downloading/unpacking psutil>=3.1.1 08:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:30 INFO - Installing collected packages: psutil 08:40:30 INFO - Running setup.py install for psutil 08:40:30 INFO - building 'psutil._psutil_linux' extension 08:40:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:40:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:40:31 INFO - building 'psutil._psutil_posix' extension 08:40:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:40:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:40:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:31 INFO - Successfully installed psutil 08:40:31 INFO - Cleaning up... 08:40:31 INFO - Return code: 0 08:40:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 08:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 08:40:31 INFO - Using env: {'DISPLAY': ':0', 08:40:31 INFO - 'HOME': '/home/cltbld', 08:40:31 INFO - 'LANG': 'en_US.UTF-8', 08:40:31 INFO - 'LANGUAGE': 'en_US:en', 08:40:31 INFO - 'LOGNAME': 'cltbld', 08:40:31 INFO - 'MAIL': '/var/mail/cltbld', 08:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:31 INFO - 'MOZ_NO_REMOTE': '1', 08:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:31 INFO - 'NO_EM_RESTART': '1', 08:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:31 INFO - 'PWD': '/builds/slave/test', 08:40:31 INFO - 'SHELL': '/bin/bash', 08:40:31 INFO - 'SHLVL': '1', 08:40:31 INFO - 'TERM': 'linux', 08:40:31 INFO - 'TMOUT': '86400', 08:40:31 INFO - 'USER': 'cltbld', 08:40:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:31 INFO - '_': '/tools/buildbot/bin/python'} 08:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:33 INFO - Installing collected packages: mozsystemmonitor 08:40:33 INFO - Running setup.py install for mozsystemmonitor 08:40:33 INFO - Successfully installed mozsystemmonitor 08:40:33 INFO - Cleaning up... 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 08:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 08:40:33 INFO - Using env: {'DISPLAY': ':0', 08:40:33 INFO - 'HOME': '/home/cltbld', 08:40:33 INFO - 'LANG': 'en_US.UTF-8', 08:40:33 INFO - 'LANGUAGE': 'en_US:en', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MAIL': '/var/mail/cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SHLVL': '1', 08:40:33 INFO - 'TERM': 'linux', 08:40:33 INFO - 'TMOUT': '86400', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - '_': '/tools/buildbot/bin/python'} 08:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:36 INFO - warning: no files found matching '*.txt' 08:40:36 INFO - no previously-included directories found matching 'build' 08:40:36 INFO - no previously-included directories found matching 'dist' 08:40:36 INFO - no previously-included directories found matching '.git*' 08:40:36 INFO - Installing collected packages: jsonschema, functools32 08:40:36 INFO - Running setup.py install for functools32 08:40:36 INFO - warning: no files found matching '*.txt' 08:40:36 INFO - no previously-included directories found matching 'build' 08:40:36 INFO - no previously-included directories found matching 'dist' 08:40:36 INFO - no previously-included directories found matching '.git*' 08:40:36 INFO - Successfully installed jsonschema functools32 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - Downloading docopt-0.6.1.tar.gz 08:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:39 INFO - Running setup.py install for blobuploader 08:40:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:39 INFO - Running setup.py install for requests 08:40:40 INFO - Running setup.py install for docopt 08:40:40 INFO - Successfully installed blobuploader requests docopt 08:40:40 INFO - Cleaning up... 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:40 INFO - Using env: {'DISPLAY': ':0', 08:40:40 INFO - 'HOME': '/home/cltbld', 08:40:40 INFO - 'LANG': 'en_US.UTF-8', 08:40:40 INFO - 'LANGUAGE': 'en_US:en', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MAIL': '/var/mail/cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SHLVL': '1', 08:40:40 INFO - 'TERM': 'linux', 08:40:40 INFO - 'TMOUT': '86400', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - '_': '/tools/buildbot/bin/python'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:40 INFO - Running setup.py (path:/tmp/pip-OagmSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:40 INFO - Running setup.py (path:/tmp/pip-WFJJxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:40 INFO - Running setup.py (path:/tmp/pip-dnxBkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:40 INFO - Running setup.py (path:/tmp/pip-0yKViN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:40 INFO - Running setup.py (path:/tmp/pip-n650Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:40 INFO - Running setup.py (path:/tmp/pip-XEjavV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:40 INFO - Running setup.py (path:/tmp/pip-zEWsX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:41 INFO - Running setup.py (path:/tmp/pip-Z4AMhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:41 INFO - Running setup.py (path:/tmp/pip-tWc1gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:41 INFO - Running setup.py (path:/tmp/pip-TptJDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:41 INFO - Running setup.py (path:/tmp/pip-mf726p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:41 INFO - Running setup.py (path:/tmp/pip-siz1rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:41 INFO - Running setup.py (path:/tmp/pip-UPwsj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:41 INFO - Running setup.py (path:/tmp/pip-Fe5o7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:41 INFO - Running setup.py (path:/tmp/pip-qbhadB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:41 INFO - Running setup.py (path:/tmp/pip-7CFORc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:41 INFO - Running setup.py (path:/tmp/pip-HFvUP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:41 INFO - Running setup.py install for manifestparser 08:40:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Running setup.py install for mozcrash 08:40:41 INFO - Running setup.py install for mozdebug 08:40:42 INFO - Running setup.py install for mozdevice 08:40:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozfile 08:40:42 INFO - Running setup.py install for mozhttpd 08:40:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozinfo 08:40:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozInstall 08:40:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozleak 08:40:42 INFO - Running setup.py install for mozlog 08:40:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for moznetwork 08:40:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozprocess 08:40:42 INFO - Running setup.py install for mozprofile 08:40:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozrunner 08:40:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozscreenshot 08:40:43 INFO - Running setup.py install for moztest 08:40:43 INFO - Running setup.py install for mozversion 08:40:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:43 INFO - Cleaning up... 08:40:43 INFO - Return code: 0 08:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:43 INFO - Using env: {'DISPLAY': ':0', 08:40:43 INFO - 'HOME': '/home/cltbld', 08:40:43 INFO - 'LANG': 'en_US.UTF-8', 08:40:43 INFO - 'LANGUAGE': 'en_US:en', 08:40:43 INFO - 'LOGNAME': 'cltbld', 08:40:43 INFO - 'MAIL': '/var/mail/cltbld', 08:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:43 INFO - 'MOZ_NO_REMOTE': '1', 08:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:43 INFO - 'NO_EM_RESTART': '1', 08:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:43 INFO - 'PWD': '/builds/slave/test', 08:40:43 INFO - 'SHELL': '/bin/bash', 08:40:43 INFO - 'SHLVL': '1', 08:40:43 INFO - 'TERM': 'linux', 08:40:43 INFO - 'TMOUT': '86400', 08:40:43 INFO - 'USER': 'cltbld', 08:40:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:43 INFO - '_': '/tools/buildbot/bin/python'} 08:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:43 INFO - Running setup.py (path:/tmp/pip-VvIpZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:43 INFO - Running setup.py (path:/tmp/pip-bxngOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:43 INFO - Running setup.py (path:/tmp/pip-FXCKIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:43 INFO - Running setup.py (path:/tmp/pip-0sdiXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:44 INFO - Running setup.py (path:/tmp/pip-C_D8CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:44 INFO - Running setup.py (path:/tmp/pip-8s0QUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:44 INFO - Running setup.py (path:/tmp/pip-jT_vyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:44 INFO - Running setup.py (path:/tmp/pip-0eOJhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:44 INFO - Running setup.py (path:/tmp/pip-c7m_zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:44 INFO - Running setup.py (path:/tmp/pip-UVQ5OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:44 INFO - Running setup.py (path:/tmp/pip-nSQfMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:44 INFO - Running setup.py (path:/tmp/pip-rYuUeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:44 INFO - Running setup.py (path:/tmp/pip-4tlLXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:44 INFO - Running setup.py (path:/tmp/pip-cLKI75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:44 INFO - Running setup.py (path:/tmp/pip-EdF03O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:44 INFO - Running setup.py (path:/tmp/pip-vs0xFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:44 INFO - Running setup.py (path:/tmp/pip-ZwRnbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:40:44 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:40:44 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:40:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:46 INFO - Downloading blessings-1.6.tar.gz 08:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:46 INFO - Installing collected packages: blessings 08:40:46 INFO - Running setup.py install for blessings 08:40:47 INFO - Successfully installed blessings 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:47 INFO - Reading from file tmpfile_stdout 08:40:47 INFO - Current package versions: 08:40:47 INFO - argparse == 1.2.1 08:40:47 INFO - blessings == 1.6 08:40:47 INFO - blobuploader == 1.2.4 08:40:47 INFO - docopt == 0.6.1 08:40:47 INFO - functools32 == 3.2.3-2 08:40:47 INFO - jsonschema == 2.5.1 08:40:47 INFO - manifestparser == 1.1 08:40:47 INFO - mozInstall == 1.12 08:40:47 INFO - mozcrash == 0.17 08:40:47 INFO - mozdebug == 0.1 08:40:47 INFO - mozdevice == 0.48 08:40:47 INFO - mozfile == 1.2 08:40:47 INFO - mozhttpd == 0.7 08:40:47 INFO - mozinfo == 0.9 08:40:47 INFO - mozleak == 0.1 08:40:47 INFO - mozlog == 3.3 08:40:47 INFO - moznetwork == 0.27 08:40:47 INFO - mozprocess == 0.23 08:40:47 INFO - mozprofile == 0.28 08:40:47 INFO - mozrunner == 6.12 08:40:47 INFO - mozscreenshot == 0.1 08:40:47 INFO - mozsystemmonitor == 0.3 08:40:47 INFO - moztest == 0.7 08:40:47 INFO - mozversion == 1.4 08:40:47 INFO - psutil == 3.1.1 08:40:47 INFO - requests == 1.2.3 08:40:47 INFO - wsgiref == 0.1.2 08:40:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:47 INFO - Using env: {'DISPLAY': ':0', 08:40:47 INFO - 'HOME': '/home/cltbld', 08:40:47 INFO - 'LANG': 'en_US.UTF-8', 08:40:47 INFO - 'LANGUAGE': 'en_US:en', 08:40:47 INFO - 'LOGNAME': 'cltbld', 08:40:47 INFO - 'MAIL': '/var/mail/cltbld', 08:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:47 INFO - 'MOZ_NO_REMOTE': '1', 08:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:47 INFO - 'NO_EM_RESTART': '1', 08:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:47 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 2)) 08:40:47 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 3)) 08:40:47 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 4)) 08:40:47 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 5)) 08:40:47 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 6)) 08:40:47 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 7)) 08:40:47 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 8)) 08:40:47 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 9)) 08:40:47 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:47 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 4)) 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1ac6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d87180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:40:47 INFO - Using env: {'DISPLAY': ':0', 08:40:47 INFO - 'HOME': '/home/cltbld', 08:40:47 INFO - 'LANG': 'en_US.UTF-8', 08:40:47 INFO - 'LANGUAGE': 'en_US:en', 08:40:47 INFO - 'LOGNAME': 'cltbld', 08:40:47 INFO - 'MAIL': '/var/mail/cltbld', 08:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:47 INFO - 'MOZ_NO_REMOTE': '1', 08:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:47 INFO - 'NO_EM_RESTART': '1', 08:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Running post-action listener: _resource_record_post_action 08:40:47 INFO - Running post-action listener: _start_resource_monitoring 08:40:47 INFO - Starting resource monitoring. 08:40:47 INFO - [mozharness: 2016-07-30 15:40:47.814533Z] Finished create-virtualenv step (success) 08:40:47 INFO - [mozharness: 2016-07-30 15:40:47.815473Z] Running install step. 08:40:47 INFO - Running pre-action listener: _resource_record_pre_action 08:40:47 INFO - Running main action method: install 08:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:48 INFO - Reading from file tmpfile_stdout 08:40:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:48 INFO - Reading from file tmpfile_stdout 08:40:48 INFO - Output received: 08:40:48 INFO - Usage: mozinstall [options] installer 08:40:48 INFO - Options: 08:40:48 INFO - -h, --help show this help message and exit 08:40:48 INFO - -d DEST, --destination=DEST 08:40:48 INFO - Directory to install application into. [default: 08:40:48 INFO - "/builds/slave/test"] 08:40:48 INFO - --app=APP Application being installed. [default: firefox] 08:40:48 INFO - mkdir: /builds/slave/test/build/application 08:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:04 INFO - Reading from file tmpfile_stdout 08:41:04 INFO - Output received: 08:41:04 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:04 INFO - Running post-action listener: _resource_record_post_action 08:41:04 INFO - [mozharness: 2016-07-30 15:41:04.113362Z] Finished install step (success) 08:41:04 INFO - [mozharness: 2016-07-30 15:41:04.113642Z] Running run-tests step. 08:41:04 INFO - Running pre-action listener: _resource_record_pre_action 08:41:04 INFO - Running main action method: run_tests 08:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:04 INFO - Python 2.7.3 08:41:04 INFO - Return code: 0 08:41:04 INFO - grabbing minidump binary from tooltool 08:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:04 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d853b0>, '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 0x1d862b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d86740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:41:04 INFO - Calling ['/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'] with output_timeout 600 08:41:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:04 INFO - Return code: 0 08:41:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:04 INFO - Using env: {'DISPLAY': ':0', 08:41:04 INFO - 'HOME': '/home/cltbld', 08:41:04 INFO - 'LANG': 'en_US.UTF-8', 08:41:04 INFO - 'LANGUAGE': 'en_US:en', 08:41:04 INFO - 'LOGNAME': 'cltbld', 08:41:04 INFO - 'MAIL': '/var/mail/cltbld', 08:41:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:04 INFO - 'MOZ_NO_REMOTE': '1', 08:41:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:04 INFO - 'NO_EM_RESTART': '1', 08:41:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:04 INFO - 'PWD': '/builds/slave/test', 08:41:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:04 INFO - 'SHELL': '/bin/bash', 08:41:04 INFO - 'SHLVL': '1', 08:41:04 INFO - 'TERM': 'linux', 08:41:04 INFO - 'TMOUT': '86400', 08:41:04 INFO - 'USER': 'cltbld', 08:41:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352', 08:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:04 INFO - '_': '/tools/buildbot/bin/python'} 08:41:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:04 INFO - mozversion application_buildid: 20160730072226 08:41:04 INFO - mozversion application_changeset: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 08:41:04 INFO - mozversion application_display_name: Nightly 08:41:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:04 INFO - mozversion application_name: Firefox 08:41:04 INFO - mozversion application_remotingname: firefox 08:41:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:04 INFO - mozversion application_vendor: Mozilla 08:41:04 INFO - mozversion application_version: 50.0a1 08:41:04 INFO - mozversion platform_buildid: 20160730072226 08:41:04 INFO - mozversion platform_changeset: e5859dfe0bcbd40f4e33f4a633f73ea3473a7849 08:41:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:04 INFO - mozversion platform_version: 50.0a1 08:41:04 INFO - using testdate: 1469893264 08:41:04 INFO - actual date: 1469893264 08:41:04 INFO - starting webserver on 'localhost:38122' 08:41:04 INFO - SUITE-START | Running 2 tests 08:41:04 INFO - TEST-START | dromaeo_css 08:41:04 INFO - operating with platform_type : linux_ 08:41:04 INFO - Initialising browser for dromaeo_css test... 08:41:04 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvUaf_9/profile http://localhost:38122/getInfo.html) 08:41:09 INFO - PROCESS | 3332 | __metrics Screen width/height:1600/1200 08:41:09 INFO - PROCESS | 3332 | colorDepth:24 08:41:09 INFO - PROCESS | 3332 | Browser inner width/height: 1024/697 08:41:09 INFO - PROCESS | 3332 | __metrics 08:41:10 INFO - PROCESS | 3332 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:41:10 INFO - PROCESS | 3332 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:11 INFO - TEST-INFO | 3332: exit 0 08:41:11 INFO - Browser initialized. 08:41:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:11 INFO - TEST-INFO | started process 3409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvUaf_9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:23 INFO - PROCESS | 3409 | RSS: Main: 157388800 08:41:23 INFO - PROCESS | 3409 | 08:42:15 INFO - PROCESS | 3409 | 1469893335617 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:44:28 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:38122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38122/tests/dromaeo/cssquery-ext.html) 08:44:29 INFO - PROCESS | 3409 | RSS: Main: 244740096 08:44:29 INFO - PROCESS | 3409 | 08:47:31 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:38122/tests/dromaeo/cssquery-ext.html (next: http://localhost:38122/tests/dromaeo/cssquery-jquery.html) 08:47:32 INFO - PROCESS | 3409 | RSS: Main: 249917440 08:47:32 INFO - PROCESS | 3409 | 08:50:34 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:38122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38122/tests/dromaeo/cssquery-mootools.html) 08:50:35 INFO - PROCESS | 3409 | RSS: Main: 188731392 08:50:35 INFO - PROCESS | 3409 | 08:53:37 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:38122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38122/tests/dromaeo/cssquery-prototype.html) 08:53:38 INFO - PROCESS | 3409 | RSS: Main: 189026304 08:53:38 INFO - PROCESS | 3409 | 08:56:41 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:38122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38122/tests/dromaeo/cssquery-yui.html) 08:56:41 INFO - PROCESS | 3409 | RSS: Main: 189771776 08:56:41 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:38122/tests/dromaeo/cssquery-yui.html (next: http://localhost:38122/tests/dromaeo/cssquery-dojo.html) 08:59:44 INFO - PROCESS | 3409 | RSS: Main: 281092096 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | __start_tp_report 08:59:44 INFO - PROCESS | 3409 | _x_x_mozilla_page_load 08:59:44 INFO - PROCESS | 3409 | _x_x_mozilla_page_load_details 08:59:44 INFO - PROCESS | 3409 | |i|pagename|runs| 08:59:44 INFO - PROCESS | 3409 | |0;dojo.html;2628.7765539929105;2640.207937618714;2653.4958357911983;2686.3552747340646;2691.703912569617;4642.744649044301;4740.691855029425;4753.33453316536;4875.8049678012885;4908.656394052417;4753.952460475402;4792.664513484057;4811.8797030074265;4865.391826021747;4889.217725163974;4322.697411181219;4331.501877284106;4386.38590597315;4445.888852778674;4563.087382523492;4473.776311184428;4497.9325310120375;4512.571305725951;4517.683762136652;4524.932126018096;4315.784210789448;4360.7819609019425;4365.236083685342;4369.104333611602;4453.109378124388;4367.10474352757;4417.160739459492;4479.686421950465;4483.193025255453;4486.394336764528;4371.540988196225;4455.4207952966235;4456.086502267028;4486.394336764528;4501.122281155176;4815.374001379833;4861.538153875376;4912.336834527365;4913.950860491385;4917.483664215241;4981.551660350586;5072.5434710875825;5105.183170692671;5126.589872810204;5213.061648903196;5159.303494028296;5213.478652134756;5214.400343960455;5221.242919776611;5223.2165175223645;4627.814887404534;4864.027194561067;4871.537203965618;4872.439669437989;4881.682690625169;5239.554637855748;5334.199870019528;5344.706041167773;5410.486003829708;5429.022775900376;5131.4868513148385;5141.794328226903;5149.922751158736;5199.870003249874;5202.03762303975;5010.69935803853;5214.556762675215;5262.842114736487;5263.736813159327;5269.051570717231;5029.924551131736;5076.847694569169;5076.923846142311;5157.690538567698;5164.1995490699;5090.185570308733;5092.057969275622;5098.515641014098;5098.668586541863;5155.6391052626705;4389.29771236607;4400.185965596375;4403.229434848889;4404.515503294635;4461.08547747711;3761.586225515191;3776.4524143998965;3827.483289755847;3852.5376954765047;3905.6680182184264;4436.489803672554;4438.223310920576;4439.64482841372;4484.192845287879;4491.416115904912;5172.844814655567;5211.947880521222;5220.582353411718;5221.6344855859725;5263.578913686896;4195.832166713297;4346.673999450054;4378.5183629800695;4390.385346051556;4436.223660859337;4622.722636641813;4626.32918226862;4637.884052898705;4670.836520721827;4688.601468875184;4813.229883218668;4821.083994041121;4821.252705830602;4821.734804585712;4846.636502262274;4932.975335123445;5070.746462676925;5071.518205770446;5101.7194054327365;5138.563222126011;4775.06886157196;4825.5174482551465;4834.081524510332;4835.879103022453;4882.218844984785;5026.59787217029;5054.444011158696;5058.54473097423;5059.215821547666;5068.619853511075;4949.950500494949;5091.363579552556;5105.744712764421;5110.233464980134;5180.041692286939;5015.824446144367;5035.320231768665;5037.219231019198;5043.9747801260755;5057.4942505750605;4984.950150498448;4987.8753031173055;4990.076835785391;5024.6231532634465;5030.748462576783;4784;4808.687435316693;4847.491013443538;4868.537488938545;4992.750362481934;5003.249512573143;5005.024020316004;5008.048470790538;5010.473900240422;5016;4901.215805471107;4901.754912254301;4905.607551395951;4911.435184953633;4944.629152813482 08:59:44 INFO - PROCESS | 3409 | |1;ext.html;558.3690429814309;565.9603827732059;574.2706762411738;581.1109003225065;596.5734499832619;26780.59829102565;39522.60477395229;40117.59882401175;40171.79914100425;44874.32688509667;41706.16587668245;42140.367894481606;42227.36658950111;42229.7888510557;42280.57719422805;7770.378369730408;7911.604419779017;7914.6438410271385;7914.881276780824;7919.247671471201;7364.116306043283;9885.802283954317;10080.39517628941;10104.797904041914;10455.790884182312;10210.744731381701;10240.003199376088;10298.17614590831;10314.535845886916;10337.586496540129;10111.090001899827;10152.03555662211;10174.745631359237;10175.491225438698;10177.643782467578;9963.80072398548;9978.750531236705;9982.450965196911;9984.301098923079;9991.700248992542;38655.22689546221;38920;38924.80537597294;38957.61042389568;38970;2975.181824998121;3074.4773388524004;3178.4914413693928;3234.644189139193;3323.302106557626;29607.111786646434;29828.40343193124;30139.547906781416;30256;31579.368412631848;3261.4944683574086;3313.2710803623163;3316.4196265653413;3387.6442973487674;3494.825258737053;198151.99999999854;199172;199644;201088.99999999854;201311.99344003331;31559.21101972469;54460;54473.72763136238;54774;54825;32391;34303;34330.14174645654;34346.82826585851;34372.48441273383;13647.362316522082;13786.862131378759;13790;13801.723965520634;13808.17150970945;10066.899331006744;11059.115270778319;11203.60787372438;11274.549018039186;11276.54893804255;7884.17216192303;7898.723544676023;8030.156833532395;8034.638441270157;8044.356451483867;3114.5016797312323;3148.165736079941;3175.8253296068474;3177.253345463814;3226;828.3166387730147;867.6919693508839;896.7668406214431;1024.1908891975256;1039.4906495816995;26224.21327360182;28318.9642254171;28458.573121403195;28635;28962.131136065953;1036.5076588620345;1043.4626167523732;1047.2930771729052;1052.563186277686;1092.229977865603;14195.574132776033;15053.397864085315;15112.697746045018;15198.620034499227;15327.770083448757;127423;127475;128725;128748;129026.35486822505;50626.74686626617;51169.23246151311;51200.23199652008;51253.7437312811;51309.48690513122;1102.1293178389144;1175.7237049293237;1190.5297407524154;1196.7367179220732;1217.5981925964588;29078.854605726836;29931.401371972002;30537.694623053485;30629.54055689211;30750.84624576863;43943.34084988664;44605.77697111494;44622.10755784931;44662.77668611636;44662.776686117664;316561;318370;318817;319671;320311;25614.359641009123;26678;26768.866155669097;27687.30781730473;27759.58360624552;42633.57366426296;43116.78441607772;43273;43297.567024330616;43905.56094439015;36079;36673.26653466969;37207.81396093002;37307.81346093252;37491.62508374881;36056.4591531122;36298.092547686516;36655.25085618642;36751.448728268566;37099.25801483901;36068.07616442071;36120.096997575274;36328;36350.8182459086;36575.63424365722;32745.34509309848;35492.82253588819;36484.81757591195;36504.43581785678;37062.44406333961;26001.699915004552;26117.477650447265;26139.738602613732;26163.215103546925;26527.867360663073 08:59:44 INFO - PROCESS | 3409 | |2;jquery.html;342.0798053236791;363.9144800971772;365.0745360511105;368.5466875742837;389.54228781182104;13318.866811331884;14527.418903243872;16682.332706691748;16897.83102168978;17362.39231626893;16219.83780162198;17153.57116072099;17307.653846923055;17349.566260843487;17391.217395217212;4845;5080.034793389263;5092.643514953955;5094.414142373619;5097.5667068299235;3792.829322680472;5009.298698182258;5046.889684269455;5847.649141051551;6163.969180154093;6147.477464415508;6205.255369355684;6218.098375735515;6221.9688901555655;6224.346443623423;5819.301683797929;5904.97047514764;5914.733836977303;5915.231019967419;5959.3146788119275;5044.873878153039;5195.064888320101;5196.142636464979;5197.870053248661;5199.090159222121;20798.48003799902;21020.684689729667;21072.473188170265;21159.894200529052;21191.364259072252;2027.6755719084877;2091.5294058836794;2206.984786997983;2360.173939121311;2480.1691433369842;9433.151016408556;9435.952820235923;12109.93945030278;12502.937485312606;12638.810417843648;1756.5696404381008;1790.588164722108;1791.2029147029577;1816.4459839748872;1821.034851528692;67019.66490167567;74125.62937185279;84362;84825.57587212085;86238;15824.60438489047;16424.125777988804;16617.83382166163;16634.58413539647;16968.321267149422;29735.553966690517;29737.702622973928;29796.55305170381;29814.55278170829;29866.552001719992;9233.122853328923;9379.124175164858;9433.811323773623;9570.665026724171;9605.759856003655;7445.553266804009;7708;7712.730054448068;7964.681412743541;7993.400494962901;8221.671133154727;8317.95841020791;8336.583170841433;8412.873806892901;8547.829043419097;3358.6473420290517;3358.8302245018995;3437.3125374925116;3447;3490.441529355291;716.9301286948318;728.6320408193828;775.9185285544936;785.9056913170456;881.2905610983092;16770.413035543697;17014.574635633962;17501.91249043772;17749.7337539937;18176.636467270582;845.526505157114;851.0808327006818;881.1893058386172;882.642529775442;888.7555922121468;9263.90736092644;9719.368241064309;9798.412095274307;9818.410895346302;9901.40591564494;286808;291418;292647;393270;395822;77609;78348.60825695835;79961;80239.19760802317;81068;873.7204094689638;883.9911600884166;912.4844462878452;917.655879045358;923.6536298887917;15826.68346633084;15947.920260398623;16219.837801621832;16672.083035433167;16912;36052;36605;36690.26619467649;37232.627673724;38009.809950951174;51618.48381516287;51744.741276293375;52015.73992130015;53330;54158.18762718484;7463.365613922877;7504.512206706547;7603.505772124794;7624.351930086005;7682.385409167365;8812.515311657664;11088.057515110982;11121.16591255643;11259.03879189815;11964.282143071443;9740.123388895034;9897.851532226878;10146.289759716748;10436.321639093434;10493.737656558647;9932.652357167754;10333.741656458347;10448.42533660656;10598.20513461478;10706.197035222234;9920.355176913477;10161.475778633265;10176.440295783506;10295.485225738534;10308.948455257676;7459.664315105725;7494.213107623621;7646.082470103401;7650.349720273839;7651.846963060819;8894;9655.710328690151;9752.658656947257;9814.06766357195;10117.696469105938 08:59:44 INFO - PROCESS | 3409 | |3;mootools.html;1319.089828018667;1361.4826365980928;1389.2081513537282;1645.8107317658473;1659.493854374416;7165.462590305729;7646.273604007617;7647.847043059135;7649.92350076499;7651.579163146025;6305.337939516354;7061.470389720778;7208.207097219301;7274;7543.094828620573;2145.6674215496623;2179.226374637005;2180.6401943679275;2182.19258874216;2183.5632873425297;2155.644318687415;2179.5640871825617;2209.4586826227596;2211.7788221177834;2213.756486786452;2151.333086743107;2166.9133234670594;2170.8046275835172;2171.4245724882917;2186.3987403464093;2094.6334391481505;2098.328534868843;2099.611571859211;2100.949525237389;2102.02255950982;2070.6272870883236;2115.397111823123;2117.2589593642256;2119.0676102515;2119.5548934723724;7406.703731850719;7460.888086678704;7474.439417043689;7509.173990861001;7571.129320128201;4388.934165987513;4526;4528.8867778305475;4529.1621050105505;4532.274836026253;2738.972610273892;2830.844303563303;2893.363460038788;2895.869685864141;2900.4779139755046;816.6610856494548;832.2551316571695;872.6291326186409;880.0495464897895;890.2788741119714;10028.548715307828;10142;10162;10164.745881352952;10209.744756381077;3989.740666856645;4080.5307389649975;4232.619064284229;4243.342281946303;4293.763842988666;8755.605997730117;8756.4308319959;8756.8686469703;8759.34304927133;8800.955995219983;4642.767861606906;4645.512221216791;4647.604953578916;4650.18621741194;4652.744099074584;3642.399004164336;3947.4670919426085;4109.815058322382;4261.786910654455;4263.253930562139;3555.520004799319;3573.8213089345427;3688.243909998444;3693.6121707220354;3713.1274150574595;1142.497301187475;1157.4964890272759;1167.772284404533;1175.5474142455216;1186.2704436771323;840.7393707950555;852.5311078906576;862.6290695001085;871.4117970369975;875.4484674654926;5164.354455693038;5253.632245742838;5373.462653734595;5405;5463.69949652765;406.1349325935738;408.74044981437004;414.3246508191689;414.55435406937664;424.39947474323486;3479.7738147020364;3602.9099272518397;3606.062423769839;3606.8737594184076;3815.04623844039;8916.286697064219;9094.86357704635;9147.0852914708;9156.542172891463;9157.221636160868;9074.092590740873;9079.409838360485;9122;9125.680601178927;9134.543272836465;6603;6865;6870.416014638712;6991.265917078634;7020.438364930896;5188.792448302026;5320;5337.919931201112;5383.7846486140115;5559.499645031967;8345.165483451607;8374.413791034813;8590.398672092893;8648.524331161594;8718.476891386537;8600.956995214983;8749.387542871938;8773.736787896374;8807.471551706662;8810.735677929672;6413.262474815456;6547.377999090078;6611.966940165268;6700.43046341047;6853.280405557344;7350.889736654061;7364.116306043309;7397.8150546236775;7398.149212840593;7400.259974002557;6363.61818290904;6486.870262594816;6515.087887695821;6639.900401494078;6697.9953007049335;6170.290416602148;6225.346338634559;6279.905801413074;6358.364163583789;6425.807225783234;6194.039923811816;6292.150559674568;6293.55945083858;6294.213223347082;6296.496280297473;4356.825726970886;4375.584319489643;4418.6023257906945;4485.46174459054;4603.746793926366;4611.907761844812;4630.490646029001;4649.0469453761225;4657.045305712253;4666.580007799314 08:59:44 INFO - PROCESS | 3409 | |4;prototype.html;286.43572162839206;291.82636331382827;292.3772364862843;295.8624239728526;297.07461258180757;5034.29519867218;5053.166227572451;5063.721495317756;5081.187010078388;5087.516685914837;4916.385451818523;4994.301937341313;4994.775235114419;4995.600351971842;5000.849974500771;3705.277470893177;3808.2954653389074;3855.4602355670227;3865.8646947356847;3888.494495715567;3898.1229223424784;3916.647501724844;3916.981584787947;3950.940735888964;3960.4059391091423;3871.264459752652;3878.1080351519167;3881.709791223178;3882.7282090253693;3916.3929590913453;3656.3053019926397;3692.353838078339;3870.858096861433;3890.824912878927;3897.2984862724697;3423.828808559587;3429.159855835311;3437.810920399377;3462.307538492312;3471.1322169457635;4808.687435316729;4809.374781278447;4813.614910807162;4820.276958456225;4820.63845211607;4226.957730422687;4438.733675979452;4439.378487011821;4450.310201918675;4450.3991961085485;5158.716270605115;5163.14808056674;5167.354080739908;5180.300659410969;5184.792608295664;3771.4531392948143;3774.150816066363;3777.0934975605933;3781.640744129303;3785.8296376663116;5322.551626251929;5447.4824891635235;5480.479354461359;5499.615026948115;5512.228288039678;3802.4106263529197;3828.196078823423;3833.15670552478;3833.7124715646437;3835.753380151462;3888.727789054739;3899.1421887184774;3910.921781564353;3921.2157568485845;3922.8234729437245;4427.512973572904;4432.844850430284;4433.756143412079;4458.331250312479;4465.821367145278;4958.851234462972;5193.428722840485;5197;5211.1922651989;5239.952009598096;1349.7840345544666;1361.5907535700503;1363.7886127650231;1365.4060483689627;1365.877071063609;842.8946381702287;876.6712482818942;878.200837238123;883.2315885179806;893.3701740273092;4148.481439820022;4338.8047537860875;4414.977925110418;4557.908841823145;4563.292689633112;5347.919781203285;5352.19717042439;5364.088105022156;5374.333956473506;5377.166539186433;4524.434445694288;4537.137943790669;4558.427342566809;4564.885877853014;4577.267637178035;2683.5840444731098;2803.5794630805135;2823.1530540838075;2838;2845.5873898285045;5010.1733214020005;5028.924566131511;5034.716147382394;5047.318611987408;5052.57053150479;5272.420033796279;5474.206240095164;5476.302346272589;5478.178273258964;5495.725213739297;4992.750362481934;4997.25041243809;5022.472640372781;5023.246513023076;5034.414159539807;5277.762500687401;5342.572594192377;5347.1979203119845;5349.893002139857;5360.410354860885;5033.697978121324;5230.372355317386;5239.109351410193;5249.685018898878;5268.972550352644;5036.924446133237;5043.067032598981;5043.5712964398435;5054.725373581977;5077.441481436965;3655.2506736119562;3696.667299943018;3696.981515092515;3725.96274037267;3733.8879833605033;5184.1160283079735;5239;5262.289590905179;5318.308619879391;5324.920126198188;5081.314022606901;5093.847184584469;5095.87260318495;5109.156989096758;5112.130937740668;5090.898182036412;5107.514786095315;5109.6678715883345;5166.354205724285;5176.352955880515;4835.903281934412;4917.336159618549;5031;5061.330535361833;5066.885285237242;4920.188168952082;4978.27814966835;5120.539151476385;5125.1799712045895;5132.46109158533;5069.946671598009;5083.593312535062;5083.923741143812;5086.18621020635;5126.333576635014 08:59:44 INFO - PROCESS | 3409 | |5;yui.html;622.4149299658321;624.5011971268957;639.5363361562864;639.7057353617337;646.369789455281;11748.883856033674;12775.680607984805;12778.10553261272;12882.291473968928;12978.805317920214;12591.370431478412;12727.42726577304;12793.296368699717;12797.616071517868;12805.103642744989;643.4530648948403;766.2452484302971;771.3327971304809;771.9961400192991;777.6772639354662;763.9732609358673;785.8467598818232;787.5786454246951;796.3151689546985;796.9322607578363;822.6585966823791;822.7696245051395;824.4888169335021;824.9876251856227;825.2655136928139;671.9160104986877;816.9714060007931;819.2790344496864;820.0897004325194;820.5158956215831;572.9427057294279;590.4862769390614;590.9793157239476;591.3436085944599;591.6124938165508;11502.309861408343;11683.357415342152;12004.519819207222;12145.696357591043;12200.633980980496;11867.881321186764;12054.216475929037;12180.086493513021;12701.110922235448;12833.67915802103;11566.016888564482;11578.94210528942;11851.407429628483;11896.107791915554;12118.030557555463;3902.2000489899788;3904.9609503905167;3934.527856657191;3938.113924367023;4010.278149933011;57868.71065644645;57920;58148;58336;58880.70559647217;9830.75423114428;9844.655437059668;10022.949885250673;10213.591456341663;10232.744181395376;18610.348637797884;19379.321723739882;19684.803151968295;20046.09792559338;20055.09752061161;6614.735410583619;6990.370866622028;7121.08230887247;7154.35610795031;7277.19950805411;3584.2473080653353;3687.797171155612;3688.704903607705;3712.294664013829;3761.191343861083;2785.5543113101808;2874.1664917173784;2893.363460038788;2920.3721199942115;2926.7512261457587;520.7867457785472;524.5619907377383;525.9526642602184;534.7433232048561;536.3081624704088;595.5116804220497;596.0939372154302;609.6283362434523;611.1535523300172;619.6653806944199;8328.750137495885;8676.1323867614;8734.0829212933;8786.265837019242;8872.8669069964;552.8756029893242;566.3713278261126;592.1413949772847;612.7732738886551;630.6878095342835;3900.414937759302;3914.4715463412645;4058.9594104059174;4215.641670457984;4280.6789490788315;83030;86732.56633716791;87911;88605.55697221472;93950;45823;46167.76916115398;53133.734331328094;78197.60901195572;82398;68896.6555167231;69106;69152;69680.65159674169;70386.9441958371;7840.255175758294;8242.29940455068;8886.955565222133;9004.279657627243;9095.772605684911;30656.693433066277;37205.255894882495;38017.23965520619;39415.21169576535;44019.33970990502;37239;39219.215615688096;48237;58712;59071.40928590659;10536.894631053898;10688.358698478116;10694.73263168427;10702;10778.622748203776;12392.81410778821;12796.232226066466;12946.223226606433;13174.814266715659;13568.253746044062;11163.553457861595;12198.390080496118;12636.494540218288;12836.16564923277;13155.408006639533;11864.466099025738;11952.34262115592;12427.254364738144;12437.564685235973;12460.87539124597;12088.15382923187;12106.394680265776;12168.148229623841;12808;12905.096643234883;9774.533819927068;10053.447060411747;10098.506229436342;10162.796744065225;10449.164066874784;10170.389776613427;10930.234883558074;11058.115350771757;11064.391458469861;11067.83398249043 08:59:44 INFO - PROCESS | 3409 | __end_tp_report 08:59:44 INFO - PROCESS | 3409 | __start_cc_report 08:59:44 INFO - PROCESS | 3409 | _x_x_mozilla_cycle_collect,1000 08:59:44 INFO - PROCESS | 3409 | __end_cc_report 08:59:44 INFO - PROCESS | 3409 | __startTimestamp1469894384930__endTimestamp 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | ------- Summary: start ------- 08:59:44 INFO - PROCESS | 3409 | Number of tests: 6 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | [#0] dojo.html Cycles:165 Average:4757.35 Median:4881.68 stddev:503.71 (10.3%) stddev-sans-first:476.77 08:59:44 INFO - PROCESS | 3409 | Values: 2628.8 2640.2 2653.5 2686.4 2691.7 4642.7 4740.7 4753.3 4875.8 4908.7 4754.0 4792.7 4811.9 4865.4 4889.2 4322.7 4331.5 4386.4 4445.9 4563.1 4473.8 4497.9 4512.6 4517.7 4524.9 4315.8 4360.8 4365.2 4369.1 4453.1 4367.1 4417.2 4479.7 4483.2 4486.4 4371.5 4455.4 4456.1 4486.4 4501.1 4815.4 4861.5 4912.3 4914.0 4917.5 4981.6 5072.5 5105.2 5126.6 5213.1 5159.3 5213.5 5214.4 5221.2 5223.2 4627.8 4864.0 4871.5 4872.4 4881.7 5239.6 5334.2 5344.7 5410.5 5429.0 5131.5 5141.8 5149.9 5199.9 5202.0 5010.7 5214.6 5262.8 5263.7 5269.1 5029.9 5076.8 5076.9 5157.7 5164.2 5090.2 5092.1 5098.5 5098.7 5155.6 4389.3 4400.2 4403.2 4404.5 4461.1 3761.6 3776.5 3827.5 3852.5 3905.7 4436.5 4438.2 4439.6 4484.2 4491.4 5172.8 5211.9 5220.6 5221.6 5263.6 4195.8 4346.7 4378.5 4390.4 4436.2 4622.7 4626.3 4637.9 4670.8 4688.6 4813.2 4821.1 4821.3 4821.7 4846.6 4933.0 5070.7 5071.5 5101.7 5138.6 4775.1 4825.5 4834.1 4835.9 4882.2 5026.6 5054.4 5058.5 5059.2 5068.6 4950.0 5091.4 5105.7 5110.2 5180.0 5015.8 5035.3 5037.2 5044.0 5057.5 4985.0 4987.9 4990.1 5024.6 5030.7 4784.0 4808.7 4847.5 4868.5 4992.8 5003.2 5005.0 5008.0 5010.5 5016.0 4901.2 4901.8 4905.6 4911.4 4944.6 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | [#1] ext.html Cycles:180 Average:38476.89 Median:17812.82 stddev:60289.18 (338.5%) stddev-sans-first:60391.08 08:59:44 INFO - PROCESS | 3409 | Values: 558.4 566.0 574.3 581.1 596.6 26780.6 39522.6 40117.6 40171.8 44874.3 41706.2 42140.4 42227.4 42229.8 42280.6 7770.4 7911.6 7914.6 7914.9 7919.2 7364.1 9885.8 10080.4 10104.8 10455.8 10210.7 10240.0 10298.2 10314.5 10337.6 10111.1 10152.0 10174.7 10175.5 10177.6 9963.8 9978.8 9982.5 9984.3 9991.7 38655.2 38920.0 38924.8 38957.6 38970.0 2975.2 3074.5 3178.5 3234.6 3323.3 29607.1 29828.4 30139.5 30256.0 31579.4 3261.5 3313.3 3316.4 3387.6 3494.8 198152.0 199172.0 199644.0 201089.0 201312.0 31559.2 54460.0 54473.7 54774.0 54825.0 32391.0 34303.0 34330.1 34346.8 34372.5 13647.4 13786.9 13790.0 13801.7 13808.2 10066.9 11059.1 11203.6 11274.5 11276.5 7884.2 7898.7 8030.2 8034.6 8044.4 3114.5 3148.2 3175.8 3177.3 3226.0 828.3 867.7 896.8 1024.2 1039.5 26224.2 28319.0 28458.6 28635.0 28962.1 1036.5 1043.5 1047.3 1052.6 1092.2 14195.6 15053.4 15112.7 15198.6 15327.8 127423.0 127475.0 128725.0 128748.0 129026.4 50626.7 51169.2 51200.2 51253.7 51309.5 1102.1 1175.7 1190.5 1196.7 1217.6 29078.9 29931.4 30537.7 30629.5 30750.8 43943.3 44605.8 44622.1 44662.8 44662.8 316561.0 318370.0 318817.0 319671.0 320311.0 25614.4 26678.0 26768.9 27687.3 27759.6 42633.6 43116.8 43273.0 43297.6 43905.6 36079.0 36673.3 37207.8 37307.8 37491.6 36056.5 36298.1 36655.3 36751.4 37099.3 36068.1 36120.1 36328.0 36350.8 36575.6 32745.3 35492.8 36484.8 36504.4 37062.4 26001.7 26117.5 26139.7 26163.2 26527.9 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | [#2] jquery.html Cycles:180 Average:24024.96 Median:5093.53 stddev:56136.54 (1102.1%) stddev-sans-first:56265.85 08:59:44 INFO - PROCESS | 3409 | Values: 342.1 363.9 365.1 368.5 389.5 13318.9 14527.4 16682.3 16897.8 17362.4 16219.8 17153.6 17307.7 17349.6 17391.2 4845.0 5080.0 5092.6 5094.4 5097.6 3792.8 5009.3 5046.9 5847.6 6164.0 6147.5 6205.3 6218.1 6222.0 6224.3 5819.3 5905.0 5914.7 5915.2 5959.3 5044.9 5195.1 5196.1 5197.9 5199.1 20798.5 21020.7 21072.5 21159.9 21191.4 2027.7 2091.5 2207.0 2360.2 2480.2 9433.2 9436.0 12109.9 12502.9 12638.8 1756.6 1790.6 1791.2 1816.4 1821.0 67019.7 74125.6 84362.0 84825.6 86238.0 15824.6 16424.1 16617.8 16634.6 16968.3 29735.6 29737.7 29796.6 29814.6 29866.6 9233.1 9379.1 9433.8 9570.7 9605.8 7445.6 7708.0 7712.7 7964.7 7993.4 8221.7 8318.0 8336.6 8412.9 8547.8 3358.6 3358.8 3437.3 3447.0 3490.4 716.9 728.6 775.9 785.9 881.3 16770.4 17014.6 17501.9 17749.7 18176.6 845.5 851.1 881.2 882.6 888.8 9263.9 9719.4 9798.4 9818.4 9901.4 286808.0 291418.0 292647.0 393270.0 395822.0 77609.0 78348.6 79961.0 80239.2 81068.0 873.7 884.0 912.5 917.7 923.7 15826.7 15947.9 16219.8 16672.1 16912.0 36052.0 36605.0 36690.3 37232.6 38009.8 51618.5 51744.7 52015.7 53330.0 54158.2 7463.4 7504.5 7603.5 7624.4 7682.4 8812.5 11088.1 11121.2 11259.0 11964.3 9740.1 9897.9 10146.3 10436.3 10493.7 9932.7 10333.7 10448.4 10598.2 10706.2 9920.4 10161.5 10176.4 10295.5 10308.9 7459.7 7494.2 7646.1 7650.3 7651.8 8894.0 9655.7 9752.7 9814.1 10117.7 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | [#3] mootools.html Cycles:180 Average:4979.79 Median:5176.57 stddev:2745.41 (53.0%) stddev-sans-first:2739.33 08:59:44 INFO - PROCESS | 3409 | Values: 1319.1 1361.5 1389.2 1645.8 1659.5 7165.5 7646.3 7647.8 7649.9 7651.6 6305.3 7061.5 7208.2 7274.0 7543.1 2145.7 2179.2 2180.6 2182.2 2183.6 2155.6 2179.6 2209.5 2211.8 2213.8 2151.3 2166.9 2170.8 2171.4 2186.4 2094.6 2098.3 2099.6 2100.9 2102.0 2070.6 2115.4 2117.3 2119.1 2119.6 7406.7 7460.9 7474.4 7509.2 7571.1 4388.9 4526.0 4528.9 4529.2 4532.3 2739.0 2830.8 2893.4 2895.9 2900.5 816.7 832.3 872.6 880.0 890.3 10028.5 10142.0 10162.0 10164.7 10209.7 3989.7 4080.5 4232.6 4243.3 4293.8 8755.6 8756.4 8756.9 8759.3 8801.0 4642.8 4645.5 4647.6 4650.2 4652.7 3642.4 3947.5 4109.8 4261.8 4263.3 3555.5 3573.8 3688.2 3693.6 3713.1 1142.5 1157.5 1167.8 1175.5 1186.3 840.7 852.5 862.6 871.4 875.4 5164.4 5253.6 5373.5 5405.0 5463.7 406.1 408.7 414.3 414.6 424.4 3479.8 3602.9 3606.1 3606.9 3815.0 8916.3 9094.9 9147.1 9156.5 9157.2 9074.1 9079.4 9122.0 9125.7 9134.5 6603.0 6865.0 6870.4 6991.3 7020.4 5188.8 5320.0 5337.9 5383.8 5559.5 8345.2 8374.4 8590.4 8648.5 8718.5 8601.0 8749.4 8773.7 8807.5 8810.7 6413.3 6547.4 6612.0 6700.4 6853.3 7350.9 7364.1 7397.8 7398.1 7400.3 6363.6 6486.9 6515.1 6639.9 6698.0 6170.3 6225.3 6279.9 6358.4 6425.8 6194.0 6292.2 6293.6 6294.2 6296.5 4356.8 4375.6 4418.6 4485.5 4603.7 4611.9 4630.5 4649.0 4657.0 4666.6 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | [#4] prototype.html Cycles:180 Average:4303.81 Median:4985.51 stddev:1244.02 (25.0%) stddev-sans-first:1210.42 08:59:44 INFO - PROCESS | 3409 | Values: 286.4 291.8 292.4 295.9 297.1 5034.3 5053.2 5063.7 5081.2 5087.5 4916.4 4994.3 4994.8 4995.6 5000.8 3705.3 3808.3 3855.5 3865.9 3888.5 3898.1 3916.6 3917.0 3950.9 3960.4 3871.3 3878.1 3881.7 3882.7 3916.4 3656.3 3692.4 3870.9 3890.8 3897.3 3423.8 3429.2 3437.8 3462.3 3471.1 4808.7 4809.4 4813.6 4820.3 4820.6 4227.0 4438.7 4439.4 4450.3 4450.4 5158.7 5163.1 5167.4 5180.3 5184.8 3771.5 3774.2 3777.1 3781.6 3785.8 5322.6 5447.5 5480.5 5499.6 5512.2 3802.4 3828.2 3833.2 3833.7 3835.8 3888.7 3899.1 3910.9 3921.2 3922.8 4427.5 4432.8 4433.8 4458.3 4465.8 4958.9 5193.4 5197.0 5211.2 5240.0 1349.8 1361.6 1363.8 1365.4 1365.9 842.9 876.7 878.2 883.2 893.4 4148.5 4338.8 4415.0 4557.9 4563.3 5347.9 5352.2 5364.1 5374.3 5377.2 4524.4 4537.1 4558.4 4564.9 4577.3 2683.6 2803.6 2823.2 2838.0 2845.6 5010.2 5028.9 5034.7 5047.3 5052.6 5272.4 5474.2 5476.3 5478.2 5495.7 4992.8 4997.3 5022.5 5023.2 5034.4 5277.8 5342.6 5347.2 5349.9 5360.4 5033.7 5230.4 5239.1 5249.7 5269.0 5036.9 5043.1 5043.6 5054.7 5077.4 3655.3 3696.7 3697.0 3726.0 3733.9 5184.1 5239.0 5262.3 5318.3 5324.9 5081.3 5093.8 5095.9 5109.2 5112.1 5090.9 5107.5 5109.7 5166.4 5176.4 4835.9 4917.3 5031.0 5061.3 5066.9 4920.2 4978.3 5120.5 5125.2 5132.5 5069.9 5083.6 5083.9 5086.2 5126.3 08:59:44 INFO - PROCESS | 3409 | 08:59:44 INFO - PROCESS | 3409 | [#5] yui.html Cycles:180 Average:16135.59 Median:4137.30 stddev:21755.44 (525.8%) stddev-sans-first:21785.29 08:59:44 INFO - PROCESS | 3409 | Values: 622.4 624.5 639.5 639.7 646.4 11748.9 12775.7 12778.1 12882.3 12978.8 12591.4 12727.4 12793.3 12797.6 12805.1 643.5 766.2 771.3 772.0 777.7 764.0 785.8 787.6 796.3 796.9 822.7 822.8 824.5 825.0 825.3 671.9 817.0 819.3 820.1 820.5 572.9 590.5 591.0 591.3 591.6 11502.3 11683.4 12004.5 12145.7 12200.6 11867.9 12054.2 12180.1 12701.1 12833.7 11566.0 11578.9 11851.4 11896.1 12118.0 3902.2 3905.0 3934.5 3938.1 4010.3 57868.7 57920.0 58148.0 58336.0 58880.7 9830.8 9844.7 10022.9 10213.6 10232.7 18610.3 19379.3 19684.8 20046.1 20055.1 6614.7 6990.4 7121.1 7154.4 7277.2 3584.2 3687.8 3688.7 3712.3 3761.2 2785.6 2874.2 2893.4 2920.4 2926.8 520.8 524.6 526.0 534.7 536.3 595.5 596.1 609.6 611.2 619.7 8328.8 8676.1 8734.1 8786.3 8872.9 552.9 566.4 592.1 612.8 630.7 3900.4 3914.5 4059.0 4215.6 4280.7 83030.0 86732.6 87911.0 88605.6 93950.0 45823.0 46167.8 53133.7 78197.6 82398.0 68896.7 69106.0 69152.0 69680.7 70386.9 7840.3 8242.3 8887.0 9004.3 9095.8 30656.7 37205.3 38017.2 39415.2 44019.3 37239.0 39219.2 48237.0 58712.0 59071.4 10536.9 10688.4 10694.7 10702.0 10778.6 12392.8 12796.2 12946.2 13174.8 13568.3 11163.6 12198.4 12636.5 12836.2 13155.4 11864.5 11952.3 12427.3 12437.6 12460.9 12088.2 12106.4 12168.1 12808.0 12905.1 9774.5 10053.4 10098.5 10162.8 10449.2 10170.4 10930.2 11058.1 11064.4 11067.8 08:59:44 INFO - PROCESS | 3409 | -------- Summary: end -------- 08:59:44 INFO - PROCESS | 3409 | 08:59:45 INFO - TEST-INFO | 3409: exit 0 08:59:45 INFO - TEST-OK | dromaeo_css | took 1121307ms 08:59:45 INFO - TEST-START | kraken 08:59:45 INFO - operating with platform_type : linux_ 08:59:45 INFO - Initialising browser for kraken test... 08:59:45 INFO - TEST-INFO | started process 3593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjIloOg/profile http://localhost:38122/getInfo.html) 08:59:50 INFO - PROCESS | 3593 | __metrics Screen width/height:1600/1200 08:59:50 INFO - PROCESS | 3593 | colorDepth:24 08:59:50 INFO - PROCESS | 3593 | Browser inner width/height: 1024/697 08:59:50 INFO - PROCESS | 3593 | __metrics 08:59:50 INFO - PROCESS | 3593 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:59:50 INFO - PROCESS | 3593 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:51 INFO - PROCESS | 3593 | console.error: PushService: 08:59:51 INFO - PROCESS | 3593 | stateChangeProcessEnqueue: Error transitioning state 08:59:51 INFO - PROCESS | 3593 | UnknownError 08:59:51 INFO - TEST-INFO | 3593: exit 0 08:59:51 INFO - Browser initialized. 08:59:51 INFO - Running cycle 1/1 for kraken test... 08:59:51 INFO - TEST-INFO | started process 3673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjIloOg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:03 INFO - PROCESS | 3673 | RSS: Main: 156995584 09:00:03 INFO - PROCESS | 3673 | 09:00:06 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38122/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:07 INFO - PROCESS | 3673 | RSS: Main: 213655552 09:00:07 INFO - PROCESS | 3673 | 09:00:10 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38122/tests/kraken/driver.html?testName=audio-dft) 09:00:10 INFO - PROCESS | 3673 | RSS: Main: 192454656 09:00:10 INFO - PROCESS | 3673 | 09:00:14 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38122/tests/kraken/driver.html?testName=audio-fft) 09:00:14 INFO - PROCESS | 3673 | RSS: Main: 271323136 09:00:14 INFO - PROCESS | 3673 | 09:00:16 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38122/tests/kraken/driver.html?testName=audio-oscillator) 09:00:17 INFO - PROCESS | 3673 | RSS: Main: 180314112 09:00:17 INFO - PROCESS | 3673 | 09:00:19 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:20 INFO - PROCESS | 3673 | RSS: Main: 185491456 09:00:20 INFO - PROCESS | 3673 | 09:00:23 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38122/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:24 INFO - PROCESS | 3673 | RSS: Main: 221036544 09:00:24 INFO - PROCESS | 3673 | 09:00:27 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38122/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:28 INFO - PROCESS | 3673 | RSS: Main: 220286976 09:00:28 INFO - PROCESS | 3673 | 09:00:30 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38122/tests/kraken/driver.html?testName=json-parse-financial) 09:00:31 INFO - PROCESS | 3673 | RSS: Main: 219820032 09:00:31 INFO - PROCESS | 3673 | 09:00:33 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:33 INFO - PROCESS | 3673 | RSS: Main: 184516608 09:00:33 INFO - PROCESS | 3673 | 09:00:35 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:36 INFO - PROCESS | 3673 | RSS: Main: 190611456 09:00:36 INFO - PROCESS | 3673 | 09:00:38 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:39 INFO - PROCESS | 3673 | RSS: Main: 195092480 09:00:39 INFO - PROCESS | 3673 | 09:00:41 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:42 INFO - PROCESS | 3673 | RSS: Main: 191057920 09:00:42 INFO - PROCESS | 3673 | 09:00:45 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:46 INFO - PROCESS | 3673 | RSS: Main: 193806336 09:00:46 INFO - PROCESS | 3673 | 09:00:47 INFO - PROCESS | 3673 | Cycle 1(1): loaded http://localhost:38122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38122/tests/kraken/driver.html?testName=ai-astar) 09:00:48 INFO - PROCESS | 3673 | RSS: Main: 244973568 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | __start_tp_report 09:00:48 INFO - PROCESS | 3673 | _x_x_mozilla_page_load 09:00:48 INFO - PROCESS | 3673 | _x_x_mozilla_page_load_details 09:00:48 INFO - PROCESS | 3673 | |i|pagename|runs| 09:00:48 INFO - PROCESS | 3673 | |0;ai-astar;105;115;116;115;114;113;113;114;113;115 09:00:48 INFO - PROCESS | 3673 | |1;audio-beat-detection;147;121;123;174;124;126;146;122;192;122 09:00:48 INFO - PROCESS | 3673 | |2;audio-dft;161;161;161;161;160;161;160;161;160;164 09:00:48 INFO - PROCESS | 3673 | |3;audio-fft;75;75;76;130;75;76;74;75;102;76 09:00:48 INFO - PROCESS | 3673 | |4;audio-oscillator;86;86;120;84;86;85;124;86;85;121 09:00:48 INFO - PROCESS | 3673 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;116;117 09:00:48 INFO - PROCESS | 3673 | |6;imaging-darkroom;149;146;147;147;147;147;147;147;148;146 09:00:48 INFO - PROCESS | 3673 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 09:00:48 INFO - PROCESS | 3673 | |8;json-parse-financial;63;64;62;63;64;64;63;64;63;62 09:00:48 INFO - PROCESS | 3673 | |9;json-stringify-tinderbox;67;67;66;66;66;65;66;67;66;67 09:00:48 INFO - PROCESS | 3673 | |10;stanford-crypto-aes;79;84;78;84;78;89;81;79;89;82 09:00:48 INFO - PROCESS | 3673 | |11;stanford-crypto-ccm;142;137;128;132;127;126;126;128;164;133 09:00:48 INFO - PROCESS | 3673 | |12;stanford-crypto-pbkdf2;168;165;163;163;168;162;163;167;166;162 09:00:48 INFO - PROCESS | 3673 | |13;stanford-crypto-sha256-iterative;71;67;67;67;67;68;67;71;66;66 09:00:48 INFO - PROCESS | 3673 | __end_tp_report 09:00:48 INFO - PROCESS | 3673 | __start_cc_report 09:00:48 INFO - PROCESS | 3673 | _x_x_mozilla_cycle_collect,1930 09:00:48 INFO - PROCESS | 3673 | __end_cc_report 09:00:48 INFO - PROCESS | 3673 | __startTimestamp1469894448092__endTimestamp 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | ------- Summary: start ------- 09:00:48 INFO - PROCESS | 3673 | Number of tests: 14 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:3.09 (2.7%) stddev-sans-first:1.09 09:00:48 INFO - PROCESS | 3673 | Values: 105.0 115.0 116.0 115.0 114.0 113.0 113.0 114.0 113.0 115.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:136.00 stddev:25.15 (18.5%) stddev-sans-first:26.54 09:00:48 INFO - PROCESS | 3673 | Values: 147.0 121.0 123.0 174.0 124.0 126.0 146.0 122.0 192.0 122.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 09:00:48 INFO - PROCESS | 3673 | Values: 161.0 161.0 161.0 161.0 160.0 161.0 160.0 161.0 160.0 164.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:18.42 (24.6%) stddev-sans-first:19.28 09:00:48 INFO - PROCESS | 3673 | Values: 75.0 75.0 76.0 130.0 75.0 76.0 74.0 75.0 102.0 76.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.50 stddev:17.54 (20.5%) stddev-sans-first:18.21 09:00:48 INFO - PROCESS | 3673 | Values: 86.0 86.0 120.0 84.0 86.0 85.0 124.0 86.0 85.0 121.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:00:48 INFO - PROCESS | 3673 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 09:00:48 INFO - PROCESS | 3673 | Values: 149.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:00:48 INFO - PROCESS | 3673 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 09:00:48 INFO - PROCESS | 3673 | Values: 63.0 64.0 62.0 63.0 64.0 64.0 63.0 64.0 63.0 62.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 09:00:48 INFO - PROCESS | 3673 | Values: 67.0 67.0 66.0 66.0 66.0 65.0 66.0 67.0 66.0 67.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:4.16 (5.0%) stddev-sans-first:4.24 09:00:48 INFO - PROCESS | 3673 | Values: 79.0 84.0 78.0 84.0 78.0 89.0 81.0 79.0 89.0 82.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:132.50 stddev:11.67 (8.8%) stddev-sans-first:12.04 09:00:48 INFO - PROCESS | 3673 | Values: 142.0 137.0 128.0 132.0 127.0 126.0 126.0 128.0 164.0 133.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:2.41 (1.5%) stddev-sans-first:2.24 09:00:48 INFO - PROCESS | 3673 | Values: 168.0 165.0 163.0 163.0 168.0 162.0 163.0 167.0 166.0 162.0 09:00:48 INFO - PROCESS | 3673 | 09:00:48 INFO - PROCESS | 3673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.50 09:00:48 INFO - PROCESS | 3673 | Values: 71.0 67.0 67.0 67.0 67.0 68.0 67.0 71.0 66.0 66.0 09:00:48 INFO - PROCESS | 3673 | -------- Summary: end -------- 09:00:48 INFO - PROCESS | 3673 | 09:00:49 INFO - TEST-INFO | 3673: exit 0 09:00:49 INFO - TEST-OK | kraken | took 63361ms 09:00:49 INFO - SUITE-END | took 1184s 09:00:49 INFO - Completed test suite (00:19:44) 09:00:49 INFO - javascript benchmark 09:00:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.7765539929105, 2640.207937618714, 2653.4958357911983, 2686.3552747340646, 2691.703912569617, 4642.744649044301, 4740.691855029425, 4753.33453316536, 4875.8049678012885, 4908.656394052417, 4753.952460475402, 4792.664513484057, 4811.8797030074265, 4865.391826021747, 4889.217725163974, 4322.697411181219, 4331.501877284106, 4386.38590597315, 4445.888852778674, 4563.087382523492, 4473.776311184428, 4497.9325310120375, 4512.571305725951, 4517.683762136652, 4524.932126018096, 4315.784210789448, 4360.7819609019425, 4365.236083685342, 4369.104333611602, 4453.109378124388, 4367.10474352757, 4417.160739459492, 4479.686421950465, 4483.193025255453, 4486.394336764528, 4371.540988196225, 4455.4207952966235, 4456.086502267028, 4486.394336764528, 4501.122281155176, 4815.374001379833, 4861.538153875376, 4912.336834527365, 4913.950860491385, 4917.483664215241, 4981.551660350586, 5072.5434710875825, 5105.183170692671, 5126.589872810204, 5213.061648903196, 5159.303494028296, 5213.478652134756, 5214.400343960455, 5221.242919776611, 5223.2165175223645, 4627.814887404534, 4864.027194561067, 4871.537203965618, 4872.439669437989, 4881.682690625169, 5239.554637855748, 5334.199870019528, 5344.706041167773, 5410.486003829708, 5429.022775900376, 5131.4868513148385, 5141.794328226903, 5149.922751158736, 5199.870003249874, 5202.03762303975, 5010.69935803853, 5214.556762675215, 5262.842114736487, 5263.736813159327, 5269.051570717231, 5029.924551131736, 5076.847694569169, 5076.923846142311, 5157.690538567698, 5164.1995490699, 5090.185570308733, 5092.057969275622, 5098.515641014098, 5098.668586541863, 5155.6391052626705, 4389.29771236607, 4400.185965596375, 4403.229434848889, 4404.515503294635, 4461.08547747711, 3761.586225515191, 3776.4524143998965, 3827.483289755847, 3852.5376954765047, 3905.6680182184264, 4436.489803672554, 4438.223310920576, 4439.64482841372, 4484.192845287879, 4491.416115904912, 5172.844814655567, 5211.947880521222, 5220.582353411718, 5221.6344855859725, 5263.578913686896, 4195.832166713297, 4346.673999450054, 4378.5183629800695, 4390.385346051556, 4436.223660859337, 4622.722636641813, 4626.32918226862, 4637.884052898705, 4670.836520721827, 4688.601468875184, 4813.229883218668, 4821.083994041121, 4821.252705830602, 4821.734804585712, 4846.636502262274, 4932.975335123445, 5070.746462676925, 5071.518205770446, 5101.7194054327365, 5138.563222126011, 4775.06886157196, 4825.5174482551465, 4834.081524510332, 4835.879103022453, 4882.218844984785, 5026.59787217029, 5054.444011158696, 5058.54473097423, 5059.215821547666, 5068.619853511075, 4949.950500494949, 5091.363579552556, 5105.744712764421, 5110.233464980134, 5180.041692286939, 5015.824446144367, 5035.320231768665, 5037.219231019198, 5043.9747801260755, 5057.4942505750605, 4984.950150498448, 4987.8753031173055, 4990.076835785391, 5024.6231532634465, 5030.748462576783, 4784.0, 4808.687435316693, 4847.491013443538, 4868.537488938545, 4992.750362481934, 5003.249512573143, 5005.024020316004, 5008.048470790538, 5010.473900240422, 5016.0, 4901.215805471107, 4901.754912254301, 4905.607551395951, 4911.435184953633, 4944.629152813482], "value": 4724.7974604679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.3690429814309, 565.9603827732059, 574.2706762411738, 581.1109003225065, 596.5734499832619, 26780.59829102565, 39522.60477395229, 40117.59882401175, 40171.79914100425, 44874.32688509667, 41706.16587668245, 42140.367894481606, 42227.36658950111, 42229.7888510557, 42280.57719422805, 7770.378369730408, 7911.604419779017, 7914.6438410271385, 7914.881276780824, 7919.247671471201, 7364.116306043283, 9885.802283954317, 10080.39517628941, 10104.797904041914, 10455.790884182312, 10210.744731381701, 10240.003199376088, 10298.17614590831, 10314.535845886916, 10337.586496540129, 10111.090001899827, 10152.03555662211, 10174.745631359237, 10175.491225438698, 10177.643782467578, 9963.80072398548, 9978.750531236705, 9982.450965196911, 9984.301098923079, 9991.700248992542, 38655.22689546221, 38920.0, 38924.80537597294, 38957.61042389568, 38970.0, 2975.181824998121, 3074.4773388524004, 3178.4914413693928, 3234.644189139193, 3323.302106557626, 29607.111786646434, 29828.40343193124, 30139.547906781416, 30256.0, 31579.368412631848, 3261.4944683574086, 3313.2710803623163, 3316.4196265653413, 3387.6442973487674, 3494.825258737053, 198151.99999999854, 199172.0, 199644.0, 201088.99999999854, 201311.99344003331, 31559.21101972469, 54460.0, 54473.72763136238, 54774.0, 54825.0, 32391.0, 34303.0, 34330.14174645654, 34346.82826585851, 34372.48441273383, 13647.362316522082, 13786.862131378759, 13790.0, 13801.723965520634, 13808.17150970945, 10066.899331006744, 11059.115270778319, 11203.60787372438, 11274.549018039186, 11276.54893804255, 7884.17216192303, 7898.723544676023, 8030.156833532395, 8034.638441270157, 8044.356451483867, 3114.5016797312323, 3148.165736079941, 3175.8253296068474, 3177.253345463814, 3226.0, 828.3166387730147, 867.6919693508839, 896.7668406214431, 1024.1908891975256, 1039.4906495816995, 26224.21327360182, 28318.9642254171, 28458.573121403195, 28635.0, 28962.131136065953, 1036.5076588620345, 1043.4626167523732, 1047.2930771729052, 1052.563186277686, 1092.229977865603, 14195.574132776033, 15053.397864085315, 15112.697746045018, 15198.620034499227, 15327.770083448757, 127423.0, 127475.0, 128725.0, 128748.0, 129026.35486822505, 50626.74686626617, 51169.23246151311, 51200.23199652008, 51253.7437312811, 51309.48690513122, 1102.1293178389144, 1175.7237049293237, 1190.5297407524154, 1196.7367179220732, 1217.5981925964588, 29078.854605726836, 29931.401371972002, 30537.694623053485, 30629.54055689211, 30750.84624576863, 43943.34084988664, 44605.77697111494, 44622.10755784931, 44662.77668611636, 44662.776686117664, 316561.0, 318370.0, 318817.0, 319671.0, 320311.0, 25614.359641009123, 26678.0, 26768.866155669097, 27687.30781730473, 27759.58360624552, 42633.57366426296, 43116.78441607772, 43273.0, 43297.567024330616, 43905.56094439015, 36079.0, 36673.26653466969, 37207.81396093002, 37307.81346093252, 37491.62508374881, 36056.4591531122, 36298.092547686516, 36655.25085618642, 36751.448728268566, 37099.25801483901, 36068.07616442071, 36120.096997575274, 36328.0, 36350.8182459086, 36575.63424365722, 32745.34509309848, 35492.82253588819, 36484.81757591195, 36504.43581785678, 37062.44406333961, 26001.699915004552, 26117.477650447265, 26139.738602613732, 26163.215103546925, 26527.867360663073], "value": 16613.16866481643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.0798053236791, 363.9144800971772, 365.0745360511105, 368.5466875742837, 389.54228781182104, 13318.866811331884, 14527.418903243872, 16682.332706691748, 16897.83102168978, 17362.39231626893, 16219.83780162198, 17153.57116072099, 17307.653846923055, 17349.566260843487, 17391.217395217212, 4845.0, 5080.034793389263, 5092.643514953955, 5094.414142373619, 5097.5667068299235, 3792.829322680472, 5009.298698182258, 5046.889684269455, 5847.649141051551, 6163.969180154093, 6147.477464415508, 6205.255369355684, 6218.098375735515, 6221.9688901555655, 6224.346443623423, 5819.301683797929, 5904.97047514764, 5914.733836977303, 5915.231019967419, 5959.3146788119275, 5044.873878153039, 5195.064888320101, 5196.142636464979, 5197.870053248661, 5199.090159222121, 20798.48003799902, 21020.684689729667, 21072.473188170265, 21159.894200529052, 21191.364259072252, 2027.6755719084877, 2091.5294058836794, 2206.984786997983, 2360.173939121311, 2480.1691433369842, 9433.151016408556, 9435.952820235923, 12109.93945030278, 12502.937485312606, 12638.810417843648, 1756.5696404381008, 1790.588164722108, 1791.2029147029577, 1816.4459839748872, 1821.034851528692, 67019.66490167567, 74125.62937185279, 84362.0, 84825.57587212085, 86238.0, 15824.60438489047, 16424.125777988804, 16617.83382166163, 16634.58413539647, 16968.321267149422, 29735.553966690517, 29737.702622973928, 29796.55305170381, 29814.55278170829, 29866.552001719992, 9233.122853328923, 9379.124175164858, 9433.811323773623, 9570.665026724171, 9605.759856003655, 7445.553266804009, 7708.0, 7712.730054448068, 7964.681412743541, 7993.400494962901, 8221.671133154727, 8317.95841020791, 8336.583170841433, 8412.873806892901, 8547.829043419097, 3358.6473420290517, 3358.8302245018995, 3437.3125374925116, 3447.0, 3490.441529355291, 716.9301286948318, 728.6320408193828, 775.9185285544936, 785.9056913170456, 881.2905610983092, 16770.413035543697, 17014.574635633962, 17501.91249043772, 17749.7337539937, 18176.636467270582, 845.526505157114, 851.0808327006818, 881.1893058386172, 882.642529775442, 888.7555922121468, 9263.90736092644, 9719.368241064309, 9798.412095274307, 9818.410895346302, 9901.40591564494, 286808.0, 291418.0, 292647.0, 393270.0, 395822.0, 77609.0, 78348.60825695835, 79961.0, 80239.19760802317, 81068.0, 873.7204094689638, 883.9911600884166, 912.4844462878452, 917.655879045358, 923.6536298887917, 15826.68346633084, 15947.920260398623, 16219.837801621832, 16672.083035433167, 16912.0, 36052.0, 36605.0, 36690.26619467649, 37232.627673724, 38009.809950951174, 51618.48381516287, 51744.741276293375, 52015.73992130015, 53330.0, 54158.18762718484, 7463.365613922877, 7504.512206706547, 7603.505772124794, 7624.351930086005, 7682.385409167365, 8812.515311657664, 11088.057515110982, 11121.16591255643, 11259.03879189815, 11964.282143071443, 9740.123388895034, 9897.851532226878, 10146.289759716748, 10436.321639093434, 10493.737656558647, 9932.652357167754, 10333.741656458347, 10448.42533660656, 10598.20513461478, 10706.197035222234, 9920.355176913477, 10161.475778633265, 10176.440295783506, 10295.485225738534, 10308.948455257676, 7459.664315105725, 7494.213107623621, 7646.082470103401, 7650.349720273839, 7651.846963060819, 8894.0, 9655.710328690151, 9752.658656947257, 9814.06766357195, 10117.696469105938], "value": 8983.271207939293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.089828018667, 1361.4826365980928, 1389.2081513537282, 1645.8107317658473, 1659.493854374416, 7165.462590305729, 7646.273604007617, 7647.847043059135, 7649.92350076499, 7651.579163146025, 6305.337939516354, 7061.470389720778, 7208.207097219301, 7274.0, 7543.094828620573, 2145.6674215496623, 2179.226374637005, 2180.6401943679275, 2182.19258874216, 2183.5632873425297, 2155.644318687415, 2179.5640871825617, 2209.4586826227596, 2211.7788221177834, 2213.756486786452, 2151.333086743107, 2166.9133234670594, 2170.8046275835172, 2171.4245724882917, 2186.3987403464093, 2094.6334391481505, 2098.328534868843, 2099.611571859211, 2100.949525237389, 2102.02255950982, 2070.6272870883236, 2115.397111823123, 2117.2589593642256, 2119.0676102515, 2119.5548934723724, 7406.703731850719, 7460.888086678704, 7474.439417043689, 7509.173990861001, 7571.129320128201, 4388.934165987513, 4526.0, 4528.8867778305475, 4529.1621050105505, 4532.274836026253, 2738.972610273892, 2830.844303563303, 2893.363460038788, 2895.869685864141, 2900.4779139755046, 816.6610856494548, 832.2551316571695, 872.6291326186409, 880.0495464897895, 890.2788741119714, 10028.548715307828, 10142.0, 10162.0, 10164.745881352952, 10209.744756381077, 3989.740666856645, 4080.5307389649975, 4232.619064284229, 4243.342281946303, 4293.763842988666, 8755.605997730117, 8756.4308319959, 8756.8686469703, 8759.34304927133, 8800.955995219983, 4642.767861606906, 4645.512221216791, 4647.604953578916, 4650.18621741194, 4652.744099074584, 3642.399004164336, 3947.4670919426085, 4109.815058322382, 4261.786910654455, 4263.253930562139, 3555.520004799319, 3573.8213089345427, 3688.243909998444, 3693.6121707220354, 3713.1274150574595, 1142.497301187475, 1157.4964890272759, 1167.772284404533, 1175.5474142455216, 1186.2704436771323, 840.7393707950555, 852.5311078906576, 862.6290695001085, 871.4117970369975, 875.4484674654926, 5164.354455693038, 5253.632245742838, 5373.462653734595, 5405.0, 5463.69949652765, 406.1349325935738, 408.74044981437004, 414.3246508191689, 414.55435406937664, 424.39947474323486, 3479.7738147020364, 3602.9099272518397, 3606.062423769839, 3606.8737594184076, 3815.04623844039, 8916.286697064219, 9094.86357704635, 9147.0852914708, 9156.542172891463, 9157.221636160868, 9074.092590740873, 9079.409838360485, 9122.0, 9125.680601178927, 9134.543272836465, 6603.0, 6865.0, 6870.416014638712, 6991.265917078634, 7020.438364930896, 5188.792448302026, 5320.0, 5337.919931201112, 5383.7846486140115, 5559.499645031967, 8345.165483451607, 8374.413791034813, 8590.398672092893, 8648.524331161594, 8718.476891386537, 8600.956995214983, 8749.387542871938, 8773.736787896374, 8807.471551706662, 8810.735677929672, 6413.262474815456, 6547.377999090078, 6611.966940165268, 6700.43046341047, 6853.280405557344, 7350.889736654061, 7364.116306043309, 7397.8150546236775, 7398.149212840593, 7400.259974002557, 6363.61818290904, 6486.870262594816, 6515.087887695821, 6639.900401494078, 6697.9953007049335, 6170.290416602148, 6225.346338634559, 6279.905801413074, 6358.364163583789, 6425.807225783234, 6194.039923811816, 6292.150559674568, 6293.55945083858, 6294.213223347082, 6296.496280297473, 4356.825726970886, 4375.584319489643, 4418.6023257906945, 4485.46174459054, 4603.746793926366, 4611.907761844812, 4630.490646029001, 4649.0469453761225, 4657.045305712253, 4666.580007799314], "value": 3970.375338080357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.43572162839206, 291.82636331382827, 292.3772364862843, 295.8624239728526, 297.07461258180757, 5034.29519867218, 5053.166227572451, 5063.721495317756, 5081.187010078388, 5087.516685914837, 4916.385451818523, 4994.301937341313, 4994.775235114419, 4995.600351971842, 5000.849974500771, 3705.277470893177, 3808.2954653389074, 3855.4602355670227, 3865.8646947356847, 3888.494495715567, 3898.1229223424784, 3916.647501724844, 3916.981584787947, 3950.940735888964, 3960.4059391091423, 3871.264459752652, 3878.1080351519167, 3881.709791223178, 3882.7282090253693, 3916.3929590913453, 3656.3053019926397, 3692.353838078339, 3870.858096861433, 3890.824912878927, 3897.2984862724697, 3423.828808559587, 3429.159855835311, 3437.810920399377, 3462.307538492312, 3471.1322169457635, 4808.687435316729, 4809.374781278447, 4813.614910807162, 4820.276958456225, 4820.63845211607, 4226.957730422687, 4438.733675979452, 4439.378487011821, 4450.310201918675, 4450.3991961085485, 5158.716270605115, 5163.14808056674, 5167.354080739908, 5180.300659410969, 5184.792608295664, 3771.4531392948143, 3774.150816066363, 3777.0934975605933, 3781.640744129303, 3785.8296376663116, 5322.551626251929, 5447.4824891635235, 5480.479354461359, 5499.615026948115, 5512.228288039678, 3802.4106263529197, 3828.196078823423, 3833.15670552478, 3833.7124715646437, 3835.753380151462, 3888.727789054739, 3899.1421887184774, 3910.921781564353, 3921.2157568485845, 3922.8234729437245, 4427.512973572904, 4432.844850430284, 4433.756143412079, 4458.331250312479, 4465.821367145278, 4958.851234462972, 5193.428722840485, 5197.0, 5211.1922651989, 5239.952009598096, 1349.7840345544666, 1361.5907535700503, 1363.7886127650231, 1365.4060483689627, 1365.877071063609, 842.8946381702287, 876.6712482818942, 878.200837238123, 883.2315885179806, 893.3701740273092, 4148.481439820022, 4338.8047537860875, 4414.977925110418, 4557.908841823145, 4563.292689633112, 5347.919781203285, 5352.19717042439, 5364.088105022156, 5374.333956473506, 5377.166539186433, 4524.434445694288, 4537.137943790669, 4558.427342566809, 4564.885877853014, 4577.267637178035, 2683.5840444731098, 2803.5794630805135, 2823.1530540838075, 2838.0, 2845.5873898285045, 5010.1733214020005, 5028.924566131511, 5034.716147382394, 5047.318611987408, 5052.57053150479, 5272.420033796279, 5474.206240095164, 5476.302346272589, 5478.178273258964, 5495.725213739297, 4992.750362481934, 4997.25041243809, 5022.472640372781, 5023.246513023076, 5034.414159539807, 5277.762500687401, 5342.572594192377, 5347.1979203119845, 5349.893002139857, 5360.410354860885, 5033.697978121324, 5230.372355317386, 5239.109351410193, 5249.685018898878, 5268.972550352644, 5036.924446133237, 5043.067032598981, 5043.5712964398435, 5054.725373581977, 5077.441481436965, 3655.2506736119562, 3696.667299943018, 3696.981515092515, 3725.96274037267, 3733.8879833605033, 5184.1160283079735, 5239.0, 5262.289590905179, 5318.308619879391, 5324.920126198188, 5081.314022606901, 5093.847184584469, 5095.87260318495, 5109.156989096758, 5112.130937740668, 5090.898182036412, 5107.514786095315, 5109.6678715883345, 5166.354205724285, 5176.352955880515, 4835.903281934412, 4917.336159618549, 5031.0, 5061.330535361833, 5066.885285237242, 4920.188168952082, 4978.27814966835, 5120.539151476385, 5125.1799712045895, 5132.46109158533, 5069.946671598009, 5083.593312535062, 5083.923741143812, 5086.18621020635, 5126.333576635014], "value": 3904.5022148809653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.4149299658321, 624.5011971268957, 639.5363361562864, 639.7057353617337, 646.369789455281, 11748.883856033674, 12775.680607984805, 12778.10553261272, 12882.291473968928, 12978.805317920214, 12591.370431478412, 12727.42726577304, 12793.296368699717, 12797.616071517868, 12805.103642744989, 643.4530648948403, 766.2452484302971, 771.3327971304809, 771.9961400192991, 777.6772639354662, 763.9732609358673, 785.8467598818232, 787.5786454246951, 796.3151689546985, 796.9322607578363, 822.6585966823791, 822.7696245051395, 824.4888169335021, 824.9876251856227, 825.2655136928139, 671.9160104986877, 816.9714060007931, 819.2790344496864, 820.0897004325194, 820.5158956215831, 572.9427057294279, 590.4862769390614, 590.9793157239476, 591.3436085944599, 591.6124938165508, 11502.309861408343, 11683.357415342152, 12004.519819207222, 12145.696357591043, 12200.633980980496, 11867.881321186764, 12054.216475929037, 12180.086493513021, 12701.110922235448, 12833.67915802103, 11566.016888564482, 11578.94210528942, 11851.407429628483, 11896.107791915554, 12118.030557555463, 3902.2000489899788, 3904.9609503905167, 3934.527856657191, 3938.113924367023, 4010.278149933011, 57868.71065644645, 57920.0, 58148.0, 58336.0, 58880.70559647217, 9830.75423114428, 9844.655437059668, 10022.949885250673, 10213.591456341663, 10232.744181395376, 18610.348637797884, 19379.321723739882, 19684.803151968295, 20046.09792559338, 20055.09752061161, 6614.735410583619, 6990.370866622028, 7121.08230887247, 7154.35610795031, 7277.19950805411, 3584.2473080653353, 3687.797171155612, 3688.704903607705, 3712.294664013829, 3761.191343861083, 2785.5543113101808, 2874.1664917173784, 2893.363460038788, 2920.3721199942115, 2926.7512261457587, 520.7867457785472, 524.5619907377383, 525.9526642602184, 534.7433232048561, 536.3081624704088, 595.5116804220497, 596.0939372154302, 609.6283362434523, 611.1535523300172, 619.6653806944199, 8328.750137495885, 8676.1323867614, 8734.0829212933, 8786.265837019242, 8872.8669069964, 552.8756029893242, 566.3713278261126, 592.1413949772847, 612.7732738886551, 630.6878095342835, 3900.414937759302, 3914.4715463412645, 4058.9594104059174, 4215.641670457984, 4280.6789490788315, 83030.0, 86732.56633716791, 87911.0, 88605.55697221472, 93950.0, 45823.0, 46167.76916115398, 53133.734331328094, 78197.60901195572, 82398.0, 68896.6555167231, 69106.0, 69152.0, 69680.65159674169, 70386.9441958371, 7840.255175758294, 8242.29940455068, 8886.955565222133, 9004.279657627243, 9095.772605684911, 30656.693433066277, 37205.255894882495, 38017.23965520619, 39415.21169576535, 44019.33970990502, 37239.0, 39219.215615688096, 48237.0, 58712.0, 59071.40928590659, 10536.894631053898, 10688.358698478116, 10694.73263168427, 10702.0, 10778.622748203776, 12392.81410778821, 12796.232226066466, 12946.223226606433, 13174.814266715659, 13568.253746044062, 11163.553457861595, 12198.390080496118, 12636.494540218288, 12836.16564923277, 13155.408006639533, 11864.466099025738, 11952.34262115592, 12427.254364738144, 12437.564685235973, 12460.87539124597, 12088.15382923187, 12106.394680265776, 12168.148229623841, 12808.0, 12905.096643234883, 9774.533819927068, 10053.447060411747, 10098.506229436342, 10162.796744065225, 10449.164066874784, 10170.389776613427, 10930.234883558074, 11058.115350771757, 11064.391458469861, 11067.83398249043], "value": 6466.382310041512, "unit": "score"}], "name": "dromaeo_css", "value": 6430.276107112527, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 116.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 123.0, 174.0, 124.0, 126.0, 146.0, 122.0, 192.0, 122.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0, 164.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 130.0, 75.0, 76.0, 74.0, 75.0, 102.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 120.0, 84.0, 86.0, 85.0, 124.0, 86.0, 85.0, 121.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 78.0, 84.0, 78.0, 89.0, 81.0, 79.0, 89.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 128.0, 132.0, 127.0, 126.0, 126.0, 128.0, 164.0, 133.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 163.0, 163.0, 168.0, 162.0, 163.0, 167.0, 166.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 71.0, 66.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1530.8, "alertThreshold": 2.0}]} 09:00:49 INFO - Return code: 0 09:00:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:00:49 INFO - # TBPL SUCCESS # 09:00:49 INFO - Running post-action listener: _resource_record_post_action 09:00:49 INFO - [mozharness: 2016-07-30 16:00:49.394029Z] Finished run-tests step (success) 09:00:49 INFO - Running post-run listener: _resource_record_post_run 09:00:49 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7761920; Write bytes: 360460288; Read time: 1364; Write time: 231376 09:00:49 INFO - TinderboxPrint: CPU usage
13.0% 09:00:49 INFO - TinderboxPrint: I/O read bytes / time
7,761,920 / 1,364 09:00:49 INFO - TinderboxPrint: I/O write bytes / time
360,460,288 / 231,376 09:00:49 INFO - TinderboxPrint: CPU idle
8,340.0 (87.0%) 09:00:49 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 09:00:49 INFO - TinderboxPrint: Swap in / out
0 / 0 09:00:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 133451776; Read time: 0; Write time: 68740 09:00:49 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5521408; Write bytes: 190681088; Read time: 1180; Write time: 119492 09:00:50 INFO - Running post-run listener: _upload_blobber_files 09:00:50 INFO - Blob upload gear active. 09:00:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:00:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:51 INFO - (blobuploader) - INFO - Done attempting. 09:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:54 INFO - (blobuploader) - INFO - Done attempting. 09:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:55 INFO - (blobuploader) - INFO - Done attempting. 09:00:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:55 INFO - Return code: 0 09:00:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5800d714499d7a8222f13b335c18a0485e45657f92d3f85c8a8b937c1c987c056385862c402e9d8cc477c5cf9de31fedeb4d635e1dbf9bc58987039e5b2f12b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f344f5708a60d91f2a69bcfd04e36db26aa1f007a67448bdd072592d362d2248dee1386aff4ed4ed476bd0490a00c9c00ee8dc37a69ffeafb7c5bad7bb91f446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06db3cc14c237ad318d815e5ceaccd1c8f70af1adcecf5a2d9a0385c17055a86cca6ccb6f849e05f096a8c91f96a588e3b2f3ccb0381a7c93730e7c9fc2be15d"} 09:00:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:55 INFO - Contents: 09:00:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5800d714499d7a8222f13b335c18a0485e45657f92d3f85c8a8b937c1c987c056385862c402e9d8cc477c5cf9de31fedeb4d635e1dbf9bc58987039e5b2f12b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f344f5708a60d91f2a69bcfd04e36db26aa1f007a67448bdd072592d362d2248dee1386aff4ed4ed476bd0490a00c9c00ee8dc37a69ffeafb7c5bad7bb91f446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06db3cc14c237ad318d815e5ceaccd1c8f70af1adcecf5a2d9a0385c17055a86cca6ccb6f849e05f096a8c91f96a588e3b2f3ccb0381a7c93730e7c9fc2be15d"} 09:00:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:55 INFO - Copying logs to upload dir... 09:00:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.183221 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-30 09:00:55.465531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:55.468681) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5800d714499d7a8222f13b335c18a0485e45657f92d3f85c8a8b937c1c987c056385862c402e9d8cc477c5cf9de31fedeb4d635e1dbf9bc58987039e5b2f12b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f344f5708a60d91f2a69bcfd04e36db26aa1f007a67448bdd072592d362d2248dee1386aff4ed4ed476bd0490a00c9c00ee8dc37a69ffeafb7c5bad7bb91f446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06db3cc14c237ad318d815e5ceaccd1c8f70af1adcecf5a2d9a0385c17055a86cca6ccb6f849e05f096a8c91f96a588e3b2f3ccb0381a7c93730e7c9fc2be15d"} build_url:https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/SkwCUQAtTMCdsGxXdU54VA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5800d714499d7a8222f13b335c18a0485e45657f92d3f85c8a8b937c1c987c056385862c402e9d8cc477c5cf9de31fedeb4d635e1dbf9bc58987039e5b2f12b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f344f5708a60d91f2a69bcfd04e36db26aa1f007a67448bdd072592d362d2248dee1386aff4ed4ed476bd0490a00c9c00ee8dc37a69ffeafb7c5bad7bb91f446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06db3cc14c237ad318d815e5ceaccd1c8f70af1adcecf5a2d9a0385c17055a86cca6ccb6f849e05f096a8c91f96a588e3b2f3ccb0381a7c93730e7c9fc2be15d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:55.494768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:55.495139) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469893040.112665-662349352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 09:00:55.580464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 09:00:55.580795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 09:00:55.581115) ========= ========= Total master_lag: 0.32 =========