builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1469725241.85 results: success (0) buildid: 20160728084226 builduid: c3d253957ff24634ac5da267aae02782 revision: afb47dfb71ed76d1bf86fe0101cda1a5e6038863 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:41.854203) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:41.854980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:41.855455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:41.931330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:41.931666) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 10:00:42-- 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% 38.7M=0s 2016-07-28 10:00:42 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:42.116633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:42.117024) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016339 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:42.167555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:42.168010) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev afb47dfb71ed76d1bf86fe0101cda1a5e6038863 --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 afb47dfb71ed76d1bf86fe0101cda1a5e6038863 --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=6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 10:00:42,303 truncating revision to first 12 chars 2016-07-28 10:00:42,303 Setting DEBUG logging. 2016-07-28 10:00:42,303 attempt 1/10 2016-07-28 10:00:42,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/afb47dfb71ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 10:00:42,893 unpacking tar archive at: mozilla-central-afb47dfb71ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:43.117330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:43.117668) ========= script_repo_revision: afb47dfb71ed76d1bf86fe0101cda1a5e6038863 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:43.118062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:43.118328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:00:43.128536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-28 10:00:43.129057) ========= /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=6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:43 INFO - MultiFileLogger online at 20160728 10:00:43 in /builds/slave/test 10:00:43 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 10:00:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:43 INFO - {'append_to_log': False, 10:00:43 INFO - 'base_work_dir': '/builds/slave/test', 10:00:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:00:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:43 INFO - 'branch': 'Firefox-Non-PGO', 10:00:43 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:43 INFO - 'config_files': ('talos/linux_config.py',), 10:00:43 INFO - 'default_actions': ('clobber', 10:00:43 INFO - 'read-buildbot-config', 10:00:43 INFO - 'download-and-extract', 10:00:43 INFO - 'populate-webroot', 10:00:43 INFO - 'create-virtualenv', 10:00:43 INFO - 'install', 10:00:43 INFO - 'run-tests'), 10:00:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:43 INFO - 'download_minidump_stackwalk': True, 10:00:43 INFO - 'download_symbols': 'ondemand', 10:00:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:43 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:43 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:43 INFO - 'installer_path': 'installer.exe', 10:00:43 INFO - 'log_level': 'info', 10:00:43 INFO - 'log_name': 'talos', 10:00:43 INFO - 'log_to_console': True, 10:00:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:43 INFO - 'opt_config_files': (), 10:00:43 INFO - 'pip_index': False, 10:00:43 INFO - 'sps_profile': False, 10:00:43 INFO - 'sps_profile_interval': 0, 10:00:43 INFO - 'suite': 'dromaeojs', 10:00:43 INFO - 'system_bits': '32', 10:00:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:43 INFO - 'title': 'talos-linux64-ix-023', 10:00:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:43 INFO - 'use_talos_json': True, 10:00:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:43 INFO - 'work_dir': 'build'} 10:00:43 INFO - [mozharness: 2016-07-28 17:00:43.353481Z] Running clobber step. 10:00:43 INFO - Running pre-action listener: _resource_record_pre_action 10:00:43 INFO - Running main action method: clobber 10:00:43 INFO - rmtree: /builds/slave/test/build 10:00:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:43 INFO - Running post-action listener: _resource_record_post_action 10:00:43 INFO - [mozharness: 2016-07-28 17:00:43.840882Z] Finished clobber step (success) 10:00:43 INFO - [mozharness: 2016-07-28 17:00:43.840981Z] Running read-buildbot-config step. 10:00:43 INFO - Running pre-action listener: _resource_record_pre_action 10:00:43 INFO - Running main action method: read_buildbot_config 10:00:43 INFO - Using buildbot properties: 10:00:43 INFO - { 10:00:43 INFO - "project": "", 10:00:43 INFO - "product": "firefox", 10:00:43 INFO - "script_repo_revision": "production", 10:00:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:00:43 INFO - "repository": "", 10:00:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:00:43 INFO - "buildid": "20160728084226", 10:00:43 INFO - "pgo_build": "False", 10:00:43 INFO - "basedir": "/builds/slave/test", 10:00:43 INFO - "buildnumber": 664, 10:00:43 INFO - "slavename": "talos-linux64-ix-023", 10:00:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:00:43 INFO - "platform": "ubuntu64_hw", 10:00:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:00:43 INFO - "branch": "mozilla-central", 10:00:43 INFO - "repo_path": "mozilla-central", 10:00:43 INFO - "revision": "afb47dfb71ed76d1bf86fe0101cda1a5e6038863", 10:00:43 INFO - "stage_platform": "linux64", 10:00:43 INFO - "builduid": "c3d253957ff24634ac5da267aae02782", 10:00:43 INFO - "slavebuilddir": "test" 10:00:43 INFO - } 10:00:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:00:43 INFO - Running post-action listener: _resource_record_post_action 10:00:43 INFO - [mozharness: 2016-07-28 17:00:43.843407Z] Finished read-buildbot-config step (success) 10:00:43 INFO - [mozharness: 2016-07-28 17:00:43.843496Z] Running download-and-extract step. 10:00:43 INFO - Running pre-action listener: _resource_record_pre_action 10:00:43 INFO - Running main action method: download_and_extract 10:00:43 INFO - mkdir: /builds/slave/test/build/tests 10:00: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')]} 10:00:43 INFO - https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:44 INFO - Downloaded 1361 bytes. 10:00:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:00:44 INFO - Using the following test package requirements: 10:00:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:00:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'jsshell-linux-x86_64.zip'], 10:00:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:00:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:00:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:44 INFO - https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:46 INFO - Downloaded 22746516 bytes. 10:00:46 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'] 10:00:46 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 10:00:47 INFO - Return code: 0 10:00:47 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 10:00: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')]} 10:00:47 INFO - https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:00:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:00:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:00:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:48 INFO - Downloaded 22746516 bytes. 10:00:48 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'] 10:00:48 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 10:00:49 INFO - Return code: 0 10:00:49 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')]} 10:00:49 INFO - https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:50 INFO - Downloaded 14413725 bytes. 10:00:50 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'] 10:00:50 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 10:00:50 INFO - Return code: 0 10:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:50 INFO - https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:00:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt0ur10RRqCylghPuG8cFw/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 10:00:52 INFO - Downloaded 57160553 bytes. 10:00:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:52 INFO - mkdir: /builds/slave/test/properties 10:00:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:52 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:52 INFO - Contents: 10:00:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:52 INFO - Running post-action listener: _resource_record_post_action 10:00:52 INFO - Running post-action listener: set_extra_try_arguments 10:00:52 INFO - [mozharness: 2016-07-28 17:00:52.891790Z] Finished download-and-extract step (success) 10:00:52 INFO - [mozharness: 2016-07-28 17:00:52.892030Z] Running populate-webroot step. 10:00:52 INFO - Running pre-action listener: _resource_record_pre_action 10:00:52 INFO - Running main action method: populate_webroot 10:00:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:52 INFO - '--tppagecycles', 10:00:52 INFO - '7'], 10:00:52 INFO - 'tests': ['tsvgm']}}, 10:00:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['damp', 'tps']}, 10:00:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'tests': ['damp', 'tps']}, 10:00:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['dromaeo_dom']}, 10:00:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['basic_compositor_video']}, 10:00:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tsvgx', 10:00:52 INFO - 'tsvgr_opacity', 10:00:52 INFO - 'tart', 10:00:52 INFO - 'tscrollx', 10:00:52 INFO - 'cart']}, 10:00:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:52 INFO - 'tsvgr_opacity', 10:00:52 INFO - 'tart', 10:00:52 INFO - 'tscrollx', 10:00:52 INFO - 'cart']}, 10:00:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tp5o']}, 10:00:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'tests': ['tp5o']}, 10:00:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s', 10:00:52 INFO - '--xperf_path', 10:00:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:52 INFO - 'tests': ['tp5n']}, 10:00:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--xperf_path', 10:00:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:52 INFO - 'tests': ['tp5n']}}, 10:00:52 INFO - 'talos.zip': {'path': '', 10:00:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:52 INFO - Running post-action listener: _resource_record_post_action 10:00:52 INFO - [mozharness: 2016-07-28 17:00:52.911230Z] Finished populate-webroot step (success) 10:00:52 INFO - [mozharness: 2016-07-28 17:00:52.911319Z] Running create-virtualenv step. 10:00:52 INFO - Running pre-action listener: _resource_record_pre_action 10:00:52 INFO - Running main action method: create_virtualenv 10:00:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:00:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:53 INFO - Using real prefix '/usr' 10:00:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:55 INFO - Installing pip.................done. 10:00:55 INFO - Return code: 0 10:00:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:55 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:00:55 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 10:00:55 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 10:00:55 INFO - Using env: {'DISPLAY': ':0', 10:00:55 INFO - 'HOME': '/home/cltbld', 10:00:55 INFO - 'LANG': 'en_US.UTF-8', 10:00:55 INFO - 'LANGUAGE': 'en_US:en', 10:00:55 INFO - 'LOGNAME': 'cltbld', 10:00:55 INFO - 'MAIL': '/var/mail/cltbld', 10:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:55 INFO - 'MOZ_NO_REMOTE': '1', 10:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:55 INFO - 'NO_EM_RESTART': '1', 10:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:55 INFO - 'PWD': '/builds/slave/test', 10:00:55 INFO - 'SHELL': '/bin/bash', 10:00:55 INFO - 'SHLVL': '1', 10:00:55 INFO - 'TERM': 'linux', 10:00:55 INFO - 'TMOUT': '86400', 10:00:55 INFO - 'USER': 'cltbld', 10:00:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:55 INFO - '_': '/tools/buildbot/bin/python'} 10:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:00:55 INFO - Cleaning up... 10:00:55 INFO - Return code: 0 10:00:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:55 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:00:55 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 10:00:55 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 10:00:55 INFO - Using env: {'DISPLAY': ':0', 10:00:55 INFO - 'HOME': '/home/cltbld', 10:00:55 INFO - 'LANG': 'en_US.UTF-8', 10:00:55 INFO - 'LANGUAGE': 'en_US:en', 10:00:55 INFO - 'LOGNAME': 'cltbld', 10:00:55 INFO - 'MAIL': '/var/mail/cltbld', 10:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:55 INFO - 'MOZ_NO_REMOTE': '1', 10:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:55 INFO - 'NO_EM_RESTART': '1', 10:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:55 INFO - 'PWD': '/builds/slave/test', 10:00:55 INFO - 'SHELL': '/bin/bash', 10:00:55 INFO - 'SHLVL': '1', 10:00:55 INFO - 'TERM': 'linux', 10:00:55 INFO - 'TMOUT': '86400', 10:00:55 INFO - 'USER': 'cltbld', 10:00:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:55 INFO - '_': '/tools/buildbot/bin/python'} 10:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:55 INFO - Downloading/unpacking psutil>=3.1.1 10:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:57 INFO - Installing collected packages: psutil 10:00:57 INFO - Running setup.py install for psutil 10:00:57 INFO - building 'psutil._psutil_linux' extension 10:00:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:00:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:00:58 INFO - building 'psutil._psutil_posix' extension 10:00:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:00:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:00:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:58 INFO - Successfully installed psutil 10:00:58 INFO - Cleaning up... 10:00:58 INFO - Return code: 0 10:00:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:58 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:00:58 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 10:00:58 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 10:00:58 INFO - Using env: {'DISPLAY': ':0', 10:00:58 INFO - 'HOME': '/home/cltbld', 10:00:58 INFO - 'LANG': 'en_US.UTF-8', 10:00:58 INFO - 'LANGUAGE': 'en_US:en', 10:00:58 INFO - 'LOGNAME': 'cltbld', 10:00:58 INFO - 'MAIL': '/var/mail/cltbld', 10:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:58 INFO - 'MOZ_NO_REMOTE': '1', 10:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:58 INFO - 'NO_EM_RESTART': '1', 10:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:58 INFO - 'PWD': '/builds/slave/test', 10:00:58 INFO - 'SHELL': '/bin/bash', 10:00:58 INFO - 'SHLVL': '1', 10:00:58 INFO - 'TERM': 'linux', 10:00:58 INFO - 'TMOUT': '86400', 10:00:58 INFO - 'USER': 'cltbld', 10:00:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:58 INFO - '_': '/tools/buildbot/bin/python'} 10:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:00 INFO - Installing collected packages: mozsystemmonitor 10:01:00 INFO - Running setup.py install for mozsystemmonitor 10:01:00 INFO - Successfully installed mozsystemmonitor 10:01:00 INFO - Cleaning up... 10:01:01 INFO - Return code: 0 10:01:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:01 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:01 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 10:01:01 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 10:01:01 INFO - Using env: {'DISPLAY': ':0', 10:01:01 INFO - 'HOME': '/home/cltbld', 10:01:01 INFO - 'LANG': 'en_US.UTF-8', 10:01:01 INFO - 'LANGUAGE': 'en_US:en', 10:01:01 INFO - 'LOGNAME': 'cltbld', 10:01:01 INFO - 'MAIL': '/var/mail/cltbld', 10:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:01 INFO - 'MOZ_NO_REMOTE': '1', 10:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:01 INFO - 'NO_EM_RESTART': '1', 10:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:01 INFO - 'PWD': '/builds/slave/test', 10:01:01 INFO - 'SHELL': '/bin/bash', 10:01:01 INFO - 'SHLVL': '1', 10:01:01 INFO - 'TERM': 'linux', 10:01:01 INFO - 'TMOUT': '86400', 10:01:01 INFO - 'USER': 'cltbld', 10:01:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:01 INFO - '_': '/tools/buildbot/bin/python'} 10:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:01 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:03 INFO - warning: no files found matching '*.txt' 10:01:03 INFO - no previously-included directories found matching 'build' 10:01:03 INFO - no previously-included directories found matching 'dist' 10:01:03 INFO - no previously-included directories found matching '.git*' 10:01:03 INFO - Installing collected packages: jsonschema, functools32 10:01:03 INFO - Running setup.py install for functools32 10:01:03 INFO - warning: no files found matching '*.txt' 10:01:03 INFO - no previously-included directories found matching 'build' 10:01:03 INFO - no previously-included directories found matching 'dist' 10:01:03 INFO - no previously-included directories found matching '.git*' 10:01:03 INFO - Successfully installed jsonschema functools32 10:01:03 INFO - Cleaning up... 10:01:03 INFO - Return code: 0 10:01:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:03 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 10:01:03 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 10:01:03 INFO - Using env: {'DISPLAY': ':0', 10:01:03 INFO - 'HOME': '/home/cltbld', 10:01:03 INFO - 'LANG': 'en_US.UTF-8', 10:01:03 INFO - 'LANGUAGE': 'en_US:en', 10:01:03 INFO - 'LOGNAME': 'cltbld', 10:01:03 INFO - 'MAIL': '/var/mail/cltbld', 10:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:03 INFO - 'MOZ_NO_REMOTE': '1', 10:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:03 INFO - 'NO_EM_RESTART': '1', 10:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:03 INFO - 'PWD': '/builds/slave/test', 10:01:03 INFO - 'SHELL': '/bin/bash', 10:01:03 INFO - 'SHLVL': '1', 10:01:03 INFO - 'TERM': 'linux', 10:01:03 INFO - 'TMOUT': '86400', 10:01:03 INFO - 'USER': 'cltbld', 10:01:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:03 INFO - '_': '/tools/buildbot/bin/python'} 10:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:01:03 INFO - Cleaning up... 10:01:03 INFO - Return code: 0 10:01:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:03 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 10:01:03 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 10:01:03 INFO - Using env: {'DISPLAY': ':0', 10:01:03 INFO - 'HOME': '/home/cltbld', 10:01:03 INFO - 'LANG': 'en_US.UTF-8', 10:01:03 INFO - 'LANGUAGE': 'en_US:en', 10:01:03 INFO - 'LOGNAME': 'cltbld', 10:01:03 INFO - 'MAIL': '/var/mail/cltbld', 10:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:03 INFO - 'MOZ_NO_REMOTE': '1', 10:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:03 INFO - 'NO_EM_RESTART': '1', 10:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:03 INFO - 'PWD': '/builds/slave/test', 10:01:03 INFO - 'SHELL': '/bin/bash', 10:01:03 INFO - 'SHLVL': '1', 10:01:03 INFO - 'TERM': 'linux', 10:01:03 INFO - 'TMOUT': '86400', 10:01:03 INFO - 'USER': 'cltbld', 10:01:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:03 INFO - '_': '/tools/buildbot/bin/python'} 10:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:04 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 10:01:04 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 10:01:04 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 10:01:04 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 10:01:04 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 10:01:04 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 10:01:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - Downloading docopt-0.6.1.tar.gz 10:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:06 INFO - Running setup.py install for blobuploader 10:01:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:01:06 INFO - Running setup.py install for requests 10:01:07 INFO - Running setup.py install for docopt 10:01:07 INFO - Successfully installed blobuploader requests docopt 10:01:07 INFO - Cleaning up... 10:01:07 INFO - Return code: 0 10:01:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:07 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:07 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 10:01:07 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 10:01:07 INFO - Using env: {'DISPLAY': ':0', 10:01:07 INFO - 'HOME': '/home/cltbld', 10:01:07 INFO - 'LANG': 'en_US.UTF-8', 10:01:07 INFO - 'LANGUAGE': 'en_US:en', 10:01:07 INFO - 'LOGNAME': 'cltbld', 10:01:07 INFO - 'MAIL': '/var/mail/cltbld', 10:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:07 INFO - 'MOZ_NO_REMOTE': '1', 10:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:07 INFO - 'NO_EM_RESTART': '1', 10:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:07 INFO - 'PWD': '/builds/slave/test', 10:01:07 INFO - 'SHELL': '/bin/bash', 10:01:07 INFO - 'SHLVL': '1', 10:01:07 INFO - 'TERM': 'linux', 10:01:07 INFO - 'TMOUT': '86400', 10:01:07 INFO - 'USER': 'cltbld', 10:01:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:07 INFO - '_': '/tools/buildbot/bin/python'} 10:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:07 INFO - Running setup.py (path:/tmp/pip-kCcDAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:07 INFO - Running setup.py (path:/tmp/pip-yXeypW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:07 INFO - Running setup.py (path:/tmp/pip-uciC68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:07 INFO - Running setup.py (path:/tmp/pip-WuxbUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:07 INFO - Running setup.py (path:/tmp/pip-qr_y1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:07 INFO - Running setup.py (path:/tmp/pip-cSPq2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:07 INFO - Running setup.py (path:/tmp/pip-X3k7UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:08 INFO - Running setup.py (path:/tmp/pip-wVTK83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:08 INFO - Running setup.py (path:/tmp/pip-FmFG8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:08 INFO - Running setup.py (path:/tmp/pip-KjH2Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:08 INFO - Running setup.py (path:/tmp/pip-60hLjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:08 INFO - Running setup.py (path:/tmp/pip-iM7FcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:08 INFO - Running setup.py (path:/tmp/pip-gX5600-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:08 INFO - Running setup.py (path:/tmp/pip-OOlLyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:08 INFO - Running setup.py (path:/tmp/pip-b6pgjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:08 INFO - Running setup.py (path:/tmp/pip-lss9PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:08 INFO - Running setup.py (path:/tmp/pip-bziz22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:08 INFO - Running setup.py install for manifestparser 10:01:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:01:08 INFO - Running setup.py install for mozcrash 10:01:08 INFO - Running setup.py install for mozdebug 10:01:09 INFO - Running setup.py install for mozdevice 10:01:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Running setup.py install for mozfile 10:01:09 INFO - Running setup.py install for mozhttpd 10:01:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Running setup.py install for mozinfo 10:01:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Running setup.py install for mozInstall 10:01:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Running setup.py install for mozleak 10:01:09 INFO - Running setup.py install for mozlog 10:01:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Running setup.py install for moznetwork 10:01:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:01:09 INFO - Running setup.py install for mozprocess 10:01:09 INFO - Running setup.py install for mozprofile 10:01:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:01:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:01:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:01:10 INFO - Running setup.py install for mozrunner 10:01:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:01:10 INFO - Running setup.py install for mozscreenshot 10:01:10 INFO - Running setup.py install for moztest 10:01:10 INFO - Running setup.py install for mozversion 10:01:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:01:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:10 INFO - Cleaning up... 10:01:10 INFO - Return code: 0 10:01:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:10 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:10 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 10:01:10 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 10:01:10 INFO - Using env: {'DISPLAY': ':0', 10:01:10 INFO - 'HOME': '/home/cltbld', 10:01:10 INFO - 'LANG': 'en_US.UTF-8', 10:01:10 INFO - 'LANGUAGE': 'en_US:en', 10:01:10 INFO - 'LOGNAME': 'cltbld', 10:01:10 INFO - 'MAIL': '/var/mail/cltbld', 10:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:10 INFO - 'MOZ_NO_REMOTE': '1', 10:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:10 INFO - 'NO_EM_RESTART': '1', 10:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:10 INFO - 'PWD': '/builds/slave/test', 10:01:10 INFO - 'SHELL': '/bin/bash', 10:01:10 INFO - 'SHLVL': '1', 10:01:10 INFO - 'TERM': 'linux', 10:01:10 INFO - 'TMOUT': '86400', 10:01:10 INFO - 'USER': 'cltbld', 10:01:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:10 INFO - '_': '/tools/buildbot/bin/python'} 10:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:10 INFO - Running setup.py (path:/tmp/pip-cttaM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:10 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)) 10:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:10 INFO - Running setup.py (path:/tmp/pip-IfP2sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:10 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)) 10:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:10 INFO - Running setup.py (path:/tmp/pip-p6yxZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:11 INFO - Running setup.py (path:/tmp/pip-jzf2Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:11 INFO - Running setup.py (path:/tmp/pip-pp86oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:11 INFO - Running setup.py (path:/tmp/pip-hieTD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:11 INFO - Running setup.py (path:/tmp/pip-dCAM3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:11 INFO - Running setup.py (path:/tmp/pip-kMVp86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:11 INFO - Running setup.py (path:/tmp/pip-_pCxGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:11 INFO - Running setup.py (path:/tmp/pip-nbL8iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:11 INFO - Running setup.py (path:/tmp/pip-kwvBAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:11 INFO - Running setup.py (path:/tmp/pip-JtcJr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:11 INFO - Running setup.py (path:/tmp/pip-n8akRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:11 INFO - Running setup.py (path:/tmp/pip-V0vP04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:11 INFO - Running setup.py (path:/tmp/pip-lQVxUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:11 INFO - Running setup.py (path:/tmp/pip-MO60AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:11 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)) 10:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:11 INFO - Running setup.py (path:/tmp/pip-pgjz9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:12 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)) 10:01:12 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)) 10:01:12 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)) 10:01:12 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)) 10:01:12 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)) 10:01:12 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)) 10:01:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:13 INFO - Downloading blessings-1.6.tar.gz 10:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:14 INFO - Installing collected packages: blessings 10:01:14 INFO - Running setup.py install for blessings 10:01:14 INFO - Successfully installed blessings 10:01:14 INFO - Cleaning up... 10:01:14 INFO - Return code: 0 10:01:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:14 INFO - Reading from file tmpfile_stdout 10:01:14 INFO - Current package versions: 10:01:14 INFO - argparse == 1.2.1 10:01:14 INFO - blessings == 1.6 10:01:14 INFO - blobuploader == 1.2.4 10:01:14 INFO - docopt == 0.6.1 10:01:14 INFO - functools32 == 3.2.3-2 10:01:14 INFO - jsonschema == 2.5.1 10:01:14 INFO - manifestparser == 1.1 10:01:14 INFO - mozInstall == 1.12 10:01:14 INFO - mozcrash == 0.17 10:01:14 INFO - mozdebug == 0.1 10:01:14 INFO - mozdevice == 0.48 10:01:14 INFO - mozfile == 1.2 10:01:14 INFO - mozhttpd == 0.7 10:01:14 INFO - mozinfo == 0.9 10:01:14 INFO - mozleak == 0.1 10:01:14 INFO - mozlog == 3.3 10:01:14 INFO - moznetwork == 0.27 10:01:14 INFO - mozprocess == 0.23 10:01:14 INFO - mozprofile == 0.28 10:01:14 INFO - mozrunner == 6.12 10:01:14 INFO - mozscreenshot == 0.1 10:01:14 INFO - mozsystemmonitor == 0.3 10:01:14 INFO - moztest == 0.7 10:01:14 INFO - mozversion == 1.4 10:01:14 INFO - psutil == 3.1.1 10:01:14 INFO - requests == 1.2.3 10:01:14 INFO - wsgiref == 0.1.2 10:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:14 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 10:01:14 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 10:01:14 INFO - Using env: {'DISPLAY': ':0', 10:01:14 INFO - 'HOME': '/home/cltbld', 10:01:14 INFO - 'LANG': 'en_US.UTF-8', 10:01:14 INFO - 'LANGUAGE': 'en_US:en', 10:01:14 INFO - 'LOGNAME': 'cltbld', 10:01:14 INFO - 'MAIL': '/var/mail/cltbld', 10:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:14 INFO - 'MOZ_NO_REMOTE': '1', 10:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:14 INFO - 'NO_EM_RESTART': '1', 10:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:14 INFO - 'PWD': '/builds/slave/test', 10:01:14 INFO - 'SHELL': '/bin/bash', 10:01:14 INFO - 'SHLVL': '1', 10:01:14 INFO - 'TERM': 'linux', 10:01:14 INFO - 'TMOUT': '86400', 10:01:14 INFO - 'USER': 'cltbld', 10:01:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:14 INFO - '_': '/tools/buildbot/bin/python'} 10:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 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)) 10:01:14 INFO - Cleaning up... 10:01:14 INFO - Return code: 0 10:01:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 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 0x1e5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', '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 10:01:14 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 10:01:14 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 10:01:14 INFO - Using env: {'DISPLAY': ':0', 10:01:14 INFO - 'HOME': '/home/cltbld', 10:01:14 INFO - 'LANG': 'en_US.UTF-8', 10:01:14 INFO - 'LANGUAGE': 'en_US:en', 10:01:14 INFO - 'LOGNAME': 'cltbld', 10:01:14 INFO - 'MAIL': '/var/mail/cltbld', 10:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:14 INFO - 'MOZ_NO_REMOTE': '1', 10:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:14 INFO - 'NO_EM_RESTART': '1', 10:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:14 INFO - 'PWD': '/builds/slave/test', 10:01:14 INFO - 'SHELL': '/bin/bash', 10:01:14 INFO - 'SHLVL': '1', 10:01:14 INFO - 'TERM': 'linux', 10:01:14 INFO - 'TMOUT': '86400', 10:01:14 INFO - 'USER': 'cltbld', 10:01:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:14 INFO - '_': '/tools/buildbot/bin/python'} 10:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:01:14 INFO - Cleaning up... 10:01:14 INFO - Return code: 0 10:01:14 INFO - Running post-action listener: _resource_record_post_action 10:01:14 INFO - Running post-action listener: _start_resource_monitoring 10:01:14 INFO - Starting resource monitoring. 10:01:14 INFO - [mozharness: 2016-07-28 17:01:14.914011Z] Finished create-virtualenv step (success) 10:01:14 INFO - [mozharness: 2016-07-28 17:01:14.914476Z] Running install step. 10:01:14 INFO - Running pre-action listener: _resource_record_pre_action 10:01:14 INFO - Running main action method: install 10:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:15 INFO - Reading from file tmpfile_stdout 10:01:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:01:15 INFO - Reading from file tmpfile_stdout 10:01:15 INFO - Output received: 10:01:15 INFO - Usage: mozinstall [options] installer 10:01:15 INFO - Options: 10:01:15 INFO - -h, --help show this help message and exit 10:01:15 INFO - -d DEST, --destination=DEST 10:01:15 INFO - Directory to install application into. [default: 10:01:15 INFO - "/builds/slave/test"] 10:01:15 INFO - --app=APP Application being installed. [default: firefox] 10:01:15 INFO - mkdir: /builds/slave/test/build/application 10:01:15 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'] 10:01:15 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 10:01:31 INFO - Reading from file tmpfile_stdout 10:01:31 INFO - Output received: 10:01:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:01:31 INFO - Running post-action listener: _resource_record_post_action 10:01:31 INFO - [mozharness: 2016-07-28 17:01:31.652183Z] Finished install step (success) 10:01:31 INFO - [mozharness: 2016-07-28 17:01:31.652461Z] Running run-tests step. 10:01:31 INFO - Running pre-action listener: _resource_record_pre_action 10:01:31 INFO - Running main action method: run_tests 10:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:31 INFO - Python 2.7.3 10:01:31 INFO - Return code: 0 10:01:31 INFO - grabbing minidump binary from tooltool 10:01: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')]} 10:01:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211a3b0>, '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 0x211b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:01:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:01:31 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 10:01:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:31 INFO - Return code: 0 10:01:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:01:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:01:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:31 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/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 10:01:31 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/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 10:01:31 INFO - Using env: {'DISPLAY': ':0', 10:01:31 INFO - 'HOME': '/home/cltbld', 10:01:31 INFO - 'LANG': 'en_US.UTF-8', 10:01:31 INFO - 'LANGUAGE': 'en_US:en', 10:01:31 INFO - 'LOGNAME': 'cltbld', 10:01:31 INFO - 'MAIL': '/var/mail/cltbld', 10:01:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:31 INFO - 'MOZ_NO_REMOTE': '1', 10:01:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:31 INFO - 'NO_EM_RESTART': '1', 10:01:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:31 INFO - 'PWD': '/builds/slave/test', 10:01:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:31 INFO - 'SHELL': '/bin/bash', 10:01:31 INFO - 'SHLVL': '1', 10:01:31 INFO - 'TERM': 'linux', 10:01:31 INFO - 'TMOUT': '86400', 10:01:31 INFO - 'USER': 'cltbld', 10:01:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292', 10:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:31 INFO - '_': '/tools/buildbot/bin/python'} 10:01:31 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/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 10:01:31 INFO - mozversion application_buildid: 20160728084226 10:01:31 INFO - mozversion application_changeset: afb47dfb71ed76d1bf86fe0101cda1a5e6038863 10:01:31 INFO - mozversion application_display_name: Nightly 10:01:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:31 INFO - mozversion application_name: Firefox 10:01:31 INFO - mozversion application_remotingname: firefox 10:01:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:01:31 INFO - mozversion application_vendor: Mozilla 10:01:31 INFO - mozversion application_version: 50.0a1 10:01:31 INFO - mozversion platform_buildid: 20160728084226 10:01:31 INFO - mozversion platform_changeset: afb47dfb71ed76d1bf86fe0101cda1a5e6038863 10:01:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:01:31 INFO - mozversion platform_version: 50.0a1 10:01:31 INFO - using testdate: 1469725291 10:01:31 INFO - actual date: 1469725291 10:01:31 INFO - starting webserver on 'localhost:47175' 10:01:31 INFO - SUITE-START | Running 2 tests 10:01:31 INFO - TEST-START | dromaeo_css 10:01:31 INFO - operating with platform_type : linux_ 10:01:31 INFO - Initialising browser for dromaeo_css test... 10:01:31 INFO - TEST-INFO | started process 29127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Al6HE/profile http://localhost:47175/getInfo.html) 10:01:35 INFO - PROCESS | 29127 | JavaScript error: , line 0: uncaught exception: undefined 10:01:36 INFO - PROCESS | 29127 | __metrics Screen width/height:1600/1200 10:01:36 INFO - PROCESS | 29127 | colorDepth:24 10:01:36 INFO - PROCESS | 29127 | Browser inner width/height: 1024/697 10:01:36 INFO - PROCESS | 29127 | __metrics 10:01:36 INFO - PROCESS | 29127 | 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" 10:01:36 INFO - PROCESS | 29127 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:37 INFO - TEST-INFO | 29127: exit 0 10:01:37 INFO - Browser initialized. 10:01:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:37 INFO - TEST-INFO | started process 29205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Al6HE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:49 INFO - PROCESS | 29205 | RSS: Main: 159293440 10:01:49 INFO - PROCESS | 29205 | 10:02:41 INFO - PROCESS | 29205 | 1469725361553 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] 10:04:54 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:47175/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47175/tests/dromaeo/cssquery-ext.html) 10:04:55 INFO - PROCESS | 29205 | RSS: Main: 247808000 10:04:55 INFO - PROCESS | 29205 | 10:07:57 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:47175/tests/dromaeo/cssquery-ext.html (next: http://localhost:47175/tests/dromaeo/cssquery-jquery.html) 10:07:58 INFO - PROCESS | 29205 | RSS: Main: 243269632 10:07:58 INFO - PROCESS | 29205 | 10:11:00 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:47175/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47175/tests/dromaeo/cssquery-mootools.html) 10:11:01 INFO - PROCESS | 29205 | RSS: Main: 230154240 10:11:01 INFO - PROCESS | 29205 | 10:14:03 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:47175/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47175/tests/dromaeo/cssquery-prototype.html) 10:14:04 INFO - PROCESS | 29205 | RSS: Main: 189677568 10:14:04 INFO - PROCESS | 29205 | 10:17:06 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:47175/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47175/tests/dromaeo/cssquery-yui.html) 10:17:07 INFO - PROCESS | 29205 | RSS: Main: 190885888 10:17:07 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:47175/tests/dromaeo/cssquery-yui.html (next: http://localhost:47175/tests/dromaeo/cssquery-dojo.html) 10:20:10 INFO - PROCESS | 29205 | RSS: Main: 282898432 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | __start_tp_report 10:20:10 INFO - PROCESS | 29205 | _x_x_mozilla_page_load 10:20:10 INFO - PROCESS | 29205 | _x_x_mozilla_page_load_details 10:20:10 INFO - PROCESS | 29205 | |i|pagename|runs| 10:20:10 INFO - PROCESS | 29205 | |0;dojo.html;2650.6686664166978;2663.1611042521617;2680.5309070912585;2701.257154282572;2702.2163572563945;4604.263317869133;4663.463701674308;4803.423589169301;4848.393950756155;4878.414590249166;4729;4730.101280756654;4735.905281894368;4830.541098595628;4850.830220942268;4359.934600980988;4386.34204869269;4412.955870441303;4449.421575195228;4488.214562451574;4380.408644832939;4521.412216411862;4522.886927826798;4559.065391594715;4562.931556026662;4466.932996005063;4501.369808226851;4519.570640789137;4542.6138778203895;4560.475545312298;4304.096139810644;4335.978320108411;4342;4371.082072764723;4389.582989615981;4326.5673432656795;4347.2826983547675;4390.736555806662;4395.956040439587;4476.1271552047365;4808.230683090724;4808.927866082012;4814.301926220678;4825.975870120662;4857.587105096036;5154.175331946871;5200.427952925213;5211.921821172686;5211.973940130313;5212.452692467275;4997.975010124963;5046.293518907356;5141.640085194038;5143.382794064699;5180.456052114511;4795.088933102734;4835.540623640819;4875.7074575525585;4875.975620121877;4883.02339532095;5129.769160387791;5339.252504649352;5345.1714984177515;5346.625736198506;5347.385050719139;4970.229614409773;5002.424721157114;5071.163258062452;5072.416672082684;5125.718085505258;5184.974075129676;5218.321618189687;5232.293640358579;5236.842894713165;5240.135377662643;5096.159133742891;5100.362454693163;5101.897962040813;5104.9744751276;5106.157484015096;4918.040982008474;5032.421271553745;5032.521910418504;5033.245013247969;5033.446320904697;4326.978365108217;4366.3013917773005;4370.475542934868;4371.0602220522105;4371.388005679208;3796.9430458543143;3842.1355195080882;3869.806509674505;3876.5154355705536;3940.4286378474962;4469.307257375112;4473.5526447355005;4476.6418686505;4479.843205487792;4522.886927826765;5187.351581052369;5190.377154741455;5190.6366554341585;5192.169252919514;5200.323957885451;4324.567543245713;4412.845550405785;4458.509563947963;4458.576435238647;4525.886852828706;4685.789139488731;4689.929651055237;4690.460597031317;4691.319758634979;4736.502667219892;4867.683600565952;4882.316475693335;4883.047805677858;4883.755812209304;4927.187014142626;4995.450500445021;5095.974520127375;5135.178371460548;5139.948600513947;5191.117510023229;4807.6394270429155;4844.2007068833245;4845.903081938412;4849.078675051729;4875.293082503088;5039.0929632665;5047.293378927026;5047.747612619428;5054.241863720471;5132.640715149903;5034;5096.43939166684;5128.512791284822;5143.022825663112;5149.2276158576515;5027.044861476308;5036.320096787033;5039.949600503948;5042.193249080129;5098.592112631055;4970.975145124251;4979.601631869369;4979.751012449436;4982.277569752293;4982.701037937735;4815.542523460265;4869.537393947569;4921.360223170965;4927.384076990376;5023.045621332081;5065.848024559269;5067.746612669278;5073.137566613611;5074.188129899346;5130.589552835839;4779.30700048498;4925.827596034122;4939.925901111558;4955.231939049453;4955.876103097307 10:20:10 INFO - PROCESS | 29205 | |1;ext.html;563.5998441106814;585.9560532960027;589.1604463639313;589.9380565040673;591.2313991810645;26453.206403807868;37926.43110353347;39533;39588.40617390742;42439.78780106103;41095.794521027354;41597;41626.79186604063;41715.58284417155;41719.374209386806;7502.624868756554;7726.884096738553;7730.226977302253;7732.806679832993;7733.922660773376;7687.807804804868;7779.183185765498;7785.3771698264;7785.493942893722;7788.337991270749;7784.688612455495;7822.335101516378;7833.41249406294;7834.2949134577875;7835.451518393715;7682.884756728654;7725.072991241059;7746.10919744231;7760.029996250469;7769.999999999972;7741.458097933147;7748.883766743504;7802.375809935192;7805.4536182467255;7828.138904720477;37974;38402.80798596017;38420.157984201636;38449.23101537953;38450.84647460581;2964.392299578581;2973.2120987938215;2976.55351697245;3074.2775447769754;3327.2513684421056;28888.711112888814;29738.40523189524;29970.25074373136;30314;30339.544906826417;3269.1500209945348;3285.78642388244;3324;3333.7333013358875;3405.404054290489;249040;249051;249570;249573;250725;28390.290242743682;46990;47069.76465117653;47080.5291947083;47174.5282547177;34229.144271392914;34361.656383435846;34455.48316775251;34472.482912755826;34485.310293793984;13544.525941591997;13615.795763063563;13673.931630341785;13693.726125477633;13698.931505342609;11379.829302560469;11430.657080287605;11481.770364592661;11488.080953523699;11504.94247528757;7803.648835802289;7834.529928204326;7898.210178982055;7947.966764320717;7958.522488650699;3077.9538306925415;3133.1383869436086;3141.4659507883716;3150.9054728358187;3160.5891234139413;822.2312138150849;880.6741505642954;881.074871385056;946.2430055955208;993.64228877604;28321.57517637237;28578.857105714338;28962.855185723936;29050.41899162005;29583.26041848971;917.4586993673764;926.5321012888448;932.7108596335158;1000.5347513406301;1034.6016783538391;14883.255837208097;15040;15192.696146077238;15455;15552.14463204512;441363;445259;446278;446400;446524;49471.03173809583;50206.748966254934;50465.49534504608;50523.24215136776;50560;1034.7671773850823;1078.7680648660576;1117.608836907076;1175.3065691242036;1187.75057237981;26430;29230.7076929228;29416.26459338534;30275.243118922204;30359;42786.78606606947;43289.567104328555;43326.78336608297;43355.566444335156;43380.78309608558;328223;328424;329601;330076;330207;24897.50204995926;25569.872150639127;25905.481890362465;25916.48167036611;26005.869970650783;41788.373174403016;42536.59707223476;42727;42897.571024289355;43339.13321733611;34341.141471463416;35190.52815690767;36114.638853611126;36377.81811090928;37180.25639487141;36449.635503644626;36527.63472365242;36868.63131368759;36903;37257.62742372542;28113.71886281193;35030.824845876625;35254.471182932786;35949.46075808813;36872.44691329686;32283.677163229007;32902.83548582337;33278.334433311684;34229.48655770116;34436.31127377489;25615.669962904703;25960.610590840774;26039.869800651635;26179.476410472063;26233.4753304929 10:20:10 INFO - PROCESS | 29205 | |2;jquery.html;337.2748590530359;348.84302064071164;352.3094734320731;353.47156001777347;364.28963521133795;16089.195540222985;17348.913255433738;18097.819021809777;18191.181396837143;18238;16457.177141142954;17523.474295771146;17595.648087038284;17683.292668293285;17748.822511774877;5000.499950004998;5243.4232234454175;5250.474952504757;5251.028559716465;5252.65857719247;3842.289176502342;4030.919381612366;5193.584513238932;5925.525957923356;6167.136600875881;6235.937640623603;6236.532260080512;6244;6244.406781355787;6246.281677607088;5928.614640048383;6070.0591408331775;6106.633601983851;6115.388461153893;6118.8164355068975;5197.090509160882;5247.973760131213;5248.763805628756;5249;5253.894922101575;21756.78243217579;21760.673589896007;21862.781372186233;21891.890540547196;22174.223902163507;1865.0301843041677;1874.8406385457251;1890.4423195157462;2154.633712268918;2327.4995875886766;13319.200847949154;13611.659708507366;13639.522616708467;13739.450421983109;14182.43270269188;1720.4322573550699;1821.1895706410653;1844.5849683821034;1917.3414996028334;1943.4849764812195;45016.774916125534;63965.3603463964;64951.350486495474;72769;73265;10027.247956403298;10177.694669159937;10251.38491690501;10420.218483613759;10507.842382364272;14022.439102435788;14038.508652197124;14055.297235138201;14086.859131408759;14096.85903140976;7136.250693677193;7438.66526006331;7471.738489152854;7584.469087163846;7600.619969001638;7140.607266600283;7190.424766018706;7298.927010729931;7376.520526165782;7422.109346878409;4291.420658211164;4339.652827773771;4412.84555040572;4425.09285596452;4491.46102467706;1678.483576906379;1682.4111560953813;1800.3878681248439;1810.3301778342097;1831.5787368905226;749.7788152495027;843.1231519220065;881.0572687224736;894.4588523942921;907.4419232172166;16725.08012059324;17068.573285667957;17089.48731538056;17704.29182832698;18431.26274948987;839.6305625524872;863.8531449653574;918.4076270805426;927.2118699105706;934.9158575728081;9826.508674566243;10277.17782577392;10464.319819211727;10584.788304233873;10659;405110;406329;423419;424546;428062;81933;81990;82983;83417.16582834093;84700;908.7546362482093;909.3543584055262;914.1041779056429;919.2370332623906;921.1755478846261;15949.362025518849;16059.91970040189;16504.587385315463;16557.42049028278;16604.83395166081;40023.79214859148;40356.3946540808;40802.38796418116;40964.445688689666;43180;50857.491425085274;52277.7386113067;56182.1572676402;56714.14928776154;57980.4201957975;6540.724558711006;7616.23837616234;7878.645460954385;7879.803004924923;8011.078725946358;9704.466254356079;12183.878161218274;12238.571649992207;12418.627441176779;12702.30137342455;10453.895461045293;10616.256862019585;10735.087517561095;10833.566657333618;10925.289856159325;10267.58929642806;10994.835077473685;11087.168462365193;11358.808933002481;11608.187426880037;10280.383177009104;10581.89418105809;10600.204984626338;10605.575776969143;10608.151347892304;7903.170167132368;7932.405069619917;7936.166702496154;8132.349412046904;8132.67469301245;9831.360961537477;10062.446565438679;10079.34484258521;10319.329243599143;10617.362958222531 10:20:10 INFO - PROCESS | 29205 | |3;mootools.html;1360.2382665707205;1416.1998470863962;1448.6885319656271;1619.4412927539995;1655.9751603725938;7360.190379058306;7843.098043724966;7857.607119644016;7862.449628525991;7864.213578642133;6214.098955651428;7352.595607241599;7475.775726728193;7528.510646807954;7712.498687585303;2184.9453763655956;2217.9889100554474;2231.665250212465;2236.507968246983;2237.966430503536;2180.2805074325433;2190.302515550445;2204.614192516311;2208.6355751301016;2210.723659542557;2172.576347612216;2177.793109654588;2181.2801775414155;2183.290430610058;2229.554089182162;2115.291377388569;2116.65075262583;2121.6923546085886;2122.5754849030254;2124.9787502124937;2087.217293514932;2111.092230340953;2119.205298013245;2122.36329101269;2124.8087672109586;7777.144514103444;7796.103448103484;7832;7838.216178382173;7870.881936770953;4524.185646583614;4659.021605462857;4663.88340291492;4665.393498845162;4669.2062349400685;2811.2409649394754;2875.870585823643;2944.2197817578144;2949.218457108868;2956.231379841257;901.7430032440723;944.8015916657511;956.0344052507018;964.5273815830193;978.8042391521653;10258.948705256425;10317.638882639072;10320.329178603366;10326.793464130675;10336.948315258376;3909.4526766252748;4119;4200.201961627281;4298.161858437637;4302.720323178984;8819.382643214913;8832.470051796912;8833.955830220808;8841.071687472722;8844.292456603456;4595.241785105421;4615.5845973862515;4619.9769001155455;4624.237000894882;4630.21286381316;3366.5286859839644;4071.267171909085;4197.202531519001;4208.431861698693;4216.936745948813;3489.1102768793794;3533.9646603533633;3633.981830090833;3642.508261384732;3657.817109144585;1129.2321221569412;1165.2309475745967;1176.9117316201148;1177.4819079605118;1184.2302503372875;668.6222284409293;801.1347744435996;812.7358608452158;825.1047613339474;825.5624519004937;5104.591632669378;5187.818426355059;5205.869853253699;5249.317588713519;5362.705051222142;413.65666496808177;417.7785773540029;418.3703526193121;419.54898484129683;422.41917363625015;3490.5636795400574;3507.4563442666426;3523.1896663766966;3555.1112221944513;3651.123730304708;9185.862212066824;9683.225341972626;9687.467189304656;9699.854502182472;9717.9028209717;9586.185174260127;9606.903930960741;9607.327487075838;9620;9645.469499177612;6881.174259088842;7070.611116388545;7186.137663480311;7379.926200738031;7385.8153546161775;5226.294450249167;5330.493603107699;5370;5476.479734425223;5533.197686335378;8787.121287871161;8897.199252067345;8917.509536975529;8933.374663773473;8953.149450802164;8845.823083538164;9088.182063614306;9164.587593558172;9195.954020229856;9203;5822.097574875901;6558.639274839929;6818.897716534157;6965.895511567432;6967.686454109678;7271.127464704269;7299.379552738077;7364.77905662831;7366.263373662591;7485.251474852471;6556.803295901131;6647.235567909753;6756.966215168893;6761.560498567577;6819.897701534382;6016.669083200466;6122.112293717475;6165.229346331708;6605.9009114864275;6636;6107.4197951194565;6247.406496382836;6258.7809426671665;6258.812235632939;6259.718312675849;4453;4536.5236650151255;4651.465081515534;4687.695299805502;4721.575058244637;4393.428854248928;4538.387317712067;4581.839635612738;4670.696404733681;4726.031163611383 10:20:10 INFO - PROCESS | 29205 | |4;prototype.html;290.76883877317533;291.5277250853617;293.1688662641413;296.2608292310685;296.6588423313188;4880.804202970268;4888.582311129777;4889.951100488994;4893.094777466167;4922.827701030465;4833.661643684944;4839.516048395159;4842.927356089662;4844.249141383082;4846.7091974481555;3624.87312944047;3712.573054098773;3717.3680474319294;3722.7766334020043;3728.5712143103483;3675.8345874435713;3723.646253605903;3783.2433513297315;3807.3527500325013;3846.365349717293;3779.300829346566;3783.754055986366;3786.242751449707;3796.4495148203496;3798.734088613798;3537.9292414151832;3710.9257814843554;3775.7734535927793;3782.6973842092702;3789.886303410902;3225.2581906161713;3232.305054413289;3237.4010808000594;3239.1254361322312;3240.125166205135;4698.483166851644;4742.33607294979;4742.715437073752;4745.881352966169;4778.255936583157;4223.78881055949;4231.3976904204;4234.322508398673;4235.703500754948;4237.639800616951;4896.657233993622;5011.949880501184;5042.899142017139;5064.873378165576;5086;3536.2397084626928;3553.733469989761;3563.1626567756557;3563.1804684922354;3570;5330.333708286465;5333.5199832015305;5337.5996800239745;5352.545033672142;5368.489993450616;3569.321828852562;3650.79920604364;3675.5773086094905;3679.3193259247123;3684.115812205105;3720.2745464634136;3728.12389088564;3736.4021756518828;3738.4579236010627;3741.8129093545213;4249.30027988807;4255.510616279105;4263.381809637585;4266.637335826427;4279.358096285582;4960.925586116211;5064;5076.822311219164;5080.695158290514;5083.822066227664;1249.993750031244;1269.803180507023;1278.5333353326155;1281.3721276574597;1289.5293217975372;791.4064451661254;818.4802650316973;828.4780588229377;830.3938125168661;832.3757182113415;4323.2434323993175;4339.696221264481;4421.845235416745;4514.61625761814;4515.390422293014;5211.71335576547;5223.824639456092;5227.817026404057;5238.60710446718;5249.265102885599;4497.820087196541;4512.187806194916;4531.365608814768;4534.093181363741;4539.954600454019;2637.525245455798;2768.5708715149185;2779.040776252737;2790.897595449786;2796.3568379272883;4890.432522925422;4935.975320123448;4939.728314942713;4946.735154797888;4956.628252881048;5112.616553758483;5321.813736519203;5348.732563371816;5356.839294821161;5367.275417818544;4902.3872015998;4919.508049195052;4919.680220785637;4929.654924155275;4957.429895561984;5200.5059519345605;5208.895822083461;5238.633295669267;5243.973780131075;5266.315379000705;5017.874553136201;5137.407403704863;5168.328117344721;5168.405633352062;5178.844634660966;4885.731284779371;4900.407367605471;4914.189158788759;4916;4917.754112294442;3566.7503274770515;3574.6425357465087;3575.6245594212232;3598.262356216917;3605.963940360668;4967.875803104951;5263.131583288715;5265.789368425373;5266.419454467207;5267.57859371257;5046.59627229828;5047.343845300087;5050.595952323879;5080.872978175576;5081.745912704424;5059.645824792229;5067.391912970467;5120.670095106643;5124.616353584437;5147.768350424165;4910.533499317559;4977.776000079933;5029.44676085623;5046.116929537243;5056.342675452168;4924.261360795909;4989.201727723546;5108.66793658411;5129.256257842667;5146.408163061295;4988.927380613186;5019.648624596243;5051.722155281494;5062.544371006627;5064.34163558735 10:20:10 INFO - PROCESS | 29205 | |5;yui.html;598.9970050149749;650.2457149706339;657.8289644692378;702.9015937768713;703.6587255181238;11937.58218462354;12742.044346674013;12767.61697149086;12769.042321825877;12771.297578633183;12824.102312838106;12950.805737913939;12957;12971.156874803131;12987.350632468386;619.0621208868567;632.1876388840341;758.4501236603446;766.4634755671038;781.8319061401797;778.01581000035;781.0978320040363;783.1972228465811;783.4985609210081;783.6316931042401;816.3877092180865;816.824382757707;816.9991760093867;817.448222449847;817.7873752824249;645.3933302695498;660.9985871404825;815.6655771133807;816.2857499687773;816.4407380944043;481.02592250692277;481.4775968074643;584.374719050616;597.4354235247692;599.5802937943457;12171.93914030433;12183.695407614881;12192.207506512048;12194.81707774384;12262.570810021696;11999.880001199963;12192.878071219264;12240.755184896341;12449.128561000734;12724.109312348139;10344.5344959477;10534.315269507457;11436.313821170756;11547.826782598268;11634.709132271677;4106.650934670527;4128.380742888561;4151.6886233532605;4263.978680106579;4323.940634544525;53372.46627533714;54977.1753423699;55668.16497752537;55748;63738.68130659364;9951.751206219902;9967.40195588267;10161.339512931636;10344.22418318629;10540.262181647364;19775.208991640175;20458.590828183354;20493.692594611093;20610;20618.484537886372;6770.086038384854;7041.92958070423;7054.435645148375;7059;7094.822629434306;3636.5454318210222;3774.6791522720328;3775.320442320409;3815.389537673959;3845.5962123977138;2860.113364856901;2945.705429457037;2963.2147480917574;2974.3902499987453;2977.8064425812254;490.11778798163164;506.349341096689;514.8378260847821;519.3637793702759;525.2646295186769;403.31637873803624;421.47315855181023;537;543.5325619966825;559.9356074051454;6453.548251622341;6613.834654133589;7206.279372062857;7360.815979600446;7555.357794587521;398.40836358008335;420.5605142625963;469.85904228731243;604.9274087109575;624.7282432142033;3563.875264365735;3601.423772196436;3603.351396748558;3620.2216523447587;3657.3599620066384;55703;56134.71932640392;57291.71354143203;60795.696021520496;101964;80307;81937.59031204807;83399;85439;89778.55110724404;61534;75852.62073689706;77704.61147694226;78343.60828195937;78923;6806.591604503746;7193.5324203926575;7251.3133198937985;7372.96313518429;7414.666340014604;45038;45896.770516147204;45965.54034459613;45972.31041534313;46650.53349466598;40527;54885;54989.450105498436;55468;58648.120278195005;11251.099912007183;11252.156088293574;11442.485088170886;11568.305901645928;11597.6520704379;12780.61658150257;13133.868661313265;13197;13237.867621324049;13327.466901324226;12047.096467764777;12405.317707526172;12631.557895473981;13416;13428.261445620194;11347;11831.171817973003;11864.881351186377;12167.148299618942;12202.938985305016;11595.304281743123;11909.285442873455;11998.580049698568;12124.515019399125;13009.414576343897;9898.20814334837;10276.537555809857;10406.687799366031;10509.9474502627;10684.252102353072;10381.325213861075;10608.692180232212;10677;10705;10879.619213327496 10:20:10 INFO - PROCESS | 29205 | __end_tp_report 10:20:10 INFO - PROCESS | 29205 | __start_cc_report 10:20:10 INFO - PROCESS | 29205 | _x_x_mozilla_cycle_collect,982 10:20:10 INFO - PROCESS | 29205 | __end_cc_report 10:20:10 INFO - PROCESS | 29205 | __startTimestamp1469726410888__endTimestamp 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | ------- Summary: start ------- 10:20:10 INFO - PROCESS | 29205 | Number of tests: 6 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | [#0] dojo.html Cycles:165 Average:4759.02 Median:4878.41 stddev:494.23 (10.1%) stddev-sans-first:467.25 10:20:10 INFO - PROCESS | 29205 | Values: 2650.7 2663.2 2680.5 2701.3 2702.2 4604.3 4663.5 4803.4 4848.4 4878.4 4729.0 4730.1 4735.9 4830.5 4850.8 4359.9 4386.3 4413.0 4449.4 4488.2 4380.4 4521.4 4522.9 4559.1 4562.9 4466.9 4501.4 4519.6 4542.6 4560.5 4304.1 4336.0 4342.0 4371.1 4389.6 4326.6 4347.3 4390.7 4396.0 4476.1 4808.2 4808.9 4814.3 4826.0 4857.6 5154.2 5200.4 5211.9 5212.0 5212.5 4998.0 5046.3 5141.6 5143.4 5180.5 4795.1 4835.5 4875.7 4876.0 4883.0 5129.8 5339.3 5345.2 5346.6 5347.4 4970.2 5002.4 5071.2 5072.4 5125.7 5185.0 5218.3 5232.3 5236.8 5240.1 5096.2 5100.4 5101.9 5105.0 5106.2 4918.0 5032.4 5032.5 5033.2 5033.4 4327.0 4366.3 4370.5 4371.1 4371.4 3796.9 3842.1 3869.8 3876.5 3940.4 4469.3 4473.6 4476.6 4479.8 4522.9 5187.4 5190.4 5190.6 5192.2 5200.3 4324.6 4412.8 4458.5 4458.6 4525.9 4685.8 4689.9 4690.5 4691.3 4736.5 4867.7 4882.3 4883.0 4883.8 4927.2 4995.5 5096.0 5135.2 5139.9 5191.1 4807.6 4844.2 4845.9 4849.1 4875.3 5039.1 5047.3 5047.7 5054.2 5132.6 5034.0 5096.4 5128.5 5143.0 5149.2 5027.0 5036.3 5039.9 5042.2 5098.6 4971.0 4979.6 4979.8 4982.3 4982.7 4815.5 4869.5 4921.4 4927.4 5023.0 5065.8 5067.7 5073.1 5074.2 5130.6 4779.3 4925.8 4939.9 4955.2 4955.9 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | [#1] ext.html Cycles:180 Average:48193.97 Median:36246.23 stddev:92910.79 (256.3%) stddev-sans-first:93102.61 10:20:10 INFO - PROCESS | 29205 | Values: 563.6 586.0 589.2 589.9 591.2 26453.2 37926.4 39533.0 39588.4 42439.8 41095.8 41597.0 41626.8 41715.6 41719.4 7502.6 7726.9 7730.2 7732.8 7733.9 7687.8 7779.2 7785.4 7785.5 7788.3 7784.7 7822.3 7833.4 7834.3 7835.5 7682.9 7725.1 7746.1 7760.0 7770.0 7741.5 7748.9 7802.4 7805.5 7828.1 37974.0 38402.8 38420.2 38449.2 38450.8 2964.4 2973.2 2976.6 3074.3 3327.3 28888.7 29738.4 29970.3 30314.0 30339.5 3269.2 3285.8 3324.0 3333.7 3405.4 249040.0 249051.0 249570.0 249573.0 250725.0 28390.3 46990.0 47069.8 47080.5 47174.5 34229.1 34361.7 34455.5 34472.5 34485.3 13544.5 13615.8 13673.9 13693.7 13698.9 11379.8 11430.7 11481.8 11488.1 11504.9 7803.6 7834.5 7898.2 7948.0 7958.5 3078.0 3133.1 3141.5 3150.9 3160.6 822.2 880.7 881.1 946.2 993.6 28321.6 28578.9 28962.9 29050.4 29583.3 917.5 926.5 932.7 1000.5 1034.6 14883.3 15040.0 15192.7 15455.0 15552.1 441363.0 445259.0 446278.0 446400.0 446524.0 49471.0 50206.7 50465.5 50523.2 50560.0 1034.8 1078.8 1117.6 1175.3 1187.8 26430.0 29230.7 29416.3 30275.2 30359.0 42786.8 43289.6 43326.8 43355.6 43380.8 328223.0 328424.0 329601.0 330076.0 330207.0 24897.5 25569.9 25905.5 25916.5 26005.9 41788.4 42536.6 42727.0 42897.6 43339.1 34341.1 35190.5 36114.6 36377.8 37180.3 36449.6 36527.6 36868.6 36903.0 37257.6 28113.7 35030.8 35254.5 35949.5 36872.4 32283.7 32902.8 33278.3 34229.5 34436.3 25615.7 25960.6 26039.9 26179.5 26233.5 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | [#2] jquery.html Cycles:180 Average:25690.83 Median:222733.20 stddev:68848.94 (30.9%) stddev-sans-first:69015.76 10:20:10 INFO - PROCESS | 29205 | Values: 337.3 348.8 352.3 353.5 364.3 16089.2 17348.9 18097.8 18191.2 18238.0 16457.2 17523.5 17595.6 17683.3 17748.8 5000.5 5243.4 5250.5 5251.0 5252.7 3842.3 4030.9 5193.6 5925.5 6167.1 6235.9 6236.5 6244.0 6244.4 6246.3 5928.6 6070.1 6106.6 6115.4 6118.8 5197.1 5248.0 5248.8 5249.0 5253.9 21756.8 21760.7 21862.8 21891.9 22174.2 1865.0 1874.8 1890.4 2154.6 2327.5 13319.2 13611.7 13639.5 13739.5 14182.4 1720.4 1821.2 1844.6 1917.3 1943.5 45016.8 63965.4 64951.4 72769.0 73265.0 10027.2 10177.7 10251.4 10420.2 10507.8 14022.4 14038.5 14055.3 14086.9 14096.9 7136.3 7438.7 7471.7 7584.5 7600.6 7140.6 7190.4 7298.9 7376.5 7422.1 4291.4 4339.7 4412.8 4425.1 4491.5 1678.5 1682.4 1800.4 1810.3 1831.6 749.8 843.1 881.1 894.5 907.4 16725.1 17068.6 17089.5 17704.3 18431.3 839.6 863.9 918.4 927.2 934.9 9826.5 10277.2 10464.3 10584.8 10659.0 405110.0 406329.0 423419.0 424546.0 428062.0 81933.0 81990.0 82983.0 83417.2 84700.0 908.8 909.4 914.1 919.2 921.2 15949.4 16059.9 16504.6 16557.4 16604.8 40023.8 40356.4 40802.4 40964.4 43180.0 50857.5 52277.7 56182.2 56714.1 57980.4 6540.7 7616.2 7878.6 7879.8 8011.1 9704.5 12183.9 12238.6 12418.6 12702.3 10453.9 10616.3 10735.1 10833.6 10925.3 10267.6 10994.8 11087.2 11358.8 11608.2 10280.4 10581.9 10600.2 10605.6 10608.2 7903.2 7932.4 7936.2 8132.3 8132.7 9831.4 10062.4 10079.3 10319.3 10617.4 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | [#3] mootools.html Cycles:180 Average:5070.51 Median:5146.21 stddev:2850.76 (55.4%) stddev-sans-first:2845.12 10:20:10 INFO - PROCESS | 29205 | Values: 1360.2 1416.2 1448.7 1619.4 1656.0 7360.2 7843.1 7857.6 7862.4 7864.2 6214.1 7352.6 7475.8 7528.5 7712.5 2184.9 2218.0 2231.7 2236.5 2238.0 2180.3 2190.3 2204.6 2208.6 2210.7 2172.6 2177.8 2181.3 2183.3 2229.6 2115.3 2116.7 2121.7 2122.6 2125.0 2087.2 2111.1 2119.2 2122.4 2124.8 7777.1 7796.1 7832.0 7838.2 7870.9 4524.2 4659.0 4663.9 4665.4 4669.2 2811.2 2875.9 2944.2 2949.2 2956.2 901.7 944.8 956.0 964.5 978.8 10258.9 10317.6 10320.3 10326.8 10336.9 3909.5 4119.0 4200.2 4298.2 4302.7 8819.4 8832.5 8834.0 8841.1 8844.3 4595.2 4615.6 4620.0 4624.2 4630.2 3366.5 4071.3 4197.2 4208.4 4216.9 3489.1 3534.0 3634.0 3642.5 3657.8 1129.2 1165.2 1176.9 1177.5 1184.2 668.6 801.1 812.7 825.1 825.6 5104.6 5187.8 5205.9 5249.3 5362.7 413.7 417.8 418.4 419.5 422.4 3490.6 3507.5 3523.2 3555.1 3651.1 9185.9 9683.2 9687.5 9699.9 9717.9 9586.2 9606.9 9607.3 9620.0 9645.5 6881.2 7070.6 7186.1 7379.9 7385.8 5226.3 5330.5 5370.0 5476.5 5533.2 8787.1 8897.2 8917.5 8933.4 8953.1 8845.8 9088.2 9164.6 9196.0 9203.0 5822.1 6558.6 6818.9 6965.9 6967.7 7271.1 7299.4 7364.8 7366.3 7485.3 6556.8 6647.2 6757.0 6761.6 6819.9 6016.7 6122.1 6165.2 6605.9 6636.0 6107.4 6247.4 6258.8 6258.8 6259.7 4453.0 4536.5 4651.5 4687.7 4721.6 4393.4 4538.4 4581.8 4670.7 4726.0 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | [#4] prototype.html Cycles:180 Average:4204.29 Median:4883.27 stddev:1239.27 (25.4%) stddev-sans-first:1207.43 10:20:10 INFO - PROCESS | 29205 | Values: 290.8 291.5 293.2 296.3 296.7 4880.8 4888.6 4890.0 4893.1 4922.8 4833.7 4839.5 4842.9 4844.2 4846.7 3624.9 3712.6 3717.4 3722.8 3728.6 3675.8 3723.6 3783.2 3807.4 3846.4 3779.3 3783.8 3786.2 3796.4 3798.7 3537.9 3710.9 3775.8 3782.7 3789.9 3225.3 3232.3 3237.4 3239.1 3240.1 4698.5 4742.3 4742.7 4745.9 4778.3 4223.8 4231.4 4234.3 4235.7 4237.6 4896.7 5011.9 5042.9 5064.9 5086.0 3536.2 3553.7 3563.2 3563.2 3570.0 5330.3 5333.5 5337.6 5352.5 5368.5 3569.3 3650.8 3675.6 3679.3 3684.1 3720.3 3728.1 3736.4 3738.5 3741.8 4249.3 4255.5 4263.4 4266.6 4279.4 4960.9 5064.0 5076.8 5080.7 5083.8 1250.0 1269.8 1278.5 1281.4 1289.5 791.4 818.5 828.5 830.4 832.4 4323.2 4339.7 4421.8 4514.6 4515.4 5211.7 5223.8 5227.8 5238.6 5249.3 4497.8 4512.2 4531.4 4534.1 4540.0 2637.5 2768.6 2779.0 2790.9 2796.4 4890.4 4936.0 4939.7 4946.7 4956.6 5112.6 5321.8 5348.7 5356.8 5367.3 4902.4 4919.5 4919.7 4929.7 4957.4 5200.5 5208.9 5238.6 5244.0 5266.3 5017.9 5137.4 5168.3 5168.4 5178.8 4885.7 4900.4 4914.2 4916.0 4917.8 3566.8 3574.6 3575.6 3598.3 3606.0 4967.9 5263.1 5265.8 5266.4 5267.6 5046.6 5047.3 5050.6 5080.9 5081.7 5059.6 5067.4 5120.7 5124.6 5147.8 4910.5 4977.8 5029.4 5046.1 5056.3 4924.3 4989.2 5108.7 5129.3 5146.4 4988.9 5019.6 5051.7 5062.5 5064.3 10:20:10 INFO - PROCESS | 29205 | 10:20:10 INFO - PROCESS | 29205 | [#5] yui.html Cycles:180 Average:16560.55 Median:2342.73 stddev:22526.58 (961.6%) stddev-sans-first:22557.89 10:20:10 INFO - PROCESS | 29205 | Values: 599.0 650.2 657.8 702.9 703.7 11937.6 12742.0 12767.6 12769.0 12771.3 12824.1 12950.8 12957.0 12971.2 12987.4 619.1 632.2 758.5 766.5 781.8 778.0 781.1 783.2 783.5 783.6 816.4 816.8 817.0 817.4 817.8 645.4 661.0 815.7 816.3 816.4 481.0 481.5 584.4 597.4 599.6 12171.9 12183.7 12192.2 12194.8 12262.6 11999.9 12192.9 12240.8 12449.1 12724.1 10344.5 10534.3 11436.3 11547.8 11634.7 4106.7 4128.4 4151.7 4264.0 4323.9 53372.5 54977.2 55668.2 55748.0 63738.7 9951.8 9967.4 10161.3 10344.2 10540.3 19775.2 20458.6 20493.7 20610.0 20618.5 6770.1 7041.9 7054.4 7059.0 7094.8 3636.5 3774.7 3775.3 3815.4 3845.6 2860.1 2945.7 2963.2 2974.4 2977.8 490.1 506.3 514.8 519.4 525.3 403.3 421.5 537.0 543.5 559.9 6453.5 6613.8 7206.3 7360.8 7555.4 398.4 420.6 469.9 604.9 624.7 3563.9 3601.4 3603.4 3620.2 3657.4 55703.0 56134.7 57291.7 60795.7 101964.0 80307.0 81937.6 83399.0 85439.0 89778.6 61534.0 75852.6 77704.6 78343.6 78923.0 6806.6 7193.5 7251.3 7373.0 7414.7 45038.0 45896.8 45965.5 45972.3 46650.5 40527.0 54885.0 54989.5 55468.0 58648.1 11251.1 11252.2 11442.5 11568.3 11597.7 12780.6 13133.9 13197.0 13237.9 13327.5 12047.1 12405.3 12631.6 13416.0 13428.3 11347.0 11831.2 11864.9 12167.1 12202.9 11595.3 11909.3 11998.6 12124.5 13009.4 9898.2 10276.5 10406.7 10509.9 10684.3 10381.3 10608.7 10677.0 10705.0 10879.6 10:20:10 INFO - PROCESS | 29205 | -------- Summary: end -------- 10:20:10 INFO - PROCESS | 29205 | 10:20:11 INFO - TEST-INFO | 29205: exit 0 10:20:11 INFO - TEST-OK | dromaeo_css | took 1119804ms 10:20:11 INFO - TEST-START | kraken 10:20:11 INFO - operating with platform_type : linux_ 10:20:11 INFO - Initialising browser for kraken test... 10:20:11 INFO - TEST-INFO | started process 29398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0e_oAY/profile http://localhost:47175/getInfo.html) 10:20:15 INFO - PROCESS | 29398 | JavaScript error: , line 0: uncaught exception: undefined 10:20:16 INFO - PROCESS | 29398 | __metrics Screen width/height:1600/1200 10:20:16 INFO - PROCESS | 29398 | colorDepth:24 10:20:16 INFO - PROCESS | 29398 | Browser inner width/height: 1024/697 10:20:16 INFO - PROCESS | 29398 | __metrics 10:20:16 INFO - PROCESS | 29398 | 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" 10:20:16 INFO - PROCESS | 29398 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:17 INFO - TEST-INFO | 29398: exit 0 10:20:17 INFO - Browser initialized. 10:20:17 INFO - Running cycle 1/1 for kraken test... 10:20:17 INFO - TEST-INFO | started process 29480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0e_oAY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:29 INFO - PROCESS | 29480 | RSS: Main: 159485952 10:20:29 INFO - PROCESS | 29480 | 10:20:32 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47175/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:33 INFO - PROCESS | 29480 | RSS: Main: 215973888 10:20:33 INFO - PROCESS | 29480 | 10:20:36 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47175/tests/kraken/driver.html?testName=audio-dft) 10:20:36 INFO - PROCESS | 29480 | RSS: Main: 193564672 10:20:36 INFO - PROCESS | 29480 | 10:20:40 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47175/tests/kraken/driver.html?testName=audio-fft) 10:20:40 INFO - PROCESS | 29480 | RSS: Main: 271630336 10:20:40 INFO - PROCESS | 29480 | 10:20:42 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47175/tests/kraken/driver.html?testName=audio-oscillator) 10:20:43 INFO - PROCESS | 29480 | RSS: Main: 181678080 10:20:43 INFO - PROCESS | 29480 | 10:20:45 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47175/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:46 INFO - PROCESS | 29480 | RSS: Main: 186675200 10:20:46 INFO - PROCESS | 29480 | 10:20:49 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47175/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:50 INFO - PROCESS | 29480 | RSS: Main: 222670848 10:20:50 INFO - PROCESS | 29480 | 10:20:53 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47175/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:54 INFO - PROCESS | 29480 | RSS: Main: 222228480 10:20:54 INFO - PROCESS | 29480 | 10:20:57 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47175/tests/kraken/driver.html?testName=json-parse-financial) 10:20:57 INFO - PROCESS | 29480 | RSS: Main: 222552064 10:20:57 INFO - PROCESS | 29480 | 10:20:59 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47175/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:00 INFO - PROCESS | 29480 | RSS: Main: 187183104 10:21:00 INFO - PROCESS | 29480 | 10:21:01 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:02 INFO - PROCESS | 29480 | RSS: Main: 193789952 10:21:02 INFO - PROCESS | 29480 | 10:21:04 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:05 INFO - PROCESS | 29480 | RSS: Main: 197472256 10:21:05 INFO - PROCESS | 29480 | 10:21:08 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:08 INFO - PROCESS | 29480 | RSS: Main: 190705664 10:21:08 INFO - PROCESS | 29480 | 10:21:11 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:12 INFO - PROCESS | 29480 | RSS: Main: 195059712 10:21:12 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | Cycle 1(1): loaded http://localhost:47175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47175/tests/kraken/driver.html?testName=ai-astar) 10:21:14 INFO - PROCESS | 29480 | RSS: Main: 245284864 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | __start_tp_report 10:21:14 INFO - PROCESS | 29480 | _x_x_mozilla_page_load 10:21:14 INFO - PROCESS | 29480 | _x_x_mozilla_page_load_details 10:21:14 INFO - PROCESS | 29480 | |i|pagename|runs| 10:21:14 INFO - PROCESS | 29480 | |0;ai-astar;104;114;114;112;114;115;113;114;114;113 10:21:14 INFO - PROCESS | 29480 | |1;audio-beat-detection;148;121;123;204;127;125;145;121;167;123 10:21:14 INFO - PROCESS | 29480 | |2;audio-dft;162;162;161;162;160;163;162;161;160;161 10:21:14 INFO - PROCESS | 29480 | |3;audio-fft;76;76;76;118;77;77;74;75;100;75 10:21:14 INFO - PROCESS | 29480 | |4;audio-oscillator;86;85;113;85;87;84;122;85;85;130 10:21:14 INFO - PROCESS | 29480 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;118;117;117 10:21:14 INFO - PROCESS | 29480 | |6;imaging-darkroom;146;149;146;147;146;146;146;146;146;146 10:21:14 INFO - PROCESS | 29480 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;94;95 10:21:14 INFO - PROCESS | 29480 | |8;json-parse-financial;61;61;61;62;61;63;62;62;61;60 10:21:14 INFO - PROCESS | 29480 | |9;json-stringify-tinderbox;66;67;66;66;66;66;66;66;66;66 10:21:14 INFO - PROCESS | 29480 | |10;stanford-crypto-aes;79;80;80;86;79;89;83;85;79;83 10:21:14 INFO - PROCESS | 29480 | |11;stanford-crypto-ccm;140;131;128;129;138;130;142;135;210;133 10:21:14 INFO - PROCESS | 29480 | |12;stanford-crypto-pbkdf2;169;165;166;175;170;164;168;164;164;166 10:21:14 INFO - PROCESS | 29480 | |13;stanford-crypto-sha256-iterative;67;68;67;66;67;67;67;65;66;66 10:21:14 INFO - PROCESS | 29480 | __end_tp_report 10:21:14 INFO - PROCESS | 29480 | __start_cc_report 10:21:14 INFO - PROCESS | 29480 | _x_x_mozilla_cycle_collect,1956 10:21:14 INFO - PROCESS | 29480 | __end_cc_report 10:21:14 INFO - PROCESS | 29480 | __startTimestamp1469726474300__endTimestamp 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | ------- Summary: start ------- 10:21:14 INFO - PROCESS | 29480 | Number of tests: 14 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:0.87 10:21:14 INFO - PROCESS | 29480 | Values: 104.0 114.0 114.0 112.0 114.0 115.0 113.0 114.0 114.0 113.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:136.00 stddev:27.09 (19.9%) stddev-sans-first:28.60 10:21:14 INFO - PROCESS | 29480 | Values: 148.0 121.0 123.0 204.0 127.0 125.0 145.0 121.0 167.0 123.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 10:21:14 INFO - PROCESS | 29480 | Values: 162.0 162.0 161.0 162.0 160.0 163.0 162.0 161.0 160.0 161.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.68 (19.3%) stddev-sans-first:15.38 10:21:14 INFO - PROCESS | 29480 | Values: 76.0 76.0 76.0 118.0 77.0 77.0 74.0 75.0 100.0 75.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.04 (21.2%) stddev-sans-first:18.75 10:21:14 INFO - PROCESS | 29480 | Values: 86.0 85.0 113.0 85.0 87.0 84.0 122.0 85.0 85.0 130.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 10:21:14 INFO - PROCESS | 29480 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 10:21:14 INFO - PROCESS | 29480 | Values: 146.0 149.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:21:14 INFO - PROCESS | 29480 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 10:21:14 INFO - PROCESS | 29480 | Values: 61.0 61.0 61.0 62.0 61.0 63.0 62.0 62.0 61.0 60.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:21:14 INFO - PROCESS | 29480 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:3.50 (4.2%) stddev-sans-first:3.50 10:21:14 INFO - PROCESS | 29480 | Values: 79.0 80.0 80.0 86.0 79.0 89.0 83.0 85.0 79.0 83.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:136.50 stddev:24.50 (17.9%) stddev-sans-first:25.98 10:21:14 INFO - PROCESS | 29480 | Values: 140.0 131.0 128.0 129.0 138.0 130.0 142.0 135.0 210.0 133.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.00 stddev:3.51 (2.1%) stddev-sans-first:3.66 10:21:14 INFO - PROCESS | 29480 | Values: 169.0 165.0 166.0 175.0 170.0 164.0 168.0 164.0 164.0 166.0 10:21:14 INFO - PROCESS | 29480 | 10:21:14 INFO - PROCESS | 29480 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 10:21:14 INFO - PROCESS | 29480 | Values: 67.0 68.0 67.0 66.0 67.0 67.0 67.0 65.0 66.0 66.0 10:21:14 INFO - PROCESS | 29480 | -------- Summary: end -------- 10:21:14 INFO - PROCESS | 29480 | 10:21:15 INFO - TEST-INFO | 29480: exit 0 10:21:15 INFO - TEST-OK | kraken | took 63679ms 10:21:15 INFO - SUITE-END | took 1183s 10:21:15 INFO - Completed test suite (00:19:43) 10:21:15 INFO - javascript benchmark 10:21:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.6686664166978, 2663.1611042521617, 2680.5309070912585, 2701.257154282572, 2702.2163572563945, 4604.263317869133, 4663.463701674308, 4803.423589169301, 4848.393950756155, 4878.414590249166, 4729.0, 4730.101280756654, 4735.905281894368, 4830.541098595628, 4850.830220942268, 4359.934600980988, 4386.34204869269, 4412.955870441303, 4449.421575195228, 4488.214562451574, 4380.408644832939, 4521.412216411862, 4522.886927826798, 4559.065391594715, 4562.931556026662, 4466.932996005063, 4501.369808226851, 4519.570640789137, 4542.6138778203895, 4560.475545312298, 4304.096139810644, 4335.978320108411, 4342.0, 4371.082072764723, 4389.582989615981, 4326.5673432656795, 4347.2826983547675, 4390.736555806662, 4395.956040439587, 4476.1271552047365, 4808.230683090724, 4808.927866082012, 4814.301926220678, 4825.975870120662, 4857.587105096036, 5154.175331946871, 5200.427952925213, 5211.921821172686, 5211.973940130313, 5212.452692467275, 4997.975010124963, 5046.293518907356, 5141.640085194038, 5143.382794064699, 5180.456052114511, 4795.088933102734, 4835.540623640819, 4875.7074575525585, 4875.975620121877, 4883.02339532095, 5129.769160387791, 5339.252504649352, 5345.1714984177515, 5346.625736198506, 5347.385050719139, 4970.229614409773, 5002.424721157114, 5071.163258062452, 5072.416672082684, 5125.718085505258, 5184.974075129676, 5218.321618189687, 5232.293640358579, 5236.842894713165, 5240.135377662643, 5096.159133742891, 5100.362454693163, 5101.897962040813, 5104.9744751276, 5106.157484015096, 4918.040982008474, 5032.421271553745, 5032.521910418504, 5033.245013247969, 5033.446320904697, 4326.978365108217, 4366.3013917773005, 4370.475542934868, 4371.0602220522105, 4371.388005679208, 3796.9430458543143, 3842.1355195080882, 3869.806509674505, 3876.5154355705536, 3940.4286378474962, 4469.307257375112, 4473.5526447355005, 4476.6418686505, 4479.843205487792, 4522.886927826765, 5187.351581052369, 5190.377154741455, 5190.6366554341585, 5192.169252919514, 5200.323957885451, 4324.567543245713, 4412.845550405785, 4458.509563947963, 4458.576435238647, 4525.886852828706, 4685.789139488731, 4689.929651055237, 4690.460597031317, 4691.319758634979, 4736.502667219892, 4867.683600565952, 4882.316475693335, 4883.047805677858, 4883.755812209304, 4927.187014142626, 4995.450500445021, 5095.974520127375, 5135.178371460548, 5139.948600513947, 5191.117510023229, 4807.6394270429155, 4844.2007068833245, 4845.903081938412, 4849.078675051729, 4875.293082503088, 5039.0929632665, 5047.293378927026, 5047.747612619428, 5054.241863720471, 5132.640715149903, 5034.0, 5096.43939166684, 5128.512791284822, 5143.022825663112, 5149.2276158576515, 5027.044861476308, 5036.320096787033, 5039.949600503948, 5042.193249080129, 5098.592112631055, 4970.975145124251, 4979.601631869369, 4979.751012449436, 4982.277569752293, 4982.701037937735, 4815.542523460265, 4869.537393947569, 4921.360223170965, 4927.384076990376, 5023.045621332081, 5065.848024559269, 5067.746612669278, 5073.137566613611, 5074.188129899346, 5130.589552835839, 4779.30700048498, 4925.827596034122, 4939.925901111558, 4955.231939049453, 4955.876103097307], "value": 4727.596635016503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5998441106814, 585.9560532960027, 589.1604463639313, 589.9380565040673, 591.2313991810645, 26453.206403807868, 37926.43110353347, 39533.0, 39588.40617390742, 42439.78780106103, 41095.794521027354, 41597.0, 41626.79186604063, 41715.58284417155, 41719.374209386806, 7502.624868756554, 7726.884096738553, 7730.226977302253, 7732.806679832993, 7733.922660773376, 7687.807804804868, 7779.183185765498, 7785.3771698264, 7785.493942893722, 7788.337991270749, 7784.688612455495, 7822.335101516378, 7833.41249406294, 7834.2949134577875, 7835.451518393715, 7682.884756728654, 7725.072991241059, 7746.10919744231, 7760.029996250469, 7769.999999999972, 7741.458097933147, 7748.883766743504, 7802.375809935192, 7805.4536182467255, 7828.138904720477, 37974.0, 38402.80798596017, 38420.157984201636, 38449.23101537953, 38450.84647460581, 2964.392299578581, 2973.2120987938215, 2976.55351697245, 3074.2775447769754, 3327.2513684421056, 28888.711112888814, 29738.40523189524, 29970.25074373136, 30314.0, 30339.544906826417, 3269.1500209945348, 3285.78642388244, 3324.0, 3333.7333013358875, 3405.404054290489, 249040.0, 249051.0, 249570.0, 249573.0, 250725.0, 28390.290242743682, 46990.0, 47069.76465117653, 47080.5291947083, 47174.5282547177, 34229.144271392914, 34361.656383435846, 34455.48316775251, 34472.482912755826, 34485.310293793984, 13544.525941591997, 13615.795763063563, 13673.931630341785, 13693.726125477633, 13698.931505342609, 11379.829302560469, 11430.657080287605, 11481.770364592661, 11488.080953523699, 11504.94247528757, 7803.648835802289, 7834.529928204326, 7898.210178982055, 7947.966764320717, 7958.522488650699, 3077.9538306925415, 3133.1383869436086, 3141.4659507883716, 3150.9054728358187, 3160.5891234139413, 822.2312138150849, 880.6741505642954, 881.074871385056, 946.2430055955208, 993.64228877604, 28321.57517637237, 28578.857105714338, 28962.855185723936, 29050.41899162005, 29583.26041848971, 917.4586993673764, 926.5321012888448, 932.7108596335158, 1000.5347513406301, 1034.6016783538391, 14883.255837208097, 15040.0, 15192.696146077238, 15455.0, 15552.14463204512, 441363.0, 445259.0, 446278.0, 446400.0, 446524.0, 49471.03173809583, 50206.748966254934, 50465.49534504608, 50523.24215136776, 50560.0, 1034.7671773850823, 1078.7680648660576, 1117.608836907076, 1175.3065691242036, 1187.75057237981, 26430.0, 29230.7076929228, 29416.26459338534, 30275.243118922204, 30359.0, 42786.78606606947, 43289.567104328555, 43326.78336608297, 43355.566444335156, 43380.78309608558, 328223.0, 328424.0, 329601.0, 330076.0, 330207.0, 24897.50204995926, 25569.872150639127, 25905.481890362465, 25916.48167036611, 26005.869970650783, 41788.373174403016, 42536.59707223476, 42727.0, 42897.571024289355, 43339.13321733611, 34341.141471463416, 35190.52815690767, 36114.638853611126, 36377.81811090928, 37180.25639487141, 36449.635503644626, 36527.63472365242, 36868.63131368759, 36903.0, 37257.62742372542, 28113.71886281193, 35030.824845876625, 35254.471182932786, 35949.46075808813, 36872.44691329686, 32283.677163229007, 32902.83548582337, 33278.334433311684, 34229.48655770116, 34436.31127377489, 25615.669962904703, 25960.610590840774, 26039.869800651635, 26179.476410472063, 26233.4753304929], "value": 16535.896915393256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.2748590530359, 348.84302064071164, 352.3094734320731, 353.47156001777347, 364.28963521133795, 16089.195540222985, 17348.913255433738, 18097.819021809777, 18191.181396837143, 18238.0, 16457.177141142954, 17523.474295771146, 17595.648087038284, 17683.292668293285, 17748.822511774877, 5000.499950004998, 5243.4232234454175, 5250.474952504757, 5251.028559716465, 5252.65857719247, 3842.289176502342, 4030.919381612366, 5193.584513238932, 5925.525957923356, 6167.136600875881, 6235.937640623603, 6236.532260080512, 6244.0, 6244.406781355787, 6246.281677607088, 5928.614640048383, 6070.0591408331775, 6106.633601983851, 6115.388461153893, 6118.8164355068975, 5197.090509160882, 5247.973760131213, 5248.763805628756, 5249.0, 5253.894922101575, 21756.78243217579, 21760.673589896007, 21862.781372186233, 21891.890540547196, 22174.223902163507, 1865.0301843041677, 1874.8406385457251, 1890.4423195157462, 2154.633712268918, 2327.4995875886766, 13319.200847949154, 13611.659708507366, 13639.522616708467, 13739.450421983109, 14182.43270269188, 1720.4322573550699, 1821.1895706410653, 1844.5849683821034, 1917.3414996028334, 1943.4849764812195, 45016.774916125534, 63965.3603463964, 64951.350486495474, 72769.0, 73265.0, 10027.247956403298, 10177.694669159937, 10251.38491690501, 10420.218483613759, 10507.842382364272, 14022.439102435788, 14038.508652197124, 14055.297235138201, 14086.859131408759, 14096.85903140976, 7136.250693677193, 7438.66526006331, 7471.738489152854, 7584.469087163846, 7600.619969001638, 7140.607266600283, 7190.424766018706, 7298.927010729931, 7376.520526165782, 7422.109346878409, 4291.420658211164, 4339.652827773771, 4412.84555040572, 4425.09285596452, 4491.46102467706, 1678.483576906379, 1682.4111560953813, 1800.3878681248439, 1810.3301778342097, 1831.5787368905226, 749.7788152495027, 843.1231519220065, 881.0572687224736, 894.4588523942921, 907.4419232172166, 16725.08012059324, 17068.573285667957, 17089.48731538056, 17704.29182832698, 18431.26274948987, 839.6305625524872, 863.8531449653574, 918.4076270805426, 927.2118699105706, 934.9158575728081, 9826.508674566243, 10277.17782577392, 10464.319819211727, 10584.788304233873, 10659.0, 405110.0, 406329.0, 423419.0, 424546.0, 428062.0, 81933.0, 81990.0, 82983.0, 83417.16582834093, 84700.0, 908.7546362482093, 909.3543584055262, 914.1041779056429, 919.2370332623906, 921.1755478846261, 15949.362025518849, 16059.91970040189, 16504.587385315463, 16557.42049028278, 16604.83395166081, 40023.79214859148, 40356.3946540808, 40802.38796418116, 40964.445688689666, 43180.0, 50857.491425085274, 52277.7386113067, 56182.1572676402, 56714.14928776154, 57980.4201957975, 6540.724558711006, 7616.23837616234, 7878.645460954385, 7879.803004924923, 8011.078725946358, 9704.466254356079, 12183.878161218274, 12238.571649992207, 12418.627441176779, 12702.30137342455, 10453.895461045293, 10616.256862019585, 10735.087517561095, 10833.566657333618, 10925.289856159325, 10267.58929642806, 10994.835077473685, 11087.168462365193, 11358.808933002481, 11608.187426880037, 10280.383177009104, 10581.89418105809, 10600.204984626338, 10605.575776969143, 10608.151347892304, 7903.170167132368, 7932.405069619917, 7936.166702496154, 8132.349412046904, 8132.67469301245, 9831.360961537477, 10062.446565438679, 10079.34484258521, 10319.329243599143, 10617.362958222531], "value": 8553.30203977394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.2382665707205, 1416.1998470863962, 1448.6885319656271, 1619.4412927539995, 1655.9751603725938, 7360.190379058306, 7843.098043724966, 7857.607119644016, 7862.449628525991, 7864.213578642133, 6214.098955651428, 7352.595607241599, 7475.775726728193, 7528.510646807954, 7712.498687585303, 2184.9453763655956, 2217.9889100554474, 2231.665250212465, 2236.507968246983, 2237.966430503536, 2180.2805074325433, 2190.302515550445, 2204.614192516311, 2208.6355751301016, 2210.723659542557, 2172.576347612216, 2177.793109654588, 2181.2801775414155, 2183.290430610058, 2229.554089182162, 2115.291377388569, 2116.65075262583, 2121.6923546085886, 2122.5754849030254, 2124.9787502124937, 2087.217293514932, 2111.092230340953, 2119.205298013245, 2122.36329101269, 2124.8087672109586, 7777.144514103444, 7796.103448103484, 7832.0, 7838.216178382173, 7870.881936770953, 4524.185646583614, 4659.021605462857, 4663.88340291492, 4665.393498845162, 4669.2062349400685, 2811.2409649394754, 2875.870585823643, 2944.2197817578144, 2949.218457108868, 2956.231379841257, 901.7430032440723, 944.8015916657511, 956.0344052507018, 964.5273815830193, 978.8042391521653, 10258.948705256425, 10317.638882639072, 10320.329178603366, 10326.793464130675, 10336.948315258376, 3909.4526766252748, 4119.0, 4200.201961627281, 4298.161858437637, 4302.720323178984, 8819.382643214913, 8832.470051796912, 8833.955830220808, 8841.071687472722, 8844.292456603456, 4595.241785105421, 4615.5845973862515, 4619.9769001155455, 4624.237000894882, 4630.21286381316, 3366.5286859839644, 4071.267171909085, 4197.202531519001, 4208.431861698693, 4216.936745948813, 3489.1102768793794, 3533.9646603533633, 3633.981830090833, 3642.508261384732, 3657.817109144585, 1129.2321221569412, 1165.2309475745967, 1176.9117316201148, 1177.4819079605118, 1184.2302503372875, 668.6222284409293, 801.1347744435996, 812.7358608452158, 825.1047613339474, 825.5624519004937, 5104.591632669378, 5187.818426355059, 5205.869853253699, 5249.317588713519, 5362.705051222142, 413.65666496808177, 417.7785773540029, 418.3703526193121, 419.54898484129683, 422.41917363625015, 3490.5636795400574, 3507.4563442666426, 3523.1896663766966, 3555.1112221944513, 3651.123730304708, 9185.862212066824, 9683.225341972626, 9687.467189304656, 9699.854502182472, 9717.9028209717, 9586.185174260127, 9606.903930960741, 9607.327487075838, 9620.0, 9645.469499177612, 6881.174259088842, 7070.611116388545, 7186.137663480311, 7379.926200738031, 7385.8153546161775, 5226.294450249167, 5330.493603107699, 5370.0, 5476.479734425223, 5533.197686335378, 8787.121287871161, 8897.199252067345, 8917.509536975529, 8933.374663773473, 8953.149450802164, 8845.823083538164, 9088.182063614306, 9164.587593558172, 9195.954020229856, 9203.0, 5822.097574875901, 6558.639274839929, 6818.897716534157, 6965.895511567432, 6967.686454109678, 7271.127464704269, 7299.379552738077, 7364.77905662831, 7366.263373662591, 7485.251474852471, 6556.803295901131, 6647.235567909753, 6756.966215168893, 6761.560498567577, 6819.897701534382, 6016.669083200466, 6122.112293717475, 6165.229346331708, 6605.9009114864275, 6636.0, 6107.4197951194565, 6247.406496382836, 6258.7809426671665, 6258.812235632939, 6259.718312675849, 4453.0, 4536.5236650151255, 4651.465081515534, 4687.695299805502, 4721.575058244637, 4393.428854248928, 4538.387317712067, 4581.839635612738, 4670.696404733681, 4726.031163611383], "value": 4021.391052500536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.76883877317533, 291.5277250853617, 293.1688662641413, 296.2608292310685, 296.6588423313188, 4880.804202970268, 4888.582311129777, 4889.951100488994, 4893.094777466167, 4922.827701030465, 4833.661643684944, 4839.516048395159, 4842.927356089662, 4844.249141383082, 4846.7091974481555, 3624.87312944047, 3712.573054098773, 3717.3680474319294, 3722.7766334020043, 3728.5712143103483, 3675.8345874435713, 3723.646253605903, 3783.2433513297315, 3807.3527500325013, 3846.365349717293, 3779.300829346566, 3783.754055986366, 3786.242751449707, 3796.4495148203496, 3798.734088613798, 3537.9292414151832, 3710.9257814843554, 3775.7734535927793, 3782.6973842092702, 3789.886303410902, 3225.2581906161713, 3232.305054413289, 3237.4010808000594, 3239.1254361322312, 3240.125166205135, 4698.483166851644, 4742.33607294979, 4742.715437073752, 4745.881352966169, 4778.255936583157, 4223.78881055949, 4231.3976904204, 4234.322508398673, 4235.703500754948, 4237.639800616951, 4896.657233993622, 5011.949880501184, 5042.899142017139, 5064.873378165576, 5086.0, 3536.2397084626928, 3553.733469989761, 3563.1626567756557, 3563.1804684922354, 3570.0, 5330.333708286465, 5333.5199832015305, 5337.5996800239745, 5352.545033672142, 5368.489993450616, 3569.321828852562, 3650.79920604364, 3675.5773086094905, 3679.3193259247123, 3684.115812205105, 3720.2745464634136, 3728.12389088564, 3736.4021756518828, 3738.4579236010627, 3741.8129093545213, 4249.30027988807, 4255.510616279105, 4263.381809637585, 4266.637335826427, 4279.358096285582, 4960.925586116211, 5064.0, 5076.822311219164, 5080.695158290514, 5083.822066227664, 1249.993750031244, 1269.803180507023, 1278.5333353326155, 1281.3721276574597, 1289.5293217975372, 791.4064451661254, 818.4802650316973, 828.4780588229377, 830.3938125168661, 832.3757182113415, 4323.2434323993175, 4339.696221264481, 4421.845235416745, 4514.61625761814, 4515.390422293014, 5211.71335576547, 5223.824639456092, 5227.817026404057, 5238.60710446718, 5249.265102885599, 4497.820087196541, 4512.187806194916, 4531.365608814768, 4534.093181363741, 4539.954600454019, 2637.525245455798, 2768.5708715149185, 2779.040776252737, 2790.897595449786, 2796.3568379272883, 4890.432522925422, 4935.975320123448, 4939.728314942713, 4946.735154797888, 4956.628252881048, 5112.616553758483, 5321.813736519203, 5348.732563371816, 5356.839294821161, 5367.275417818544, 4902.3872015998, 4919.508049195052, 4919.680220785637, 4929.654924155275, 4957.429895561984, 5200.5059519345605, 5208.895822083461, 5238.633295669267, 5243.973780131075, 5266.315379000705, 5017.874553136201, 5137.407403704863, 5168.328117344721, 5168.405633352062, 5178.844634660966, 4885.731284779371, 4900.407367605471, 4914.189158788759, 4916.0, 4917.754112294442, 3566.7503274770515, 3574.6425357465087, 3575.6245594212232, 3598.262356216917, 3605.963940360668, 4967.875803104951, 5263.131583288715, 5265.789368425373, 5266.419454467207, 5267.57859371257, 5046.59627229828, 5047.343845300087, 5050.595952323879, 5080.872978175576, 5081.745912704424, 5059.645824792229, 5067.391912970467, 5120.670095106643, 5124.616353584437, 5147.768350424165, 4910.533499317559, 4977.776000079933, 5029.44676085623, 5046.116929537243, 5056.342675452168, 4924.261360795909, 4989.201727723546, 5108.66793658411, 5129.256257842667, 5146.408163061295, 4988.927380613186, 5019.648624596243, 5051.722155281494, 5062.544371006627, 5064.34163558735], "value": 3805.525040628814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.9970050149749, 650.2457149706339, 657.8289644692378, 702.9015937768713, 703.6587255181238, 11937.58218462354, 12742.044346674013, 12767.61697149086, 12769.042321825877, 12771.297578633183, 12824.102312838106, 12950.805737913939, 12957.0, 12971.156874803131, 12987.350632468386, 619.0621208868567, 632.1876388840341, 758.4501236603446, 766.4634755671038, 781.8319061401797, 778.01581000035, 781.0978320040363, 783.1972228465811, 783.4985609210081, 783.6316931042401, 816.3877092180865, 816.824382757707, 816.9991760093867, 817.448222449847, 817.7873752824249, 645.3933302695498, 660.9985871404825, 815.6655771133807, 816.2857499687773, 816.4407380944043, 481.02592250692277, 481.4775968074643, 584.374719050616, 597.4354235247692, 599.5802937943457, 12171.93914030433, 12183.695407614881, 12192.207506512048, 12194.81707774384, 12262.570810021696, 11999.880001199963, 12192.878071219264, 12240.755184896341, 12449.128561000734, 12724.109312348139, 10344.5344959477, 10534.315269507457, 11436.313821170756, 11547.826782598268, 11634.709132271677, 4106.650934670527, 4128.380742888561, 4151.6886233532605, 4263.978680106579, 4323.940634544525, 53372.46627533714, 54977.1753423699, 55668.16497752537, 55748.0, 63738.68130659364, 9951.751206219902, 9967.40195588267, 10161.339512931636, 10344.22418318629, 10540.262181647364, 19775.208991640175, 20458.590828183354, 20493.692594611093, 20610.0, 20618.484537886372, 6770.086038384854, 7041.92958070423, 7054.435645148375, 7059.0, 7094.822629434306, 3636.5454318210222, 3774.6791522720328, 3775.320442320409, 3815.389537673959, 3845.5962123977138, 2860.113364856901, 2945.705429457037, 2963.2147480917574, 2974.3902499987453, 2977.8064425812254, 490.11778798163164, 506.349341096689, 514.8378260847821, 519.3637793702759, 525.2646295186769, 403.31637873803624, 421.47315855181023, 537.0, 543.5325619966825, 559.9356074051454, 6453.548251622341, 6613.834654133589, 7206.279372062857, 7360.815979600446, 7555.357794587521, 398.40836358008335, 420.5605142625963, 469.85904228731243, 604.9274087109575, 624.7282432142033, 3563.875264365735, 3601.423772196436, 3603.351396748558, 3620.2216523447587, 3657.3599620066384, 55703.0, 56134.71932640392, 57291.71354143203, 60795.696021520496, 101964.0, 80307.0, 81937.59031204807, 83399.0, 85439.0, 89778.55110724404, 61534.0, 75852.62073689706, 77704.61147694226, 78343.60828195937, 78923.0, 6806.591604503746, 7193.5324203926575, 7251.3133198937985, 7372.96313518429, 7414.666340014604, 45038.0, 45896.770516147204, 45965.54034459613, 45972.31041534313, 46650.53349466598, 40527.0, 54885.0, 54989.450105498436, 55468.0, 58648.120278195005, 11251.099912007183, 11252.156088293574, 11442.485088170886, 11568.305901645928, 11597.6520704379, 12780.61658150257, 13133.868661313265, 13197.0, 13237.867621324049, 13327.466901324226, 12047.096467764777, 12405.317707526172, 12631.557895473981, 13416.0, 13428.261445620194, 11347.0, 11831.171817973003, 11864.881351186377, 12167.148299618942, 12202.938985305016, 11595.304281743123, 11909.285442873455, 11998.580049698568, 12124.515019399125, 13009.414576343897, 9898.20814334837, 10276.537555809857, 10406.687799366031, 10509.9474502627, 10684.252102353072, 10381.325213861075, 10608.692180232212, 10677.0, 10705.0, 10879.619213327496], "value": 6379.86098924527, "unit": "score"}], "name": "dromaeo_css", "value": 6345.6398673983795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 112.0, 114.0, 115.0, 113.0, 114.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 123.0, 204.0, 127.0, 125.0, 145.0, 121.0, 167.0, 123.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 160.0, 163.0, 162.0, 161.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 118.0, 77.0, 77.0, 74.0, 75.0, 100.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 113.0, 85.0, 87.0, 84.0, 122.0, 85.0, 85.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 60.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 86.0, 79.0, 89.0, 83.0, 85.0, 79.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 128.0, 129.0, 138.0, 130.0, 142.0, 135.0, 210.0, 133.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 166.0, 175.0, 170.0, 164.0, 168.0, 164.0, 164.0, 166.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1536.5999999999997, "alertThreshold": 2.0}]} 10:21:15 INFO - Return code: 0 10:21:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:15 INFO - # TBPL SUCCESS # 10:21:15 INFO - Running post-action listener: _resource_record_post_action 10:21:15 INFO - [mozharness: 2016-07-28 17:21:15.583737Z] Finished run-tests step (success) 10:21:15 INFO - Running post-run listener: _resource_record_post_run 10:21:15 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 546541568; Read time: 240; Write time: 674720 10:21:15 INFO - TinderboxPrint: CPU usage
13.0% 10:21:15 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 240 10:21:15 INFO - TinderboxPrint: I/O write bytes / time
546,541,568 / 674,720 10:21:15 INFO - TinderboxPrint: CPU idle
8,329.6 (87.0%) 10:21:15 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 10:21:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:21:15 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257593344; Read time: 0; Write time: 351944 10:21:15 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 288948224; Read time: 240; Write time: 322776 10:21:16 INFO - Running post-run listener: _upload_blobber_files 10:21:16 INFO - Blob upload gear active. 10:21:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:16 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 10:21:16 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'] 10:21:16 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 10:21:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:17 INFO - (blobuploader) - INFO - Done attempting. 10:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:21:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:18 INFO - (blobuploader) - INFO - Done attempting. 10:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:30 INFO - (blobuploader) - INFO - Done attempting. 10:21:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:30 INFO - Return code: 0 10:21:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a64f7881c5c2b8aa4a2182f55310673d93b5e4508e4d2d810dd9c698a8d489d786769eda88742373af03f2c1bc0641fa079e4db368b0bcda9999dfabc02a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6d117d40fde66a197a493da6392e451bda5a5bbe48bcd247b25bd8404bd411a8c15693df8a8942cc0a2ff7d6c3b8a0fcf34ae51134cbe8a2013beab8cecdbf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98c3ea030f0c158b6c2f549d9e016e40880c20b009226b91183d606069aed07900df48e49d177a643cde4aa5851134910fce01da1ddf661df872b9d9c45baace"} 10:21:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:30 INFO - Contents: 10:21:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a64f7881c5c2b8aa4a2182f55310673d93b5e4508e4d2d810dd9c698a8d489d786769eda88742373af03f2c1bc0641fa079e4db368b0bcda9999dfabc02a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6d117d40fde66a197a493da6392e451bda5a5bbe48bcd247b25bd8404bd411a8c15693df8a8942cc0a2ff7d6c3b8a0fcf34ae51134cbe8a2013beab8cecdbf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98c3ea030f0c158b6c2f549d9e016e40880c20b009226b91183d606069aed07900df48e49d177a643cde4aa5851134910fce01da1ddf661df872b9d9c45baace"} 10:21:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:30 INFO - Copying logs to upload dir... 10:21:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:21:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.505797 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-28 10:21:30.648869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:21:30.653303) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292 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/7a64f7881c5c2b8aa4a2182f55310673d93b5e4508e4d2d810dd9c698a8d489d786769eda88742373af03f2c1bc0641fa079e4db368b0bcda9999dfabc02a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6d117d40fde66a197a493da6392e451bda5a5bbe48bcd247b25bd8404bd411a8c15693df8a8942cc0a2ff7d6c3b8a0fcf34ae51134cbe8a2013beab8cecdbf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98c3ea030f0c158b6c2f549d9e016e40880c20b009226b91183d606069aed07900df48e49d177a643cde4aa5851134910fce01da1ddf661df872b9d9c45baace"} build_url:https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/Lt0ur10RRqCylghPuG8cFw/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/7a64f7881c5c2b8aa4a2182f55310673d93b5e4508e4d2d810dd9c698a8d489d786769eda88742373af03f2c1bc0641fa079e4db368b0bcda9999dfabc02a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6d117d40fde66a197a493da6392e451bda5a5bbe48bcd247b25bd8404bd411a8c15693df8a8942cc0a2ff7d6c3b8a0fcf34ae51134cbe8a2013beab8cecdbf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98c3ea030f0c158b6c2f549d9e016e40880c20b009226b91183d606069aed07900df48e49d177a643cde4aa5851134910fce01da1ddf661df872b9d9c45baace"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:21:30.684060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:21:30.684488) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469725240.273824-957421292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004368 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:21:30.769313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:21:30.769691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:21:30.770013) ========= ========= Total master_lag: 0.18 =========