builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1470103680.79 results: success (0) buildid: 20160801163004 builduid: 05b5144605214e7e820b5e1d9a9b0f5a revision: 0ccc93566e33f04ecca6286bd8a01c699d2c8633 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:00.793216) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:00.793643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:00.793976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:00.839247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:00.839799) ========= 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=923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 19:08:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.2M=0s 2016-08-01 19:08:01 (71.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160297 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.043954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.044357) ========= 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=923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.046706 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.101979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.102341) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0ccc93566e33f04ecca6286bd8a01c699d2c8633 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0ccc93566e33f04ecca6286bd8a01c699d2c8633 --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=923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 19:08:01,179 truncating revision to first 12 chars 2016-08-01 19:08:01,179 Setting DEBUG logging. 2016-08-01 19:08:01,179 attempt 1/10 2016-08-01 19:08:01,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0ccc93566e33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 19:08:01,502 unpacking tar archive at: mozilla-inbound-0ccc93566e33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.779078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.779911) ========= script_repo_revision: 0ccc93566e33f04ecca6286bd8a01c699d2c8633 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.780961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.782123) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 19:08:01.796567) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-01 19:08:01.797301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:02 INFO - MultiFileLogger online at 20160801 19:08:02 in /builds/slave/test 19:08:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:08:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:02 INFO - {'append_to_log': False, 19:08:02 INFO - 'base_work_dir': '/builds/slave/test', 19:08:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:08:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:02 INFO - 'branch': 'Mozilla-Inbound', 19:08:02 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:02 INFO - 'config_files': ('talos/linux_config.py',), 19:08:02 INFO - 'default_actions': ('clobber', 19:08:02 INFO - 'read-buildbot-config', 19:08:02 INFO - 'download-and-extract', 19:08:02 INFO - 'populate-webroot', 19:08:02 INFO - 'create-virtualenv', 19:08:02 INFO - 'install', 19:08:02 INFO - 'run-tests'), 19:08:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:02 INFO - 'download_minidump_stackwalk': True, 19:08:02 INFO - 'download_symbols': 'ondemand', 19:08:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:02 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:02 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:02 INFO - 'installer_path': 'installer.exe', 19:08:02 INFO - 'log_level': 'info', 19:08:02 INFO - 'log_name': 'talos', 19:08:02 INFO - 'log_to_console': True, 19:08:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:02 INFO - 'opt_config_files': (), 19:08:02 INFO - 'pip_index': False, 19:08:02 INFO - 'sps_profile': False, 19:08:02 INFO - 'sps_profile_interval': 0, 19:08:02 INFO - 'suite': 'dromaeojs', 19:08:02 INFO - 'system_bits': '32', 19:08:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:02 INFO - 'title': 'talos-linux64-ix-007', 19:08:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:02 INFO - 'use_talos_json': True, 19:08:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:02 INFO - 'work_dir': 'build'} 19:08:02 INFO - [mozharness: 2016-08-02 02:08:02.059783Z] Running clobber step. 19:08:02 INFO - Running pre-action listener: _resource_record_pre_action 19:08:02 INFO - Running main action method: clobber 19:08:02 INFO - rmtree: /builds/slave/test/build 19:08:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:02 INFO - Running post-action listener: _resource_record_post_action 19:08:02 INFO - [mozharness: 2016-08-02 02:08:02.748926Z] Finished clobber step (success) 19:08:02 INFO - [mozharness: 2016-08-02 02:08:02.749041Z] Running read-buildbot-config step. 19:08:02 INFO - Running pre-action listener: _resource_record_pre_action 19:08:02 INFO - Running main action method: read_buildbot_config 19:08:02 INFO - Using buildbot properties: 19:08:02 INFO - { 19:08:02 INFO - "project": "", 19:08:02 INFO - "product": "firefox", 19:08:02 INFO - "script_repo_revision": "production", 19:08:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:08:02 INFO - "repository": "", 19:08:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:08:02 INFO - "buildid": "20160801163004", 19:08:02 INFO - "pgo_build": "True", 19:08:02 INFO - "basedir": "/builds/slave/test", 19:08:02 INFO - "buildnumber": 1334, 19:08:02 INFO - "slavename": "talos-linux64-ix-007", 19:08:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:08:02 INFO - "platform": "ubuntu64_hw", 19:08:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:08:02 INFO - "branch": "mozilla-inbound", 19:08:02 INFO - "repo_path": "integration/mozilla-inbound", 19:08:02 INFO - "revision": "0ccc93566e33f04ecca6286bd8a01c699d2c8633", 19:08:02 INFO - "stage_platform": "linux64-pgo", 19:08:02 INFO - "builduid": "05b5144605214e7e820b5e1d9a9b0f5a", 19:08:02 INFO - "slavebuilddir": "test" 19:08:02 INFO - } 19:08:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:08:02 INFO - Running post-action listener: _resource_record_post_action 19:08:02 INFO - [mozharness: 2016-08-02 02:08:02.751505Z] Finished read-buildbot-config step (success) 19:08:02 INFO - [mozharness: 2016-08-02 02:08:02.751594Z] Running download-and-extract step. 19:08:02 INFO - Running pre-action listener: _resource_record_pre_action 19:08:02 INFO - Running main action method: download_and_extract 19:08:02 INFO - mkdir: /builds/slave/test/build/tests 19:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:02 INFO - https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:06 INFO - Downloaded 1361 bytes. 19:08:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:06 INFO - Using the following test package requirements: 19:08:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'jsshell-linux-x86_64.zip'], 19:08:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:06 INFO - https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:08 INFO - Downloaded 21809801 bytes. 19:08:08 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'] 19:08:08 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 19:08:10 INFO - Return code: 0 19:08:10 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 19:08: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')]} 19:08:10 INFO - https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:16 INFO - Downloaded 21809801 bytes. 19:08:16 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'] 19:08:16 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 19:08:17 INFO - Return code: 0 19:08:17 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')]} 19:08:17 INFO - https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:18 INFO - Downloaded 14413723 bytes. 19:08:18 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'] 19:08:18 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 19:08:19 INFO - Return code: 0 19:08:19 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')]} 19:08:19 INFO - https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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 19:08:21 INFO - Downloaded 59376154 bytes. 19:08:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - mkdir: /builds/slave/test/properties 19:08:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:21 INFO - Contents: 19:08:21 INFO - build_url:https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - Running post-action listener: _resource_record_post_action 19:08:21 INFO - Running post-action listener: set_extra_try_arguments 19:08:21 INFO - [mozharness: 2016-08-02 02:08:21.719174Z] Finished download-and-extract step (success) 19:08:21 INFO - [mozharness: 2016-08-02 02:08:21.719415Z] Running populate-webroot step. 19:08:21 INFO - Running pre-action listener: _resource_record_pre_action 19:08:21 INFO - Running main action method: populate_webroot 19:08:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:21 INFO - '--tppagecycles', 19:08:21 INFO - '7'], 19:08:21 INFO - 'tests': ['tsvgm']}}, 19:08:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['damp', 'tps']}, 19:08:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'tests': ['damp', 'tps']}, 19:08:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['dromaeo_dom']}, 19:08:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['basic_compositor_video']}, 19:08:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:08:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tsvgx', 19:08:21 INFO - 'tsvgr_opacity', 19:08:21 INFO - 'tart', 19:08:21 INFO - 'tscrollx', 19:08:21 INFO - 'cart']}, 19:08:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:21 INFO - 'tsvgr_opacity', 19:08:21 INFO - 'tart', 19:08:21 INFO - 'tscrollx', 19:08:21 INFO - 'cart']}, 19:08:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tp5o']}, 19:08:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'tests': ['tp5o']}, 19:08:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s', 19:08:21 INFO - '--xperf_path', 19:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:21 INFO - 'tests': ['tp5n']}, 19:08:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--xperf_path', 19:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:21 INFO - 'tests': ['tp5n']}}, 19:08:21 INFO - 'talos.zip': {'path': '', 19:08:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:21 INFO - Running post-action listener: _resource_record_post_action 19:08:21 INFO - [mozharness: 2016-08-02 02:08:21.738396Z] Finished populate-webroot step (success) 19:08:21 INFO - [mozharness: 2016-08-02 02:08:21.738501Z] Running create-virtualenv step. 19:08:21 INFO - Running pre-action listener: _resource_record_pre_action 19:08:21 INFO - Running main action method: create_virtualenv 19:08:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:21 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 19:08:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:22 INFO - Using real prefix '/usr' 19:08:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:23 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:25 INFO - Installing pip.................done. 19:08:25 INFO - Return code: 0 19:08:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:25 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')]} 19:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:25 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')]} 19:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:25 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:25 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 19:08:25 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 19:08:25 INFO - Using env: {'DISPLAY': ':0', 19:08:25 INFO - 'HOME': '/home/cltbld', 19:08:25 INFO - 'LANG': 'en_US.UTF-8', 19:08:25 INFO - 'LANGUAGE': 'en_US:en', 19:08:25 INFO - 'LOGNAME': 'cltbld', 19:08:25 INFO - 'MAIL': '/var/mail/cltbld', 19:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:25 INFO - 'MOZ_NO_REMOTE': '1', 19:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:25 INFO - 'NO_EM_RESTART': '1', 19:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:25 INFO - 'PWD': '/builds/slave/test', 19:08:25 INFO - 'SHELL': '/bin/bash', 19:08:25 INFO - 'SHLVL': '1', 19:08:25 INFO - 'TERM': 'linux', 19:08:25 INFO - 'TMOUT': '86400', 19:08:25 INFO - 'USER': 'cltbld', 19:08:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:25 INFO - '_': '/tools/buildbot/bin/python'} 19:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:25 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 19:08:25 INFO - Cleaning up... 19:08:25 INFO - Return code: 0 19:08:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:25 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')]} 19:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:25 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')]} 19:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:25 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:25 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 19:08:25 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 19:08:25 INFO - Using env: {'DISPLAY': ':0', 19:08:25 INFO - 'HOME': '/home/cltbld', 19:08:25 INFO - 'LANG': 'en_US.UTF-8', 19:08:25 INFO - 'LANGUAGE': 'en_US:en', 19:08:25 INFO - 'LOGNAME': 'cltbld', 19:08:25 INFO - 'MAIL': '/var/mail/cltbld', 19:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:25 INFO - 'MOZ_NO_REMOTE': '1', 19:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:25 INFO - 'NO_EM_RESTART': '1', 19:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:25 INFO - 'PWD': '/builds/slave/test', 19:08:25 INFO - 'SHELL': '/bin/bash', 19:08:25 INFO - 'SHLVL': '1', 19:08:25 INFO - 'TERM': 'linux', 19:08:25 INFO - 'TMOUT': '86400', 19:08:25 INFO - 'USER': 'cltbld', 19:08:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:25 INFO - '_': '/tools/buildbot/bin/python'} 19:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:25 INFO - Downloading/unpacking psutil>=3.1.1 19:08:25 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 19:08:25 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 19:08:25 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 19:08:25 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 19:08:25 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 19:08:25 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 19:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:27 INFO - Installing collected packages: psutil 19:08:27 INFO - Running setup.py install for psutil 19:08:27 INFO - building 'psutil._psutil_linux' extension 19:08:27 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 19:08:28 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 19:08:29 INFO - building 'psutil._psutil_posix' extension 19:08:29 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 19:08:29 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 19:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:29 INFO - Successfully installed psutil 19:08:29 INFO - Cleaning up... 19:08:29 INFO - Return code: 0 19:08:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:29 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')]} 19:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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')]} 19:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:29 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 19:08:29 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 19:08:29 INFO - Using env: {'DISPLAY': ':0', 19:08:29 INFO - 'HOME': '/home/cltbld', 19:08:29 INFO - 'LANG': 'en_US.UTF-8', 19:08:29 INFO - 'LANGUAGE': 'en_US:en', 19:08:29 INFO - 'LOGNAME': 'cltbld', 19:08:29 INFO - 'MAIL': '/var/mail/cltbld', 19:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:29 INFO - 'MOZ_NO_REMOTE': '1', 19:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:29 INFO - 'NO_EM_RESTART': '1', 19:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:29 INFO - 'PWD': '/builds/slave/test', 19:08:29 INFO - 'SHELL': '/bin/bash', 19:08:29 INFO - 'SHLVL': '1', 19:08:29 INFO - 'TERM': 'linux', 19:08:29 INFO - 'TMOUT': '86400', 19:08:29 INFO - 'USER': 'cltbld', 19:08:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:29 INFO - '_': '/tools/buildbot/bin/python'} 19:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:29 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 19:08:29 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 19:08:29 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 19:08:29 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 19:08:29 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 19:08:29 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 19:08:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:31 INFO - Installing collected packages: mozsystemmonitor 19:08:31 INFO - Running setup.py install for mozsystemmonitor 19:08:31 INFO - Successfully installed mozsystemmonitor 19:08:31 INFO - Cleaning up... 19:08:31 INFO - Return code: 0 19:08:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:08:31 INFO - Using env: {'DISPLAY': ':0', 19:08:31 INFO - 'HOME': '/home/cltbld', 19:08:31 INFO - 'LANG': 'en_US.UTF-8', 19:08:31 INFO - 'LANGUAGE': 'en_US:en', 19:08:31 INFO - 'LOGNAME': 'cltbld', 19:08:31 INFO - 'MAIL': '/var/mail/cltbld', 19:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:31 INFO - 'MOZ_NO_REMOTE': '1', 19:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:31 INFO - 'NO_EM_RESTART': '1', 19:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:31 INFO - 'PWD': '/builds/slave/test', 19:08:31 INFO - 'SHELL': '/bin/bash', 19:08:31 INFO - 'SHLVL': '1', 19:08:31 INFO - 'TERM': 'linux', 19:08:31 INFO - 'TMOUT': '86400', 19:08:31 INFO - 'USER': 'cltbld', 19:08:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:31 INFO - '_': '/tools/buildbot/bin/python'} 19:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:31 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:34 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:34 INFO - warning: no files found matching '*.txt' 19:08:34 INFO - no previously-included directories found matching 'build' 19:08:34 INFO - no previously-included directories found matching 'dist' 19:08:34 INFO - no previously-included directories found matching '.git*' 19:08:34 INFO - Installing collected packages: jsonschema, functools32 19:08:34 INFO - Running setup.py install for functools32 19:08:34 INFO - warning: no files found matching '*.txt' 19:08:34 INFO - no previously-included directories found matching 'build' 19:08:34 INFO - no previously-included directories found matching 'dist' 19:08:34 INFO - no previously-included directories found matching '.git*' 19:08:34 INFO - Successfully installed jsonschema functools32 19:08:34 INFO - Cleaning up... 19:08:34 INFO - Return code: 0 19:08:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:08:34 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')]} 19:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 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')]} 19:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:34 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 19:08:34 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 19:08:34 INFO - Using env: {'DISPLAY': ':0', 19:08:34 INFO - 'HOME': '/home/cltbld', 19:08:34 INFO - 'LANG': 'en_US.UTF-8', 19:08:34 INFO - 'LANGUAGE': 'en_US:en', 19:08:34 INFO - 'LOGNAME': 'cltbld', 19:08:34 INFO - 'MAIL': '/var/mail/cltbld', 19:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:34 INFO - 'MOZ_NO_REMOTE': '1', 19:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:34 INFO - 'NO_EM_RESTART': '1', 19:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:34 INFO - 'PWD': '/builds/slave/test', 19:08:34 INFO - 'SHELL': '/bin/bash', 19:08:34 INFO - 'SHLVL': '1', 19:08:34 INFO - 'TERM': 'linux', 19:08:34 INFO - 'TMOUT': '86400', 19:08:34 INFO - 'USER': 'cltbld', 19:08:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:34 INFO - '_': '/tools/buildbot/bin/python'} 19:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:08:34 INFO - Cleaning up... 19:08:34 INFO - Return code: 0 19:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:34 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')]} 19:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 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')]} 19:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:34 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 19:08:34 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 19:08:34 INFO - Using env: {'DISPLAY': ':0', 19:08:34 INFO - 'HOME': '/home/cltbld', 19:08:34 INFO - 'LANG': 'en_US.UTF-8', 19:08:34 INFO - 'LANGUAGE': 'en_US:en', 19:08:34 INFO - 'LOGNAME': 'cltbld', 19:08:34 INFO - 'MAIL': '/var/mail/cltbld', 19:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:34 INFO - 'MOZ_NO_REMOTE': '1', 19:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:34 INFO - 'NO_EM_RESTART': '1', 19:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:34 INFO - 'PWD': '/builds/slave/test', 19:08:34 INFO - 'SHELL': '/bin/bash', 19:08:34 INFO - 'SHLVL': '1', 19:08:34 INFO - 'TERM': 'linux', 19:08:34 INFO - 'TMOUT': '86400', 19:08:34 INFO - 'USER': 'cltbld', 19:08:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:34 INFO - '_': '/tools/buildbot/bin/python'} 19:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:37 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 19:08:37 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 19:08:37 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 19:08:37 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 19:08:37 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 19:08:37 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 19:08:37 INFO - Downloading docopt-0.6.1.tar.gz 19:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:37 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:37 INFO - Running setup.py install for blobuploader 19:08:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:37 INFO - Running setup.py install for requests 19:08:37 INFO - Running setup.py install for docopt 19:08:37 INFO - Successfully installed blobuploader requests docopt 19:08:37 INFO - Cleaning up... 19:08:38 INFO - Return code: 0 19:08:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:38 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')]} 19:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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')]} 19:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:38 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 19:08:38 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 19:08:38 INFO - Using env: {'DISPLAY': ':0', 19:08:38 INFO - 'HOME': '/home/cltbld', 19:08:38 INFO - 'LANG': 'en_US.UTF-8', 19:08:38 INFO - 'LANGUAGE': 'en_US:en', 19:08:38 INFO - 'LOGNAME': 'cltbld', 19:08:38 INFO - 'MAIL': '/var/mail/cltbld', 19:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:38 INFO - 'MOZ_NO_REMOTE': '1', 19:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:38 INFO - 'NO_EM_RESTART': '1', 19:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:38 INFO - 'PWD': '/builds/slave/test', 19:08:38 INFO - 'SHELL': '/bin/bash', 19:08:38 INFO - 'SHLVL': '1', 19:08:38 INFO - 'TERM': 'linux', 19:08:38 INFO - 'TMOUT': '86400', 19:08:38 INFO - 'USER': 'cltbld', 19:08:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:38 INFO - '_': '/tools/buildbot/bin/python'} 19:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:38 INFO - Running setup.py (path:/tmp/pip-6KRXNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:38 INFO - Running setup.py (path:/tmp/pip-BPkKhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:38 INFO - Running setup.py (path:/tmp/pip-kZLy3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:38 INFO - Running setup.py (path:/tmp/pip-1QGh8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:38 INFO - Running setup.py (path:/tmp/pip-U2hcyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:38 INFO - Running setup.py (path:/tmp/pip-6LYxtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:38 INFO - Running setup.py (path:/tmp/pip-Q9itCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:38 INFO - Running setup.py (path:/tmp/pip-4siOdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:38 INFO - Running setup.py (path:/tmp/pip-N5mEvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:38 INFO - Running setup.py (path:/tmp/pip-GqSacw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:38 INFO - Running setup.py (path:/tmp/pip-KDsyOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:39 INFO - Running setup.py (path:/tmp/pip-3aCQB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:39 INFO - Running setup.py (path:/tmp/pip-MEVEAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:39 INFO - Running setup.py (path:/tmp/pip-gf8ddV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:39 INFO - Running setup.py (path:/tmp/pip-5R9lsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:39 INFO - Running setup.py (path:/tmp/pip-QFbfaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:39 INFO - Running setup.py (path:/tmp/pip-qrBIwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:39 INFO - Running setup.py install for manifestparser 19:08:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:39 INFO - Running setup.py install for mozcrash 19:08:39 INFO - Running setup.py install for mozdebug 19:08:39 INFO - Running setup.py install for mozdevice 19:08:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:39 INFO - Running setup.py install for mozfile 19:08:39 INFO - Running setup.py install for mozhttpd 19:08:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for mozinfo 19:08:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for mozInstall 19:08:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for mozleak 19:08:40 INFO - Running setup.py install for mozlog 19:08:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for moznetwork 19:08:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for mozprocess 19:08:40 INFO - Running setup.py install for mozprofile 19:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for mozrunner 19:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:40 INFO - Running setup.py install for mozscreenshot 19:08:41 INFO - Running setup.py install for moztest 19:08:41 INFO - Running setup.py install for mozversion 19:08:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:41 INFO - Cleaning up... 19:08:41 INFO - Return code: 0 19:08:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:41 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:41 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 19:08:41 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 19:08:41 INFO - Using env: {'DISPLAY': ':0', 19:08:41 INFO - 'HOME': '/home/cltbld', 19:08:41 INFO - 'LANG': 'en_US.UTF-8', 19:08:41 INFO - 'LANGUAGE': 'en_US:en', 19:08:41 INFO - 'LOGNAME': 'cltbld', 19:08:41 INFO - 'MAIL': '/var/mail/cltbld', 19:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:41 INFO - 'MOZ_NO_REMOTE': '1', 19:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:41 INFO - 'NO_EM_RESTART': '1', 19:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:41 INFO - 'PWD': '/builds/slave/test', 19:08:41 INFO - 'SHELL': '/bin/bash', 19:08:41 INFO - 'SHLVL': '1', 19:08:41 INFO - 'TERM': 'linux', 19:08:41 INFO - 'TMOUT': '86400', 19:08:41 INFO - 'USER': 'cltbld', 19:08:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:41 INFO - '_': '/tools/buildbot/bin/python'} 19:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:41 INFO - Running setup.py (path:/tmp/pip-T2lbiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:41 INFO - Running setup.py (path:/tmp/pip-kxJOfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:41 INFO - Running setup.py (path:/tmp/pip-EfRvOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:41 INFO - Running setup.py (path:/tmp/pip-IYtypy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:41 INFO - Running setup.py (path:/tmp/pip-eSOaYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:41 INFO - Running setup.py (path:/tmp/pip-bDOrEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:41 INFO - Running setup.py (path:/tmp/pip-Gdln1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:41 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)) 19:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:41 INFO - Running setup.py (path:/tmp/pip-nnt60y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:42 INFO - Running setup.py (path:/tmp/pip-IJ1pJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:42 INFO - Running setup.py (path:/tmp/pip-85v9NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:42 INFO - Running setup.py (path:/tmp/pip-Jn19Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:42 INFO - Running setup.py (path:/tmp/pip-i3hHFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:42 INFO - Running setup.py (path:/tmp/pip-wle6Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:42 INFO - Running setup.py (path:/tmp/pip-R_7akO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:42 INFO - Running setup.py (path:/tmp/pip-SJDyyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:42 INFO - Running setup.py (path:/tmp/pip-Wyzf82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:42 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)) 19:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:42 INFO - Running setup.py (path:/tmp/pip-ZKLJHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:44 INFO - Downloading blessings-1.6.tar.gz 19:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:44 INFO - Installing collected packages: blessings 19:08:44 INFO - Running setup.py install for blessings 19:08:44 INFO - Successfully installed blessings 19:08:44 INFO - Cleaning up... 19:08:44 INFO - Return code: 0 19:08:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:45 INFO - Reading from file tmpfile_stdout 19:08:45 INFO - Current package versions: 19:08:45 INFO - argparse == 1.2.1 19:08:45 INFO - blessings == 1.6 19:08:45 INFO - blobuploader == 1.2.4 19:08:45 INFO - docopt == 0.6.1 19:08:45 INFO - functools32 == 3.2.3-2 19:08:45 INFO - jsonschema == 2.5.1 19:08:45 INFO - manifestparser == 1.1 19:08:45 INFO - mozInstall == 1.12 19:08:45 INFO - mozcrash == 0.17 19:08:45 INFO - mozdebug == 0.1 19:08:45 INFO - mozdevice == 0.48 19:08:45 INFO - mozfile == 1.2 19:08:45 INFO - mozhttpd == 0.7 19:08:45 INFO - mozinfo == 0.9 19:08:45 INFO - mozleak == 0.1 19:08:45 INFO - mozlog == 3.3 19:08:45 INFO - moznetwork == 0.27 19:08:45 INFO - mozprocess == 0.23 19:08:45 INFO - mozprofile == 0.28 19:08:45 INFO - mozrunner == 6.12 19:08:45 INFO - mozscreenshot == 0.1 19:08:45 INFO - mozsystemmonitor == 0.3 19:08:45 INFO - moztest == 0.7 19:08:45 INFO - mozversion == 1.4 19:08:45 INFO - psutil == 3.1.1 19:08:45 INFO - requests == 1.2.3 19:08:45 INFO - wsgiref == 0.1.2 19:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:45 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:45 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 19:08:45 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 19:08:45 INFO - Using env: {'DISPLAY': ':0', 19:08:45 INFO - 'HOME': '/home/cltbld', 19:08:45 INFO - 'LANG': 'en_US.UTF-8', 19:08:45 INFO - 'LANGUAGE': 'en_US:en', 19:08:45 INFO - 'LOGNAME': 'cltbld', 19:08:45 INFO - 'MAIL': '/var/mail/cltbld', 19:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:45 INFO - 'MOZ_NO_REMOTE': '1', 19:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:45 INFO - 'NO_EM_RESTART': '1', 19:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:45 INFO - 'PWD': '/builds/slave/test', 19:08:45 INFO - 'SHELL': '/bin/bash', 19:08:45 INFO - 'SHLVL': '1', 19:08:45 INFO - 'TERM': 'linux', 19:08:45 INFO - 'TMOUT': '86400', 19:08:45 INFO - 'USER': 'cltbld', 19:08:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:45 INFO - '_': '/tools/buildbot/bin/python'} 19:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 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)) 19:08:45 INFO - Cleaning up... 19:08:45 INFO - Return code: 0 19:08:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:45 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 0x1ed5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, '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': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', '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 19:08:45 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 19:08:45 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 19:08:45 INFO - Using env: {'DISPLAY': ':0', 19:08:45 INFO - 'HOME': '/home/cltbld', 19:08:45 INFO - 'LANG': 'en_US.UTF-8', 19:08:45 INFO - 'LANGUAGE': 'en_US:en', 19:08:45 INFO - 'LOGNAME': 'cltbld', 19:08:45 INFO - 'MAIL': '/var/mail/cltbld', 19:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:45 INFO - 'MOZ_NO_REMOTE': '1', 19:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:45 INFO - 'NO_EM_RESTART': '1', 19:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:45 INFO - 'PWD': '/builds/slave/test', 19:08:45 INFO - 'SHELL': '/bin/bash', 19:08:45 INFO - 'SHLVL': '1', 19:08:45 INFO - 'TERM': 'linux', 19:08:45 INFO - 'TMOUT': '86400', 19:08:45 INFO - 'USER': 'cltbld', 19:08:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:45 INFO - '_': '/tools/buildbot/bin/python'} 19:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:45 INFO - Cleaning up... 19:08:45 INFO - Return code: 0 19:08:45 INFO - Running post-action listener: _resource_record_post_action 19:08:45 INFO - Running post-action listener: _start_resource_monitoring 19:08:45 INFO - Starting resource monitoring. 19:08:45 INFO - [mozharness: 2016-08-02 02:08:45.552504Z] Finished create-virtualenv step (success) 19:08:45 INFO - [mozharness: 2016-08-02 02:08:45.552938Z] Running install step. 19:08:45 INFO - Running pre-action listener: _resource_record_pre_action 19:08:45 INFO - Running main action method: install 19:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:45 INFO - Reading from file tmpfile_stdout 19:08:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:45 INFO - Reading from file tmpfile_stdout 19:08:45 INFO - Output received: 19:08:45 INFO - Usage: mozinstall [options] installer 19:08:45 INFO - Options: 19:08:45 INFO - -h, --help show this help message and exit 19:08:45 INFO - -d DEST, --destination=DEST 19:08:45 INFO - Directory to install application into. [default: 19:08:45 INFO - "/builds/slave/test"] 19:08:45 INFO - --app=APP Application being installed. [default: firefox] 19:08:45 INFO - mkdir: /builds/slave/test/build/application 19:08:45 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'] 19:08:45 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 19:09:02 INFO - Reading from file tmpfile_stdout 19:09:02 INFO - Output received: 19:09:02 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:02 INFO - Running post-action listener: _resource_record_post_action 19:09:02 INFO - [mozharness: 2016-08-02 02:09:02.684347Z] Finished install step (success) 19:09:02 INFO - [mozharness: 2016-08-02 02:09:02.684689Z] Running run-tests step. 19:09:02 INFO - Running pre-action listener: _resource_record_pre_action 19:09:02 INFO - Running main action method: run_tests 19:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:02 INFO - Python 2.7.3 19:09:02 INFO - Return code: 0 19:09:02 INFO - grabbing minidump binary from tooltool 19:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:02 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 0x21943b0>, '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 0x21952b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:02 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 19:09:02 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 19:09:02 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 19:09:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:02 INFO - Return code: 0 19:09:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 19:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 19:09:02 INFO - Using env: {'DISPLAY': ':0', 19:09:02 INFO - 'HOME': '/home/cltbld', 19:09:02 INFO - 'LANG': 'en_US.UTF-8', 19:09:02 INFO - 'LANGUAGE': 'en_US:en', 19:09:02 INFO - 'LOGNAME': 'cltbld', 19:09:02 INFO - 'MAIL': '/var/mail/cltbld', 19:09:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:02 INFO - 'MOZ_NO_REMOTE': '1', 19:09:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:02 INFO - 'NO_EM_RESTART': '1', 19:09:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:02 INFO - 'PWD': '/builds/slave/test', 19:09:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:02 INFO - 'SHELL': '/bin/bash', 19:09:02 INFO - 'SHLVL': '1', 19:09:02 INFO - 'TERM': 'linux', 19:09:02 INFO - 'TMOUT': '86400', 19:09:02 INFO - 'USER': 'cltbld', 19:09:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315', 19:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:02 INFO - '_': '/tools/buildbot/bin/python'} 19:09:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 19:09:03 INFO - mozversion application_buildid: 20160801163004 19:09:03 INFO - mozversion application_changeset: 0ccc93566e33f04ecca6286bd8a01c699d2c8633 19:09:03 INFO - mozversion application_display_name: Nightly 19:09:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:03 INFO - mozversion application_name: Firefox 19:09:03 INFO - mozversion application_remotingname: firefox 19:09:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:09:03 INFO - mozversion application_vendor: Mozilla 19:09:03 INFO - mozversion application_version: 50.0a1 19:09:03 INFO - mozversion platform_buildid: 20160801163004 19:09:03 INFO - mozversion platform_changeset: 0ccc93566e33f04ecca6286bd8a01c699d2c8633 19:09:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:09:03 INFO - mozversion platform_version: 50.0a1 19:09:03 INFO - using testdate: 1470103743 19:09:03 INFO - actual date: 1470103743 19:09:03 INFO - starting webserver on 'localhost:44185' 19:09:03 INFO - SUITE-START | Running 2 tests 19:09:03 INFO - TEST-START | dromaeo_css 19:09:03 INFO - operating with platform_type : linux_ 19:09:03 INFO - Initialising browser for dromaeo_css test... 19:09:03 INFO - TEST-INFO | started process 3302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQhAh9/profile http://localhost:44185/getInfo.html) 19:09:07 INFO - PROCESS | 3302 | __metrics Screen width/height:1600/1200 19:09:07 INFO - PROCESS | 3302 | colorDepth:24 19:09:07 INFO - PROCESS | 3302 | Browser inner width/height: 1024/697 19:09:07 INFO - PROCESS | 3302 | __metrics 19:09:09 INFO - PROCESS | 3302 | 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" 19:09:09 INFO - PROCESS | 3302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:09:10 INFO - TEST-INFO | 3302: exit 0 19:09:10 INFO - Browser initialized. 19:09:10 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:10 INFO - TEST-INFO | started process 3386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQhAh9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:22 INFO - PROCESS | 3386 | RSS: Main: 156327936 19:09:22 INFO - PROCESS | 3386 | 19:10:13 INFO - PROCESS | 3386 | 1470103813412 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] 19:12:22 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44185/tests/dromaeo/cssquery-ext.html) 19:12:23 INFO - PROCESS | 3386 | RSS: Main: 259731456 19:12:23 INFO - PROCESS | 3386 | 19:15:26 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44185/tests/dromaeo/cssquery-ext.html (next: http://localhost:44185/tests/dromaeo/cssquery-jquery.html) 19:15:26 INFO - PROCESS | 3386 | RSS: Main: 239312896 19:15:26 INFO - PROCESS | 3386 | 19:18:28 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44185/tests/dromaeo/cssquery-mootools.html) 19:18:29 INFO - PROCESS | 3386 | RSS: Main: 184094720 19:18:29 INFO - PROCESS | 3386 | 19:21:31 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44185/tests/dromaeo/cssquery-prototype.html) 19:21:31 INFO - PROCESS | 3386 | RSS: Main: 219889664 19:21:31 INFO - PROCESS | 3386 | 19:24:34 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44185/tests/dromaeo/cssquery-yui.html) 19:24:35 INFO - PROCESS | 3386 | RSS: Main: 182562816 19:24:35 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44185/tests/dromaeo/cssquery-yui.html (next: http://localhost:44185/tests/dromaeo/cssquery-dojo.html) 19:27:38 INFO - PROCESS | 3386 | RSS: Main: 274665472 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | __start_tp_report 19:27:38 INFO - PROCESS | 3386 | _x_x_mozilla_page_load 19:27:38 INFO - PROCESS | 3386 | _x_x_mozilla_page_load_details 19:27:38 INFO - PROCESS | 3386 | |i|pagename|runs| 19:27:38 INFO - PROCESS | 3386 | |0;dojo.html;3057.6025116734822;3067.355855270393;3073.6926307369267;3101.3952279305518;3111.346617210386;5265.710385928773;5321.813736519222;5332.600054995876;5388.353397592289;5416.4854338837795;5383.246345511631;5395.568354531628;5451.018816613008;5458;5483.917741233875;4860.052289803499;4885.096257192413;4957.727324997124;4959.752012399384;5032.849014529552;4947.356843610326;4974.179260422026;4990.126727822635;5008.874778130557;5009;4832.661713680061;4856.902861942742;4872.610191184732;4884.389451318585;4976.377952755905;4860.562549370574;4863.416390033219;4873.780679869415;4955.430125535538;4962.9007419851405;4896.828610998634;4898.779554920037;4921.557059864629;4941.45643979162;4971.577415919651;5219.269302297681;5318.840434786963;5414.214938833847;5468.562514998791;5474.206240095204;5724.885502289931;5771.134329850556;5823.708814559255;5835.44563266489;5836.007878660595;5831.504322132624;5867;5905.320888097881;5906.379830117861;5907.822765317047;5230.032443997872;5340.145576707786;5377.7580008899695;5464.180372944051;5472.343318801769;5904.380040095728;5906.350301466835;5954.55340849438;6003.549733769984;6019.428154325332;5691.373948865621;5697.6296540724725;5706.3722990471015;5707.1724599933605;5709.143628455682;5529.723513824292;5607.859803504945;5672.12082127271;5834.883302333929;5840.88318233633;5671.829845104653;5677.403872593401;5686.34607020198;5733.226014488074;5740.282464691913;5637.267155269788;5692.48767610917;5699.572532060112;5710.942890571041;5715.971420142956;4294.613484786321;4362.978185109054;4382.07976324969;4384.671149663788;4403.757793321398;3922.921541569153;3937.1535119948776;3968.7817170055346;3989.58109398509;4016.6987475938836;5438.428964958702;5456.317960254968;5461.808836690697;5479.972600136974;5482.396936337;5596.300462442195;5736.110902810071;5808.912866307009;5813.88372232553;5863.912041319383;5452.672839629635;5503.147012213113;5554.583406244547;5559.833205003856;5562.16567514876;5028.974855125774;5030.673006254582;5032.874178145503;5037.370328708911;5071.264666623393;5768.913466297925;5990.820275391745;6057.697115144137;6057.8485537861025;6058.333583305833;5705.885882282414;5749.367569567261;5753.597248192586;5794.855128621818;5846.239988801429;6006.309274433496;6013.158157857816;6013.609115407485;6018.307894592002;6022.849428764316;5508.531774799187;5654.915176272441;5702.116171993348;5710.200571919851;5718.599698021098;5641.689707066151;5702.287214098238;5713.742881570256;5760.798372056958;5811.593188476766;5571.693556854412;5604.8879022418505;5611.074172761612;5618.887622247614;5619.297587801525;5418.674879507243;5597.216389705363;5604.663720176639;5610;5612.747426365905;5566.972165139148;5610.102383618601;5619.044762390322;5653.293338332708;5694.487496125369;5687.943120568907;5690.430956904276;5746.42535746422;5749.683767392834;5751.7411716472025;5353.2773075634295;5549.5837812163445;5560.5551555876245;5565.6104072714525;5566.359868615161 19:27:38 INFO - PROCESS | 3386 | |1;ext.html;577.3620149734543;590.9645421274722;619;620.1070458539702;638.1512588257618;33206.83396583017;33960.15099622511;36233.27533449329;36254.45618315724;43959.56040439595;43704.3444348335;47674.76162619182;47719.761401193035;47766.283505747444;47790.283145752845;8995.370324077334;9141.542922853863;9145.405548639317;9147.085291470867;9150.49672268025;9039.186473217409;9127.543622818832;9132.132447417485;9136.406133601327;9137.68018119366;9174.86237706435;9224.769380765467;9230.630774769035;9232.67685631003;9235;9160.496172710498;9207.539623018889;9208.815823683522;9218.262538996863;9222.123898229658;9040.186383225542;9088.272938164997;9090.363674542785;9106.40808347462;9108;43193.56806431927;43605;43612.6013069281;43621.563784362064;43628.56371436277;3541.752077354586;3704.722145839046;3801.9429708554394;3984.008481251565;4479.9552004479865;32232.83883580567;33207;33389;34477.24182065454;34942.30115397703;4257.680673949466;4309.35359696045;4314.482262128533;4343.131373725268;4439.156560253574;337903;338181;339349;340223.29888350645;342096;61249.08126378108;61528.69235653883;61564;61564.07653885195;61631.38368616346;37211.25577488489;38064;38211;40136.59863401387;64004.67997659982;17781;17902.91048544749;17919.910400447916;17931.820681793015;17934.730979035325;12956.28740419286;12969.675758105934;12996.415161317764;12997.545085921947;13001.544945926848;20040.799592003892;20149.49626259326;20202.898985504977;20305.187792488134;20328.288509902377;7260;7448.366888814403;7541.962290188514;7584.962075189589;7637.15991240963;885.8671199320024;938.7043081429327;1025.7179275699093;1027.445179603021;1093.6336327330275;34209.48685769716;34789.652103479144;34829.47755783665;34894.825525872206;34933;1091.4433638844246;1128.9830652540218;1144.3076938452282;1148.8391625172483;1176.8705442401329;17918.731219031724;17995;18158.182881770354;18188.818111818713;18215.908920455313;520360;572521;581919;582076;839508;63324.68337658282;64147;64181;64216.67891660512;64290.6785466079;1242.67069226655;1324.6953200763878;1354.7019655675933;1356.87109724576;1379.1793882639813;31192;35010;35174.29651407008;35443.64556354507;35644.82177589095;52108.478915211876;52704.20943685771;52800.20799688085;52976.20535691891;53056.73471632617;443790;445170.741462932;447181;447265;448900;26253.606195906694;26448;29748;30445.69554304517;30840.691593083782;49540.75229623829;49746.50253497563;49887.251691225385;49926;51407.485925141766;41990.58009419867;42521.787391064085;43100.353494696974;44410.333844992994;44494.11011779811;41840.581594184885;41912.371314430915;42483.3627495594;42847.785761071;44020.77989610031;36350.27299454049;42847.57152428436;43888.561114388445;44348.33477497775;44523.33215001713;34537.827310863286;38082.428763568016;38230.61769382271;38814.80592597132;38882.25865245881;29560.260993475335;29575.89453107393;29713.851430742707;30088.548671769502;30092.398152037276 19:27:38 INFO - PROCESS | 3386 | |2;jquery.html;391.3835708758704;391.49692644951244;397.3959581436218;402.23775944585014;422.0040703938704;12930.74138517229;18650.253989840407;20036.797792132482;20120.59758804823;20129.698054529195;18766.71849922249;19355.709664355047;19475.415737527863;19828.801711982876;19847.40457786265;5785.16115163301;5981.940180598203;5986.8802623947495;5992.820215393545;6008.519318454513;5880.088586269114;5950.821475355725;5960.52315814736;5963;5964.105384192362;4306.138772245547;6365.681715914209;6609.504287178457;6696.330366963289;6783.7625683101105;6532.444742196943;6566.047923051178;6686.364795344434;6767.932320676804;6774.916013437851;5844.561657875676;5891.234139561872;5908.320543137551;5913.822585322404;5915.556333275022;23287.883560582257;23732.40668983272;23838.404039898967;23843;24016.519669606685;2366.372911178539;2427.5873101572774;2506.5989441689426;2827.377976845091;3025.788194826363;10362.27464077515;10374;10545.630902918438;11009.064229540418;11062.889371106266;1943.650142974264;1980.386080315107;2015;2047.1811275489922;2059.7322348094804;54339.728301358635;79992.99999999942;81095;83192.58403708003;83583.5820820892;10651.30766500175;10854.6431696038;11175.994160525592;11470.76320117569;12398;15885;15940.840591594168;15965.44120955761;15983.840161598468;15995.280212390471;7840.568768717661;8164.67341306353;8271.710490132817;8361.832763344699;8414.158584141536;7586.24137586237;7992.36061115121;8043.718469853527;8241.876371854427;8252.8349433011;4832.903341933142;4845.709257444564;4919.680220785637;5031.144705400091;5059.671121377099;1911.8852868827914;1946.532832120281;2007.8293345065833;2024.908879100444;2033.7356143701224;973.6494861849728;975.6243846119295;987.7333120057544;1003.2124782046059;1018.9962886556735;19293.324733634254;19394.903025485066;20010.799892000894;20033.398998030083;20090.799092008892;981.4847205217318;996.272720913737;1000.0499525450706;1013.5135135135176;1017.0693815159194;10549.84175237372;11209.439528023566;11228.887711122785;11250.606228781953;11278.943605282086;368166;377289;379626;469662;473859;90684.27947161596;93183;94026.52986735023;96831.51584242034;100471.49764251131;1000.4497526360473;1024.9897501024893;1063.0326402973258;1063.2769716592636;1064.414571985405;17392.91303543525;17674.823251767833;18231.179596917904;18448.723269151244;18523.81476185221;41610;42545;42567.57432425636;42606.786966064974;42844.57155428531;59259.70370148294;60303;60449;62461.06308405469;62499.062514061414;8298.21166989135;8368.790780230544;8425.073241943259;8431.40980131385;8842.867356989522;12529.874701252871;13065.673358166121;13110.672233194246;13119.934400327937;13350.265735384259;11188.384638844942;11220.438978050901;11740.236884602473;11762.94118529402;11868.762624747284;10375.169986400919;10378.169746420419;11121.555137794721;11316.886831131584;11392.316461012366;10958.12335013213;11609.709757255798;11825.940870295593;11942.671179119989;12160.75678486443;7610.695572177051;7828.4911480755845;8018.8396232073865;8217.424780265324;8566.91433085661;11267.323960562064;11474;11565.942170289094;11755.647330580096;11860.584879529175 19:27:38 INFO - PROCESS | 3386 | |3;mootools.html;1299.1295831792697;1466.5233799015318;1526.5801904476268;1663.5258951198903;1805.0433270366702;8217.424780265384;8483.321334293258;8513.361497887652;8782.692605758799;8792.51641159736;8675.08911564286;8813.95593022034;8816.867746983784;8818.603162857671;8822.294216462684;2413.070967677448;2430.4774473488196;2432.635104734295;2432.6594276801175;2435.2937648082034;2316.6061769499224;2368.917087901924;2376.275236053003;2377.239283429303;2379.1435083369975;2380.262118743195;2390.486045500217;2397.1490121007055;2417.9965314394503;2427.5023620157826;2275.2264230161823;2296.8277379196543;2297.6553516972335;2305.3084074777585;2326.7091613548305;2238.115944202031;2246.51699884524;2246.6742322363166;2248.0445810530623;2251.5046689728233;8749.518776467292;8811.691590794355;8813.1186881312;8816.691415800417;8907.06475820036;5337.653052551611;5516.393196748354;5524.917126243109;5538.947599955995;5544.695041772701;3316.403047451458;3334.2997970425995;3397.8640854365794;3412.8293585320635;3419.128122328815;1094.813881640123;1107.4241394474827;1112.1436493899732;1116.3134672176552;1129.1249281806665;12934.35328233594;13002.284874331908;13008.479660813557;13025;13049.086563940433;4366.126774645084;4618.376519169936;4643.883902902455;4726.645501587394;4735.029318989667;10036.046575575308;10072.798544029225;10080.69757907264;10086.243531735003;10089.596416143419;5323.920141197885;5325.8934821303355;5326.387465441524;5332.173513105475;5338.572914166935;4408.867733967986;4768.47546769855;4933.531314525115;4976.353074100344;4982.402111746541;3874.2445223181207;3892.5134358205223;3952.209558088394;3991.16185601027;3993.4409182714444;1112.4548971004313;1117.1509652664033;1129.9661010169707;1130.7455822439886;1137.5449820071872;885.406777459104;977.1791694976112;981.622075500923;998.3261298623545;1007.1992765751245;6168;6171.259448866075;6197.845053873599;6334.113224148623;6339.841503962438;975.6536429567543;988.3328753091635;990.9405435673883;1023.2734758321675;1036.383351905615;4012.0972781124015;4064.878053658395;4233.089885674533;4301.870943871689;4350.564943505624;11454.885451145548;11662.94168529169;11748.353840538852;11778.175527713149;11793.233439826385;11439.542418303341;11678.24091434054;11771;11777.234479758788;11869.940650296694;8536.74389768308;8614.87077693835;8652.264557512555;8656.6537338507;8658.48049117055;6169.84575385619;6275.309715931336;6302.968485157545;6392.137061496825;6529.216494020748;10696.358218506915;10834.970677785597;10920.453977301262;10920.617778377718;10942.069924056545;10763.623273185402;10838.295510791773;10901.618443354444;10917.290376125526;11052.226344155832;7216.530925489827;7420.332170104716;7427.368673662583;7770.961145194238;7916.247956444128;8587.871181932402;8738;8821.426607270507;9048.592813323285;9084.954575227082;7780.572068536285;8054.436189466681;8106.392020598597;8171.264586187034;8341.499510029418;7905.802354941173;7946.801329966797;8012.599370031358;8055.637496312797;8062.355011599176;7397.630118494161;7427.071616047994;7489.66296516669;7499.66251518672;7501.28737769911;5246.790128394821;5250.396204436386;5308.495692909168;5416.945830541644;5443.374011988672;5167.354080739908;5241.947580524146;5335.199720042025;5336.306280183551;5379.865503362291 19:27:38 INFO - PROCESS | 3386 | |4;prototype.html;315.65751159991424;320.45682568047164;328.3957518166573;329.4350189425135;330.9851056702448;5234.371875374955;5283.656562323451;5284.943011397717;5305.204219367087;5331.493508116732;4991;5049.141645920193;5055.393352797661;5124.410692770332;5239.86900327492;3968.6626636735914;3982.1637456134245;4037.313656678372;4086.693497987648;4141.9585804142025;4082.265192265391;4093.359782940002;4098.4876890388705;4115.999999999985;4142.337226043834;3908.1011367385377;4079.2045551117544;4085.2442298174783;4088.3867419886956;4116.97941510292;4060.9593904060876;4068.755874647501;4088.6115818997146;4091.4067460218253;4094.877153685379;3588.856445742167;3589.820508974567;3619.529461170031;3619.94570081449;3623.61951995042;4867.561919427269;5141.845744627667;5153.433122356538;5156.484351564851;5165.147750621143;4605.516420775837;4641.280601506772;4649.511801260853;4651;4655.557722016403;5442.210879422461;5445.074337362658;5450.127979523258;5481.287432633732;5496.6701997880255;3838.7696738195796;3925.862594809168;3929.44987701722;3941.989585311483;3949.605039496056;5598.2442370280305;5636.534501029721;5686.516646085088;5695.515881150107;5709.9714501427225;3888.7361607477683;3896.7077469189926;3904.6919282040267;3911.9022024449046;3928.7839168845417;3961.603839616015;3963.564007959122;3977.6475998160763;3993.6421616650478;3997.980010099989;4495.550444955478;4542.205114105019;4548.727076375428;4567.223571992703;4612.262038073959;5429.972850135724;5435.157550579587;5437.265969094122;5443.237946687467;5445.210444485528;1312.9277889715966;1370.184740079651;1374.587623712902;1381.1367895065584;1382.0187666756715;930.4835816121982;940.8353538130937;957.4781743949565;960.841461158915;964.6928412001777;5252.238425428368;5275.472452754694;5283.996040752245;5285.497877701612;5293.523582877482;5563.833085007456;5566;5567.47109024642;5572.665640061609;5604.542818867124;5117.84848409105;5325.760340784674;5328.6802791832615;5329.387120481194;5387.380451248078;2920.3867187890783;2929.1359049080575;2956.1427186115784;2965.7756682488134;2977.8064425812686;5692.345380281238;5714.571407144397;5777.306723193244;5843.532517398683;5856.267966504187;5672.432756724294;5686.914696279559;5712.257406537124;5714.3999880012;5728.914066289009;5790.884182316414;5793.2179155814265;5813.651180929158;5842.649441033552;5869.7945571904775;5392.811251606175;5520.205933071848;5533.916991245215;5569.303837020372;5577.247071645276;5471.179323101566;5540.279763630702;5551.777928882961;5554.278173766145;5619.662820230799;5597.44025597437;5750.884982300414;5830.154627579062;5838;5838.416158384128;3976.1053762903116;3991.3613821788376;3992.820323085526;3995.760254384746;4020.0753826620626;5527.798872856738;5538.141588053858;5587.860303492445;5599.244102046172;5640.971795141162;5311.628186027096;5456.890862182813;5480.917786233289;5576.888462230814;5580.35825880029;5440.891182176413;5443.237946687388;5461.672299662033;5478.698671572943;5490;5219.616801547669;5306.787728490817;5476.972615136899;5480.835574932758;5490.286262785812;5477.589180811535;5499.3675727291875;5503.257060296809;5512.889742205213;5514.228008078952;5423.101914329953;5430.945690543202;5459.69971651563;5472.699001554953;5477.890442191214 19:27:38 INFO - PROCESS | 3386 | |5;yui.html;750.2347605442449;758.0978635423842;787.9290863822255;812.4150611559675;887.1572006593738;15441.922790386046;15938.20308984549;16561.17194140293;16566;16610.999999999985;14349.713005739879;14457.277136143204;14488.20314882681;14503.492377766781;14523.709525809503;653.4413076819322;796.3867821777213;819.0949001353508;822.6709316273478;822.7408366364606;771.3751860992586;818.7380038387719;820.0323618130603;821.57278215328;823.1028179284579;858.4505916213628;859.1194026123211;862.7584276402617;863.4560227056977;864.3215076165211;670.3531092495765;853.38129855854;854.086127843208;854.4403415762686;854.4830377621543;583.9182514447981;615.3784677475737;616.0266778489976;617.1236843681983;617.1298469158465;14872.702545949129;14991.625209369744;14992.325345359484;15013.699726005529;15108.622284442867;14063.226522541256;14570.854291457163;14755.409783608642;14795.038322509003;15244.618884527865;12999.090063695545;13489.258090805002;13595.932020339935;13608.931955340258;13967.37146828385;3777.981110094432;4434.445694288214;4457.48738895028;4461.665375096881;4550.68145229834;76438.61780691061;77005;77191.61404192999;77310.84033739498;77556;10853.34879907208;10882.455877206108;10975.396353200491;11159.442027898735;11171.329720216812;19391.12739926707;19502.12240449183;19504.70742938857;19517.51206219856;19551;8357.206065423776;8361.414700970996;8380.24577788002;8399.076101628816;8759.562021898879;4337.544557821447;4362.236608593484;4431.290993441034;4477.910441791146;4550.0899820035465;3059.831709255968;3081.645610754747;3098.5352197170605;3112.14416035592;3115.2679120406688;553.485258709396;564.5709260961698;568.883378907323;571.7170000849522;580.6748220996171;695.7356204642203;746.8506298740274;770.5723323555369;773.389022672094;783.3380793229826;9933.552990115462;10618.946905265424;10644.893551064544;10739.83890241647;10913.563457461612;623.5912101442756;689.3588962265142;710.4387533848202;737.7307282841724;746.7013194722155;4692.366530518337;5034;5110.872228194251;5121.692698438105;5131.79472821083;120740;120973.79026209802;125427;126293;129427.35286323697;67580.66209668921;88741;109273.45363273133;110505.44747276213;110611.44694276477;53059.73470132702;54917.45082549203;62821.68589157025;82795.5860220695;84111.5794421024;9695.757606059622;10490.265681402228;10531.47097773675;10730.8926910733;10985.176111791807;50323;50999.49000509948;51239.743801280754;52089.218661719344;52568;67579;68378;68623.65688171527;75970.24029759632;75981.62009189918;12436.75126497447;12458.875411245772;12797.232166070065;13740.10689305192;14145.292735362986;15761.211939402754;15873.761893571836;15885.523434296989;16579.834201657828;16712.582185445463;14817.185054822088;14861.225611431626;15239.3904243829;15724.68550629004;16062;13119.475220991053;13882.86117138856;14334.996550241383;14660.413583456542;14901.41336590447;14648.414063437343;15047.924760376129;15233.238338083273;15406.460773872861;15789.447369342477;11399.487023084146;11675.241109327866;11774;11843.822342664695;12013.75972480563;12081.275123492618;12440.315782632042;12591.663209249373;12996.610101696964;13023.739525209632 19:27:38 INFO - PROCESS | 3386 | __end_tp_report 19:27:38 INFO - PROCESS | 3386 | __start_cc_report 19:27:38 INFO - PROCESS | 3386 | _x_x_mozilla_cycle_collect,973 19:27:38 INFO - PROCESS | 3386 | __end_cc_report 19:27:38 INFO - PROCESS | 3386 | __startTimestamp1470104858459__endTimestamp 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | ------- Summary: start ------- 19:27:38 INFO - PROCESS | 3386 | Number of tests: 6 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | [#0] dojo.html Cycles:165 Average:5364.20 Median:5566.36 stddev:612.43 (11.0%) stddev-sans-first:586.97 19:27:38 INFO - PROCESS | 3386 | Values: 3057.6 3067.4 3073.7 3101.4 3111.3 5265.7 5321.8 5332.6 5388.4 5416.5 5383.2 5395.6 5451.0 5458.0 5483.9 4860.1 4885.1 4957.7 4959.8 5032.8 4947.4 4974.2 4990.1 5008.9 5009.0 4832.7 4856.9 4872.6 4884.4 4976.4 4860.6 4863.4 4873.8 4955.4 4962.9 4896.8 4898.8 4921.6 4941.5 4971.6 5219.3 5318.8 5414.2 5468.6 5474.2 5724.9 5771.1 5823.7 5835.4 5836.0 5831.5 5867.0 5905.3 5906.4 5907.8 5230.0 5340.1 5377.8 5464.2 5472.3 5904.4 5906.4 5954.6 6003.5 6019.4 5691.4 5697.6 5706.4 5707.2 5709.1 5529.7 5607.9 5672.1 5834.9 5840.9 5671.8 5677.4 5686.3 5733.2 5740.3 5637.3 5692.5 5699.6 5710.9 5716.0 4294.6 4363.0 4382.1 4384.7 4403.8 3922.9 3937.2 3968.8 3989.6 4016.7 5438.4 5456.3 5461.8 5480.0 5482.4 5596.3 5736.1 5808.9 5813.9 5863.9 5452.7 5503.1 5554.6 5559.8 5562.2 5029.0 5030.7 5032.9 5037.4 5071.3 5768.9 5990.8 6057.7 6057.8 6058.3 5705.9 5749.4 5753.6 5794.9 5846.2 6006.3 6013.2 6013.6 6018.3 6022.8 5508.5 5654.9 5702.1 5710.2 5718.6 5641.7 5702.3 5713.7 5760.8 5811.6 5571.7 5604.9 5611.1 5618.9 5619.3 5418.7 5597.2 5604.7 5610.0 5612.7 5567.0 5610.1 5619.0 5653.3 5694.5 5687.9 5690.4 5746.4 5749.7 5751.7 5353.3 5549.6 5560.6 5565.6 5566.4 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | [#1] ext.html Cycles:180 Average:62959.60 Median:23707.42 stddev:129743.22 (547.3%) stddev-sans-first:130022.65 19:27:38 INFO - PROCESS | 3386 | Values: 577.4 591.0 619.0 620.1 638.2 33206.8 33960.2 36233.3 36254.5 43959.6 43704.3 47674.8 47719.8 47766.3 47790.3 8995.4 9141.5 9145.4 9147.1 9150.5 9039.2 9127.5 9132.1 9136.4 9137.7 9174.9 9224.8 9230.6 9232.7 9235.0 9160.5 9207.5 9208.8 9218.3 9222.1 9040.2 9088.3 9090.4 9106.4 9108.0 43193.6 43605.0 43612.6 43621.6 43628.6 3541.8 3704.7 3801.9 3984.0 4480.0 32232.8 33207.0 33389.0 34477.2 34942.3 4257.7 4309.4 4314.5 4343.1 4439.2 337903.0 338181.0 339349.0 340223.3 342096.0 61249.1 61528.7 61564.0 61564.1 61631.4 37211.3 38064.0 38211.0 40136.6 64004.7 17781.0 17902.9 17919.9 17931.8 17934.7 12956.3 12969.7 12996.4 12997.5 13001.5 20040.8 20149.5 20202.9 20305.2 20328.3 7260.0 7448.4 7542.0 7585.0 7637.2 885.9 938.7 1025.7 1027.4 1093.6 34209.5 34789.7 34829.5 34894.8 34933.0 1091.4 1129.0 1144.3 1148.8 1176.9 17918.7 17995.0 18158.2 18188.8 18215.9 520360.0 572521.0 581919.0 582076.0 839508.0 63324.7 64147.0 64181.0 64216.7 64290.7 1242.7 1324.7 1354.7 1356.9 1379.2 31192.0 35010.0 35174.3 35443.6 35644.8 52108.5 52704.2 52800.2 52976.2 53056.7 443790.0 445170.7 447181.0 447265.0 448900.0 26253.6 26448.0 29748.0 30445.7 30840.7 49540.8 49746.5 49887.3 49926.0 51407.5 41990.6 42521.8 43100.4 44410.3 44494.1 41840.6 41912.4 42483.4 42847.8 44020.8 36350.3 42847.6 43888.6 44348.3 44523.3 34537.8 38082.4 38230.6 38814.8 38882.3 29560.3 29575.9 29713.9 30088.5 30092.4 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | [#2] jquery.html Cycles:180 Average:27061.53 Median:23929.76 stddev:69196.43 (289.2%) stddev-sans-first:69361.57 19:27:38 INFO - PROCESS | 3386 | Values: 391.4 391.5 397.4 402.2 422.0 12930.7 18650.3 20036.8 20120.6 20129.7 18766.7 19355.7 19475.4 19828.8 19847.4 5785.2 5981.9 5986.9 5992.8 6008.5 5880.1 5950.8 5960.5 5963.0 5964.1 4306.1 6365.7 6609.5 6696.3 6783.8 6532.4 6566.0 6686.4 6767.9 6774.9 5844.6 5891.2 5908.3 5913.8 5915.6 23287.9 23732.4 23838.4 23843.0 24016.5 2366.4 2427.6 2506.6 2827.4 3025.8 10362.3 10374.0 10545.6 11009.1 11062.9 1943.7 1980.4 2015.0 2047.2 2059.7 54339.7 79993.0 81095.0 83192.6 83583.6 10651.3 10854.6 11176.0 11470.8 12398.0 15885.0 15940.8 15965.4 15983.8 15995.3 7840.6 8164.7 8271.7 8361.8 8414.2 7586.2 7992.4 8043.7 8241.9 8252.8 4832.9 4845.7 4919.7 5031.1 5059.7 1911.9 1946.5 2007.8 2024.9 2033.7 973.6 975.6 987.7 1003.2 1019.0 19293.3 19394.9 20010.8 20033.4 20090.8 981.5 996.3 1000.0 1013.5 1017.1 10549.8 11209.4 11228.9 11250.6 11278.9 368166.0 377289.0 379626.0 469662.0 473859.0 90684.3 93183.0 94026.5 96831.5 100471.5 1000.4 1025.0 1063.0 1063.3 1064.4 17392.9 17674.8 18231.2 18448.7 18523.8 41610.0 42545.0 42567.6 42606.8 42844.6 59259.7 60303.0 60449.0 62461.1 62499.1 8298.2 8368.8 8425.1 8431.4 8842.9 12529.9 13065.7 13110.7 13119.9 13350.3 11188.4 11220.4 11740.2 11762.9 11868.8 10375.2 10378.2 11121.6 11316.9 11392.3 10958.1 11609.7 11825.9 11942.7 12160.8 7610.7 7828.5 8018.8 8217.4 8566.9 11267.3 11474.0 11565.9 11755.6 11860.6 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | [#3] mootools.html Cycles:180 Average:5984.60 Median:4631.13 stddev:3476.67 (75.1%) stddev-sans-first:3468.59 19:27:38 INFO - PROCESS | 3386 | Values: 1299.1 1466.5 1526.6 1663.5 1805.0 8217.4 8483.3 8513.4 8782.7 8792.5 8675.1 8814.0 8816.9 8818.6 8822.3 2413.1 2430.5 2432.6 2432.7 2435.3 2316.6 2368.9 2376.3 2377.2 2379.1 2380.3 2390.5 2397.1 2418.0 2427.5 2275.2 2296.8 2297.7 2305.3 2326.7 2238.1 2246.5 2246.7 2248.0 2251.5 8749.5 8811.7 8813.1 8816.7 8907.1 5337.7 5516.4 5524.9 5538.9 5544.7 3316.4 3334.3 3397.9 3412.8 3419.1 1094.8 1107.4 1112.1 1116.3 1129.1 12934.4 13002.3 13008.5 13025.0 13049.1 4366.1 4618.4 4643.9 4726.6 4735.0 10036.0 10072.8 10080.7 10086.2 10089.6 5323.9 5325.9 5326.4 5332.2 5338.6 4408.9 4768.5 4933.5 4976.4 4982.4 3874.2 3892.5 3952.2 3991.2 3993.4 1112.5 1117.2 1130.0 1130.7 1137.5 885.4 977.2 981.6 998.3 1007.2 6168.0 6171.3 6197.8 6334.1 6339.8 975.7 988.3 990.9 1023.3 1036.4 4012.1 4064.9 4233.1 4301.9 4350.6 11454.9 11662.9 11748.4 11778.2 11793.2 11439.5 11678.2 11771.0 11777.2 11869.9 8536.7 8614.9 8652.3 8656.7 8658.5 6169.8 6275.3 6303.0 6392.1 6529.2 10696.4 10835.0 10920.5 10920.6 10942.1 10763.6 10838.3 10901.6 10917.3 11052.2 7216.5 7420.3 7427.4 7771.0 7916.2 8587.9 8738.0 8821.4 9048.6 9085.0 7780.6 8054.4 8106.4 8171.3 8341.5 7905.8 7946.8 8012.6 8055.6 8062.4 7397.6 7427.1 7489.7 7499.7 7501.3 5246.8 5250.4 5308.5 5416.9 5443.4 5167.4 5241.9 5335.2 5336.3 5379.9 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | [#4] prototype.html Cycles:180 Average:4602.26 Median:5306.00 stddev:1357.64 (25.6%) stddev-sans-first:1322.78 19:27:38 INFO - PROCESS | 3386 | Values: 315.7 320.5 328.4 329.4 331.0 5234.4 5283.7 5284.9 5305.2 5331.5 4991.0 5049.1 5055.4 5124.4 5239.9 3968.7 3982.2 4037.3 4086.7 4142.0 4082.3 4093.4 4098.5 4116.0 4142.3 3908.1 4079.2 4085.2 4088.4 4117.0 4061.0 4068.8 4088.6 4091.4 4094.9 3588.9 3589.8 3619.5 3619.9 3623.6 4867.6 5141.8 5153.4 5156.5 5165.1 4605.5 4641.3 4649.5 4651.0 4655.6 5442.2 5445.1 5450.1 5481.3 5496.7 3838.8 3925.9 3929.4 3942.0 3949.6 5598.2 5636.5 5686.5 5695.5 5710.0 3888.7 3896.7 3904.7 3911.9 3928.8 3961.6 3963.6 3977.6 3993.6 3998.0 4495.6 4542.2 4548.7 4567.2 4612.3 5430.0 5435.2 5437.3 5443.2 5445.2 1312.9 1370.2 1374.6 1381.1 1382.0 930.5 940.8 957.5 960.8 964.7 5252.2 5275.5 5284.0 5285.5 5293.5 5563.8 5566.0 5567.5 5572.7 5604.5 5117.8 5325.8 5328.7 5329.4 5387.4 2920.4 2929.1 2956.1 2965.8 2977.8 5692.3 5714.6 5777.3 5843.5 5856.3 5672.4 5686.9 5712.3 5714.4 5728.9 5790.9 5793.2 5813.7 5842.6 5869.8 5392.8 5520.2 5533.9 5569.3 5577.2 5471.2 5540.3 5551.8 5554.3 5619.7 5597.4 5750.9 5830.2 5838.0 5838.4 3976.1 3991.4 3992.8 3995.8 4020.1 5527.8 5538.1 5587.9 5599.2 5641.0 5311.6 5456.9 5480.9 5576.9 5580.4 5440.9 5443.2 5461.7 5478.7 5490.0 5219.6 5306.8 5477.0 5480.8 5490.3 5477.6 5499.4 5503.3 5512.9 5514.2 5423.1 5430.9 5459.7 5472.7 5477.9 19:27:38 INFO - PROCESS | 3386 | 19:27:38 INFO - PROCESS | 3386 | [#5] yui.html Cycles:180 Average:20699.88 Median:3446.62 stddev:29743.82 (863.0%) stddev-sans-first:29789.54 19:27:38 INFO - PROCESS | 3386 | Values: 750.2 758.1 787.9 812.4 887.2 15441.9 15938.2 16561.2 16566.0 16611.0 14349.7 14457.3 14488.2 14503.5 14523.7 653.4 796.4 819.1 822.7 822.7 771.4 818.7 820.0 821.6 823.1 858.5 859.1 862.8 863.5 864.3 670.4 853.4 854.1 854.4 854.5 583.9 615.4 616.0 617.1 617.1 14872.7 14991.6 14992.3 15013.7 15108.6 14063.2 14570.9 14755.4 14795.0 15244.6 12999.1 13489.3 13595.9 13608.9 13967.4 3778.0 4434.4 4457.5 4461.7 4550.7 76438.6 77005.0 77191.6 77310.8 77556.0 10853.3 10882.5 10975.4 11159.4 11171.3 19391.1 19502.1 19504.7 19517.5 19551.0 8357.2 8361.4 8380.2 8399.1 8759.6 4337.5 4362.2 4431.3 4477.9 4550.1 3059.8 3081.6 3098.5 3112.1 3115.3 553.5 564.6 568.9 571.7 580.7 695.7 746.9 770.6 773.4 783.3 9933.6 10618.9 10644.9 10739.8 10913.6 623.6 689.4 710.4 737.7 746.7 4692.4 5034.0 5110.9 5121.7 5131.8 120740.0 120973.8 125427.0 126293.0 129427.4 67580.7 88741.0 109273.5 110505.4 110611.4 53059.7 54917.5 62821.7 82795.6 84111.6 9695.8 10490.3 10531.5 10730.9 10985.2 50323.0 50999.5 51239.7 52089.2 52568.0 67579.0 68378.0 68623.7 75970.2 75981.6 12436.8 12458.9 12797.2 13740.1 14145.3 15761.2 15873.8 15885.5 16579.8 16712.6 14817.2 14861.2 15239.4 15724.7 16062.0 13119.5 13882.9 14335.0 14660.4 14901.4 14648.4 15047.9 15233.2 15406.5 15789.4 11399.5 11675.2 11774.0 11843.8 12013.8 12081.3 12440.3 12591.7 12996.6 13023.7 19:27:38 INFO - PROCESS | 3386 | -------- Summary: end -------- 19:27:38 INFO - PROCESS | 3386 | 19:27:39 INFO - TEST-INFO | 3386: exit 0 19:27:39 INFO - TEST-OK | dromaeo_css | took 1116089ms 19:27:39 INFO - TEST-START | kraken 19:27:39 INFO - operating with platform_type : linux_ 19:27:39 INFO - Initialising browser for kraken test... 19:27:39 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTfNd8/profile http://localhost:44185/getInfo.html) 19:27:43 INFO - PROCESS | 3574 | __metrics Screen width/height:1600/1200 19:27:43 INFO - PROCESS | 3574 | colorDepth:24 19:27:43 INFO - PROCESS | 3574 | Browser inner width/height: 1024/697 19:27:43 INFO - PROCESS | 3574 | __metrics 19:27:43 INFO - PROCESS | 3574 | 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" 19:27:43 INFO - PROCESS | 3574 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:44 INFO - TEST-INFO | 3574: exit 0 19:27:44 INFO - Browser initialized. 19:27:44 INFO - Running cycle 1/1 for kraken test... 19:27:44 INFO - TEST-INFO | started process 3653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTfNd8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:56 INFO - PROCESS | 3653 | RSS: Main: 156180480 19:27:56 INFO - PROCESS | 3653 | 19:27:59 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44185/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:59 INFO - PROCESS | 3653 | RSS: Main: 212414464 19:27:59 INFO - PROCESS | 3653 | 19:28:02 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44185/tests/kraken/driver.html?testName=audio-dft) 19:28:03 INFO - PROCESS | 3653 | RSS: Main: 191217664 19:28:03 INFO - PROCESS | 3653 | 19:28:06 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44185/tests/kraken/driver.html?testName=audio-fft) 19:28:06 INFO - PROCESS | 3653 | RSS: Main: 269352960 19:28:06 INFO - PROCESS | 3653 | 19:28:08 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44185/tests/kraken/driver.html?testName=audio-oscillator) 19:28:09 INFO - PROCESS | 3653 | RSS: Main: 179257344 19:28:09 INFO - PROCESS | 3653 | 19:28:11 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:12 INFO - PROCESS | 3653 | RSS: Main: 183902208 19:28:12 INFO - PROCESS | 3653 | 19:28:15 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44185/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:15 INFO - PROCESS | 3653 | RSS: Main: 218992640 19:28:15 INFO - PROCESS | 3653 | 19:28:19 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44185/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:19 INFO - PROCESS | 3653 | RSS: Main: 220119040 19:28:19 INFO - PROCESS | 3653 | 19:28:22 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44185/tests/kraken/driver.html?testName=json-parse-financial) 19:28:23 INFO - PROCESS | 3653 | RSS: Main: 219869184 19:28:23 INFO - PROCESS | 3653 | 19:28:24 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:25 INFO - PROCESS | 3653 | RSS: Main: 183767040 19:28:25 INFO - PROCESS | 3653 | 19:28:27 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:27 INFO - PROCESS | 3653 | RSS: Main: 189321216 19:28:27 INFO - PROCESS | 3653 | 19:28:30 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:30 INFO - PROCESS | 3653 | RSS: Main: 193605632 19:28:30 INFO - PROCESS | 3653 | 19:28:33 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:34 INFO - PROCESS | 3653 | RSS: Main: 188428288 19:28:34 INFO - PROCESS | 3653 | 19:28:36 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:37 INFO - PROCESS | 3653 | RSS: Main: 192520192 19:28:37 INFO - PROCESS | 3653 | 19:28:38 INFO - PROCESS | 3653 | Cycle 1(1): loaded http://localhost:44185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44185/tests/kraken/driver.html?testName=ai-astar) 19:28:39 INFO - PROCESS | 3653 | RSS: Main: 242991104 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | __start_tp_report 19:28:39 INFO - PROCESS | 3653 | _x_x_mozilla_page_load 19:28:39 INFO - PROCESS | 3653 | _x_x_mozilla_page_load_details 19:28:39 INFO - PROCESS | 3653 | |i|pagename|runs| 19:28:39 INFO - PROCESS | 3653 | |0;ai-astar;102;113;111;111;111;114;111;113;113;110 19:28:39 INFO - PROCESS | 3653 | |1;audio-beat-detection;144;122;120;181;124;120;141;117;151;119 19:28:39 INFO - PROCESS | 3653 | |2;audio-dft;163;161;161;161;160;161;163;161;162;161 19:28:39 INFO - PROCESS | 3653 | |3;audio-fft;74;76;74;108;75;76;74;74;98;75 19:28:39 INFO - PROCESS | 3653 | |4;audio-oscillator;83;84;114;84;85;84;117;83;84;136 19:28:39 INFO - PROCESS | 3653 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;116 19:28:39 INFO - PROCESS | 3653 | |6;imaging-darkroom;146;146;145;145;146;145;145;146;146;145 19:28:39 INFO - PROCESS | 3653 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;96 19:28:39 INFO - PROCESS | 3653 | |8;json-parse-financial;51;55;53;50;53;53;50;50;49;50 19:28:39 INFO - PROCESS | 3653 | |9;json-stringify-tinderbox;61;60;61;60;60;61;60;60;60;60 19:28:39 INFO - PROCESS | 3653 | |10;stanford-crypto-aes;75;76;74;85;81;75;75;85;74;84 19:28:39 INFO - PROCESS | 3653 | |11;stanford-crypto-ccm;124;120;127;119;121;130;118;118;165;133 19:28:39 INFO - PROCESS | 3653 | |12;stanford-crypto-pbkdf2;156;164;156;155;155;160;160;161;155;159 19:28:39 INFO - PROCESS | 3653 | |13;stanford-crypto-sha256-iterative;63;62;64;63;62;62;62;63;61;65 19:28:39 INFO - PROCESS | 3653 | __end_tp_report 19:28:39 INFO - PROCESS | 3653 | __start_cc_report 19:28:39 INFO - PROCESS | 3653 | _x_x_mozilla_cycle_collect,1672 19:28:39 INFO - PROCESS | 3653 | __end_cc_report 19:28:39 INFO - PROCESS | 3653 | __startTimestamp1470104919199__endTimestamp 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | ------- Summary: start ------- 19:28:39 INFO - PROCESS | 3653 | Number of tests: 14 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.38 (3.0%) stddev-sans-first:1.36 19:28:39 INFO - PROCESS | 3653 | Values: 102.0 113.0 111.0 111.0 111.0 114.0 111.0 113.0 113.0 110.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:132.50 stddev:20.54 (15.5%) stddev-sans-first:21.46 19:28:39 INFO - PROCESS | 3653 | Values: 144.0 122.0 120.0 181.0 124.0 120.0 141.0 117.0 151.0 119.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 19:28:39 INFO - PROCESS | 3653 | Values: 163.0 161.0 161.0 161.0 160.0 161.0 163.0 161.0 162.0 161.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.17 (16.2%) stddev-sans-first:12.68 19:28:39 INFO - PROCESS | 3653 | Values: 74.0 76.0 74.0 108.0 75.0 76.0 74.0 74.0 98.0 75.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:19.43 (23.1%) stddev-sans-first:20.08 19:28:39 INFO - PROCESS | 3653 | Values: 83.0 84.0 114.0 84.0 85.0 84.0 117.0 83.0 84.0 136.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:28:39 INFO - PROCESS | 3653 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:28:39 INFO - PROCESS | 3653 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:28:39 INFO - PROCESS | 3653 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:1.96 (3.8%) stddev-sans-first:2.07 19:28:39 INFO - PROCESS | 3653 | Values: 51.0 55.0 53.0 50.0 53.0 53.0 50.0 50.0 49.0 50.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 19:28:39 INFO - PROCESS | 3653 | Values: 61.0 60.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:4.77 (6.1%) stddev-sans-first:4.89 19:28:39 INFO - PROCESS | 3653 | Values: 75.0 76.0 74.0 85.0 81.0 75.0 75.0 85.0 74.0 84.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:125.50 stddev:14.17 (11.3%) stddev-sans-first:14.97 19:28:39 INFO - PROCESS | 3653 | Values: 124.0 120.0 127.0 119.0 121.0 130.0 118.0 118.0 165.0 133.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:159.50 stddev:3.14 (2.0%) stddev-sans-first:3.24 19:28:39 INFO - PROCESS | 3653 | Values: 156.0 164.0 156.0 155.0 155.0 160.0 160.0 161.0 155.0 159.0 19:28:39 INFO - PROCESS | 3653 | 19:28:39 INFO - PROCESS | 3653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 19:28:39 INFO - PROCESS | 3653 | Values: 63.0 62.0 64.0 63.0 62.0 62.0 62.0 63.0 61.0 65.0 19:28:39 INFO - PROCESS | 3653 | -------- Summary: end -------- 19:28:39 INFO - PROCESS | 3653 | 19:28:40 INFO - TEST-INFO | 3653: exit 0 19:28:40 INFO - TEST-OK | kraken | took 61038ms 19:28:40 INFO - SUITE-END | took 1177s 19:28:40 INFO - Completed test suite (00:19:37) 19:28:40 INFO - javascript benchmark 19:28:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.6025116734822, 3067.355855270393, 3073.6926307369267, 3101.3952279305518, 3111.346617210386, 5265.710385928773, 5321.813736519222, 5332.600054995876, 5388.353397592289, 5416.4854338837795, 5383.246345511631, 5395.568354531628, 5451.018816613008, 5458.0, 5483.917741233875, 4860.052289803499, 4885.096257192413, 4957.727324997124, 4959.752012399384, 5032.849014529552, 4947.356843610326, 4974.179260422026, 4990.126727822635, 5008.874778130557, 5009.0, 4832.661713680061, 4856.902861942742, 4872.610191184732, 4884.389451318585, 4976.377952755905, 4860.562549370574, 4863.416390033219, 4873.780679869415, 4955.430125535538, 4962.9007419851405, 4896.828610998634, 4898.779554920037, 4921.557059864629, 4941.45643979162, 4971.577415919651, 5219.269302297681, 5318.840434786963, 5414.214938833847, 5468.562514998791, 5474.206240095204, 5724.885502289931, 5771.134329850556, 5823.708814559255, 5835.44563266489, 5836.007878660595, 5831.504322132624, 5867.0, 5905.320888097881, 5906.379830117861, 5907.822765317047, 5230.032443997872, 5340.145576707786, 5377.7580008899695, 5464.180372944051, 5472.343318801769, 5904.380040095728, 5906.350301466835, 5954.55340849438, 6003.549733769984, 6019.428154325332, 5691.373948865621, 5697.6296540724725, 5706.3722990471015, 5707.1724599933605, 5709.143628455682, 5529.723513824292, 5607.859803504945, 5672.12082127271, 5834.883302333929, 5840.88318233633, 5671.829845104653, 5677.403872593401, 5686.34607020198, 5733.226014488074, 5740.282464691913, 5637.267155269788, 5692.48767610917, 5699.572532060112, 5710.942890571041, 5715.971420142956, 4294.613484786321, 4362.978185109054, 4382.07976324969, 4384.671149663788, 4403.757793321398, 3922.921541569153, 3937.1535119948776, 3968.7817170055346, 3989.58109398509, 4016.6987475938836, 5438.428964958702, 5456.317960254968, 5461.808836690697, 5479.972600136974, 5482.396936337, 5596.300462442195, 5736.110902810071, 5808.912866307009, 5813.88372232553, 5863.912041319383, 5452.672839629635, 5503.147012213113, 5554.583406244547, 5559.833205003856, 5562.16567514876, 5028.974855125774, 5030.673006254582, 5032.874178145503, 5037.370328708911, 5071.264666623393, 5768.913466297925, 5990.820275391745, 6057.697115144137, 6057.8485537861025, 6058.333583305833, 5705.885882282414, 5749.367569567261, 5753.597248192586, 5794.855128621818, 5846.239988801429, 6006.309274433496, 6013.158157857816, 6013.609115407485, 6018.307894592002, 6022.849428764316, 5508.531774799187, 5654.915176272441, 5702.116171993348, 5710.200571919851, 5718.599698021098, 5641.689707066151, 5702.287214098238, 5713.742881570256, 5760.798372056958, 5811.593188476766, 5571.693556854412, 5604.8879022418505, 5611.074172761612, 5618.887622247614, 5619.297587801525, 5418.674879507243, 5597.216389705363, 5604.663720176639, 5610.0, 5612.747426365905, 5566.972165139148, 5610.102383618601, 5619.044762390322, 5653.293338332708, 5694.487496125369, 5687.943120568907, 5690.430956904276, 5746.42535746422, 5749.683767392834, 5751.7411716472025, 5353.2773075634295, 5549.5837812163445, 5560.5551555876245, 5565.6104072714525, 5566.359868615161], "value": 5322.407614087485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3620149734543, 590.9645421274722, 619.0, 620.1070458539702, 638.1512588257618, 33206.83396583017, 33960.15099622511, 36233.27533449329, 36254.45618315724, 43959.56040439595, 43704.3444348335, 47674.76162619182, 47719.761401193035, 47766.283505747444, 47790.283145752845, 8995.370324077334, 9141.542922853863, 9145.405548639317, 9147.085291470867, 9150.49672268025, 9039.186473217409, 9127.543622818832, 9132.132447417485, 9136.406133601327, 9137.68018119366, 9174.86237706435, 9224.769380765467, 9230.630774769035, 9232.67685631003, 9235.0, 9160.496172710498, 9207.539623018889, 9208.815823683522, 9218.262538996863, 9222.123898229658, 9040.186383225542, 9088.272938164997, 9090.363674542785, 9106.40808347462, 9108.0, 43193.56806431927, 43605.0, 43612.6013069281, 43621.563784362064, 43628.56371436277, 3541.752077354586, 3704.722145839046, 3801.9429708554394, 3984.008481251565, 4479.9552004479865, 32232.83883580567, 33207.0, 33389.0, 34477.24182065454, 34942.30115397703, 4257.680673949466, 4309.35359696045, 4314.482262128533, 4343.131373725268, 4439.156560253574, 337903.0, 338181.0, 339349.0, 340223.29888350645, 342096.0, 61249.08126378108, 61528.69235653883, 61564.0, 61564.07653885195, 61631.38368616346, 37211.25577488489, 38064.0, 38211.0, 40136.59863401387, 64004.67997659982, 17781.0, 17902.91048544749, 17919.910400447916, 17931.820681793015, 17934.730979035325, 12956.28740419286, 12969.675758105934, 12996.415161317764, 12997.545085921947, 13001.544945926848, 20040.799592003892, 20149.49626259326, 20202.898985504977, 20305.187792488134, 20328.288509902377, 7260.0, 7448.366888814403, 7541.962290188514, 7584.962075189589, 7637.15991240963, 885.8671199320024, 938.7043081429327, 1025.7179275699093, 1027.445179603021, 1093.6336327330275, 34209.48685769716, 34789.652103479144, 34829.47755783665, 34894.825525872206, 34933.0, 1091.4433638844246, 1128.9830652540218, 1144.3076938452282, 1148.8391625172483, 1176.8705442401329, 17918.731219031724, 17995.0, 18158.182881770354, 18188.818111818713, 18215.908920455313, 520360.0, 572521.0, 581919.0, 582076.0, 839508.0, 63324.68337658282, 64147.0, 64181.0, 64216.67891660512, 64290.6785466079, 1242.67069226655, 1324.6953200763878, 1354.7019655675933, 1356.87109724576, 1379.1793882639813, 31192.0, 35010.0, 35174.29651407008, 35443.64556354507, 35644.82177589095, 52108.478915211876, 52704.20943685771, 52800.20799688085, 52976.20535691891, 53056.73471632617, 443790.0, 445170.741462932, 447181.0, 447265.0, 448900.0, 26253.606195906694, 26448.0, 29748.0, 30445.69554304517, 30840.691593083782, 49540.75229623829, 49746.50253497563, 49887.251691225385, 49926.0, 51407.485925141766, 41990.58009419867, 42521.787391064085, 43100.353494696974, 44410.333844992994, 44494.11011779811, 41840.581594184885, 41912.371314430915, 42483.3627495594, 42847.785761071, 44020.77989610031, 36350.27299454049, 42847.57152428436, 43888.561114388445, 44348.33477497775, 44523.33215001713, 34537.827310863286, 38082.428763568016, 38230.61769382271, 38814.80592597132, 38882.25865245881, 29560.260993475335, 29575.89453107393, 29713.851430742707, 30088.548671769502, 30092.398152037276], "value": 20621.11120822804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.3835708758704, 391.49692644951244, 397.3959581436218, 402.23775944585014, 422.0040703938704, 12930.74138517229, 18650.253989840407, 20036.797792132482, 20120.59758804823, 20129.698054529195, 18766.71849922249, 19355.709664355047, 19475.415737527863, 19828.801711982876, 19847.40457786265, 5785.16115163301, 5981.940180598203, 5986.8802623947495, 5992.820215393545, 6008.519318454513, 5880.088586269114, 5950.821475355725, 5960.52315814736, 5963.0, 5964.105384192362, 4306.138772245547, 6365.681715914209, 6609.504287178457, 6696.330366963289, 6783.7625683101105, 6532.444742196943, 6566.047923051178, 6686.364795344434, 6767.932320676804, 6774.916013437851, 5844.561657875676, 5891.234139561872, 5908.320543137551, 5913.822585322404, 5915.556333275022, 23287.883560582257, 23732.40668983272, 23838.404039898967, 23843.0, 24016.519669606685, 2366.372911178539, 2427.5873101572774, 2506.5989441689426, 2827.377976845091, 3025.788194826363, 10362.27464077515, 10374.0, 10545.630902918438, 11009.064229540418, 11062.889371106266, 1943.650142974264, 1980.386080315107, 2015.0, 2047.1811275489922, 2059.7322348094804, 54339.728301358635, 79992.99999999942, 81095.0, 83192.58403708003, 83583.5820820892, 10651.30766500175, 10854.6431696038, 11175.994160525592, 11470.76320117569, 12398.0, 15885.0, 15940.840591594168, 15965.44120955761, 15983.840161598468, 15995.280212390471, 7840.568768717661, 8164.67341306353, 8271.710490132817, 8361.832763344699, 8414.158584141536, 7586.24137586237, 7992.36061115121, 8043.718469853527, 8241.876371854427, 8252.8349433011, 4832.903341933142, 4845.709257444564, 4919.680220785637, 5031.144705400091, 5059.671121377099, 1911.8852868827914, 1946.532832120281, 2007.8293345065833, 2024.908879100444, 2033.7356143701224, 973.6494861849728, 975.6243846119295, 987.7333120057544, 1003.2124782046059, 1018.9962886556735, 19293.324733634254, 19394.903025485066, 20010.799892000894, 20033.398998030083, 20090.799092008892, 981.4847205217318, 996.272720913737, 1000.0499525450706, 1013.5135135135176, 1017.0693815159194, 10549.84175237372, 11209.439528023566, 11228.887711122785, 11250.606228781953, 11278.943605282086, 368166.0, 377289.0, 379626.0, 469662.0, 473859.0, 90684.27947161596, 93183.0, 94026.52986735023, 96831.51584242034, 100471.49764251131, 1000.4497526360473, 1024.9897501024893, 1063.0326402973258, 1063.2769716592636, 1064.414571985405, 17392.91303543525, 17674.823251767833, 18231.179596917904, 18448.723269151244, 18523.81476185221, 41610.0, 42545.0, 42567.57432425636, 42606.786966064974, 42844.57155428531, 59259.70370148294, 60303.0, 60449.0, 62461.06308405469, 62499.062514061414, 8298.21166989135, 8368.790780230544, 8425.073241943259, 8431.40980131385, 8842.867356989522, 12529.874701252871, 13065.673358166121, 13110.672233194246, 13119.934400327937, 13350.265735384259, 11188.384638844942, 11220.438978050901, 11740.236884602473, 11762.94118529402, 11868.762624747284, 10375.169986400919, 10378.169746420419, 11121.555137794721, 11316.886831131584, 11392.316461012366, 10958.12335013213, 11609.709757255798, 11825.940870295593, 11942.671179119989, 12160.75678486443, 7610.695572177051, 7828.4911480755845, 8018.8396232073865, 8217.424780265324, 8566.91433085661, 11267.323960562064, 11474.0, 11565.942170289094, 11755.647330580096, 11860.584879529175], "value": 9362.528594927531, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.1295831792697, 1466.5233799015318, 1526.5801904476268, 1663.5258951198903, 1805.0433270366702, 8217.424780265384, 8483.321334293258, 8513.361497887652, 8782.692605758799, 8792.51641159736, 8675.08911564286, 8813.95593022034, 8816.867746983784, 8818.603162857671, 8822.294216462684, 2413.070967677448, 2430.4774473488196, 2432.635104734295, 2432.6594276801175, 2435.2937648082034, 2316.6061769499224, 2368.917087901924, 2376.275236053003, 2377.239283429303, 2379.1435083369975, 2380.262118743195, 2390.486045500217, 2397.1490121007055, 2417.9965314394503, 2427.5023620157826, 2275.2264230161823, 2296.8277379196543, 2297.6553516972335, 2305.3084074777585, 2326.7091613548305, 2238.115944202031, 2246.51699884524, 2246.6742322363166, 2248.0445810530623, 2251.5046689728233, 8749.518776467292, 8811.691590794355, 8813.1186881312, 8816.691415800417, 8907.06475820036, 5337.653052551611, 5516.393196748354, 5524.917126243109, 5538.947599955995, 5544.695041772701, 3316.403047451458, 3334.2997970425995, 3397.8640854365794, 3412.8293585320635, 3419.128122328815, 1094.813881640123, 1107.4241394474827, 1112.1436493899732, 1116.3134672176552, 1129.1249281806665, 12934.35328233594, 13002.284874331908, 13008.479660813557, 13025.0, 13049.086563940433, 4366.126774645084, 4618.376519169936, 4643.883902902455, 4726.645501587394, 4735.029318989667, 10036.046575575308, 10072.798544029225, 10080.69757907264, 10086.243531735003, 10089.596416143419, 5323.920141197885, 5325.8934821303355, 5326.387465441524, 5332.173513105475, 5338.572914166935, 4408.867733967986, 4768.47546769855, 4933.531314525115, 4976.353074100344, 4982.402111746541, 3874.2445223181207, 3892.5134358205223, 3952.209558088394, 3991.16185601027, 3993.4409182714444, 1112.4548971004313, 1117.1509652664033, 1129.9661010169707, 1130.7455822439886, 1137.5449820071872, 885.406777459104, 977.1791694976112, 981.622075500923, 998.3261298623545, 1007.1992765751245, 6168.0, 6171.259448866075, 6197.845053873599, 6334.113224148623, 6339.841503962438, 975.6536429567543, 988.3328753091635, 990.9405435673883, 1023.2734758321675, 1036.383351905615, 4012.0972781124015, 4064.878053658395, 4233.089885674533, 4301.870943871689, 4350.564943505624, 11454.885451145548, 11662.94168529169, 11748.353840538852, 11778.175527713149, 11793.233439826385, 11439.542418303341, 11678.24091434054, 11771.0, 11777.234479758788, 11869.940650296694, 8536.74389768308, 8614.87077693835, 8652.264557512555, 8656.6537338507, 8658.48049117055, 6169.84575385619, 6275.309715931336, 6302.968485157545, 6392.137061496825, 6529.216494020748, 10696.358218506915, 10834.970677785597, 10920.453977301262, 10920.617778377718, 10942.069924056545, 10763.623273185402, 10838.295510791773, 10901.618443354444, 10917.290376125526, 11052.226344155832, 7216.530925489827, 7420.332170104716, 7427.368673662583, 7770.961145194238, 7916.247956444128, 8587.871181932402, 8738.0, 8821.426607270507, 9048.592813323285, 9084.954575227082, 7780.572068536285, 8054.436189466681, 8106.392020598597, 8171.264586187034, 8341.499510029418, 7905.802354941173, 7946.801329966797, 8012.599370031358, 8055.637496312797, 8062.355011599176, 7397.630118494161, 7427.071616047994, 7489.66296516669, 7499.66251518672, 7501.28737769911, 5246.790128394821, 5250.396204436386, 5308.495692909168, 5416.945830541644, 5443.374011988672, 5167.354080739908, 5241.947580524146, 5335.199720042025, 5336.306280183551, 5379.865503362291], "value": 4740.9455311742495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.65751159991424, 320.45682568047164, 328.3957518166573, 329.4350189425135, 330.9851056702448, 5234.371875374955, 5283.656562323451, 5284.943011397717, 5305.204219367087, 5331.493508116732, 4991.0, 5049.141645920193, 5055.393352797661, 5124.410692770332, 5239.86900327492, 3968.6626636735914, 3982.1637456134245, 4037.313656678372, 4086.693497987648, 4141.9585804142025, 4082.265192265391, 4093.359782940002, 4098.4876890388705, 4115.999999999985, 4142.337226043834, 3908.1011367385377, 4079.2045551117544, 4085.2442298174783, 4088.3867419886956, 4116.97941510292, 4060.9593904060876, 4068.755874647501, 4088.6115818997146, 4091.4067460218253, 4094.877153685379, 3588.856445742167, 3589.820508974567, 3619.529461170031, 3619.94570081449, 3623.61951995042, 4867.561919427269, 5141.845744627667, 5153.433122356538, 5156.484351564851, 5165.147750621143, 4605.516420775837, 4641.280601506772, 4649.511801260853, 4651.0, 4655.557722016403, 5442.210879422461, 5445.074337362658, 5450.127979523258, 5481.287432633732, 5496.6701997880255, 3838.7696738195796, 3925.862594809168, 3929.44987701722, 3941.989585311483, 3949.605039496056, 5598.2442370280305, 5636.534501029721, 5686.516646085088, 5695.515881150107, 5709.9714501427225, 3888.7361607477683, 3896.7077469189926, 3904.6919282040267, 3911.9022024449046, 3928.7839168845417, 3961.603839616015, 3963.564007959122, 3977.6475998160763, 3993.6421616650478, 3997.980010099989, 4495.550444955478, 4542.205114105019, 4548.727076375428, 4567.223571992703, 4612.262038073959, 5429.972850135724, 5435.157550579587, 5437.265969094122, 5443.237946687467, 5445.210444485528, 1312.9277889715966, 1370.184740079651, 1374.587623712902, 1381.1367895065584, 1382.0187666756715, 930.4835816121982, 940.8353538130937, 957.4781743949565, 960.841461158915, 964.6928412001777, 5252.238425428368, 5275.472452754694, 5283.996040752245, 5285.497877701612, 5293.523582877482, 5563.833085007456, 5566.0, 5567.47109024642, 5572.665640061609, 5604.542818867124, 5117.84848409105, 5325.760340784674, 5328.6802791832615, 5329.387120481194, 5387.380451248078, 2920.3867187890783, 2929.1359049080575, 2956.1427186115784, 2965.7756682488134, 2977.8064425812686, 5692.345380281238, 5714.571407144397, 5777.306723193244, 5843.532517398683, 5856.267966504187, 5672.432756724294, 5686.914696279559, 5712.257406537124, 5714.3999880012, 5728.914066289009, 5790.884182316414, 5793.2179155814265, 5813.651180929158, 5842.649441033552, 5869.7945571904775, 5392.811251606175, 5520.205933071848, 5533.916991245215, 5569.303837020372, 5577.247071645276, 5471.179323101566, 5540.279763630702, 5551.777928882961, 5554.278173766145, 5619.662820230799, 5597.44025597437, 5750.884982300414, 5830.154627579062, 5838.0, 5838.416158384128, 3976.1053762903116, 3991.3613821788376, 3992.820323085526, 3995.760254384746, 4020.0753826620626, 5527.798872856738, 5538.141588053858, 5587.860303492445, 5599.244102046172, 5640.971795141162, 5311.628186027096, 5456.890862182813, 5480.917786233289, 5576.888462230814, 5580.35825880029, 5440.891182176413, 5443.237946687388, 5461.672299662033, 5478.698671572943, 5490.0, 5219.616801547669, 5306.787728490817, 5476.972615136899, 5480.835574932758, 5490.286262785812, 5477.589180811535, 5499.3675727291875, 5503.257060296809, 5512.889742205213, 5514.228008078952, 5423.101914329953, 5430.945690543202, 5459.69971651563, 5472.699001554953, 5477.890442191214], "value": 4169.129313509389, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2347605442449, 758.0978635423842, 787.9290863822255, 812.4150611559675, 887.1572006593738, 15441.922790386046, 15938.20308984549, 16561.17194140293, 16566.0, 16610.999999999985, 14349.713005739879, 14457.277136143204, 14488.20314882681, 14503.492377766781, 14523.709525809503, 653.4413076819322, 796.3867821777213, 819.0949001353508, 822.6709316273478, 822.7408366364606, 771.3751860992586, 818.7380038387719, 820.0323618130603, 821.57278215328, 823.1028179284579, 858.4505916213628, 859.1194026123211, 862.7584276402617, 863.4560227056977, 864.3215076165211, 670.3531092495765, 853.38129855854, 854.086127843208, 854.4403415762686, 854.4830377621543, 583.9182514447981, 615.3784677475737, 616.0266778489976, 617.1236843681983, 617.1298469158465, 14872.702545949129, 14991.625209369744, 14992.325345359484, 15013.699726005529, 15108.622284442867, 14063.226522541256, 14570.854291457163, 14755.409783608642, 14795.038322509003, 15244.618884527865, 12999.090063695545, 13489.258090805002, 13595.932020339935, 13608.931955340258, 13967.37146828385, 3777.981110094432, 4434.445694288214, 4457.48738895028, 4461.665375096881, 4550.68145229834, 76438.61780691061, 77005.0, 77191.61404192999, 77310.84033739498, 77556.0, 10853.34879907208, 10882.455877206108, 10975.396353200491, 11159.442027898735, 11171.329720216812, 19391.12739926707, 19502.12240449183, 19504.70742938857, 19517.51206219856, 19551.0, 8357.206065423776, 8361.414700970996, 8380.24577788002, 8399.076101628816, 8759.562021898879, 4337.544557821447, 4362.236608593484, 4431.290993441034, 4477.910441791146, 4550.0899820035465, 3059.831709255968, 3081.645610754747, 3098.5352197170605, 3112.14416035592, 3115.2679120406688, 553.485258709396, 564.5709260961698, 568.883378907323, 571.7170000849522, 580.6748220996171, 695.7356204642203, 746.8506298740274, 770.5723323555369, 773.389022672094, 783.3380793229826, 9933.552990115462, 10618.946905265424, 10644.893551064544, 10739.83890241647, 10913.563457461612, 623.5912101442756, 689.3588962265142, 710.4387533848202, 737.7307282841724, 746.7013194722155, 4692.366530518337, 5034.0, 5110.872228194251, 5121.692698438105, 5131.79472821083, 120740.0, 120973.79026209802, 125427.0, 126293.0, 129427.35286323697, 67580.66209668921, 88741.0, 109273.45363273133, 110505.44747276213, 110611.44694276477, 53059.73470132702, 54917.45082549203, 62821.68589157025, 82795.5860220695, 84111.5794421024, 9695.757606059622, 10490.265681402228, 10531.47097773675, 10730.8926910733, 10985.176111791807, 50323.0, 50999.49000509948, 51239.743801280754, 52089.218661719344, 52568.0, 67579.0, 68378.0, 68623.65688171527, 75970.24029759632, 75981.62009189918, 12436.75126497447, 12458.875411245772, 12797.232166070065, 13740.10689305192, 14145.292735362986, 15761.211939402754, 15873.761893571836, 15885.523434296989, 16579.834201657828, 16712.582185445463, 14817.185054822088, 14861.225611431626, 15239.3904243829, 15724.68550629004, 16062.0, 13119.475220991053, 13882.86117138856, 14334.996550241383, 14660.413583456542, 14901.41336590447, 14648.414063437343, 15047.924760376129, 15233.238338083273, 15406.460773872861, 15789.447369342477, 11399.487023084146, 11675.241109327866, 11774.0, 11843.822342664695, 12013.75972480563, 12081.275123492618, 12440.315782632042, 12591.663209249373, 12996.610101696964, 13023.739525209632], "value": 7656.536711034848, "unit": "score"}], "name": "dromaeo_css", "value": 7333.315583861676, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 111.0, 111.0, 114.0, 111.0, 113.0, 113.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 120.0, 181.0, 124.0, 120.0, 141.0, 117.0, 151.0, 119.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 108.0, 75.0, 76.0, 74.0, 74.0, 98.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 84.0, 85.0, 84.0, 117.0, 83.0, 84.0, 136.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 53.0, 50.0, 53.0, 53.0, 50.0, 50.0, 49.0, 50.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 85.0, 81.0, 75.0, 75.0, 85.0, 74.0, 84.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 127.0, 119.0, 121.0, 130.0, 118.0, 118.0, 165.0, 133.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 164.0, 156.0, 155.0, 155.0, 160.0, 160.0, 161.0, 155.0, 159.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0, 65.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1477.8000000000002, "alertThreshold": 2.0}]} 19:28:40 INFO - Return code: 0 19:28:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:40 INFO - # TBPL SUCCESS # 19:28:40 INFO - Running post-action listener: _resource_record_post_action 19:28:40 INFO - [mozharness: 2016-08-02 02:28:40.520524Z] Finished run-tests step (success) 19:28:40 INFO - Running post-run listener: _resource_record_post_run 19:28:40 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7684096; Write bytes: 441491456; Read time: 1080; Write time: 327616 19:28:40 INFO - TinderboxPrint: CPU usage
13.0% 19:28:40 INFO - TinderboxPrint: I/O read bytes / time
7,684,096 / 1,080 19:28:40 INFO - TinderboxPrint: I/O write bytes / time
441,491,456 / 327,616 19:28:40 INFO - TinderboxPrint: CPU idle
8,289.4 (87.0%) 19:28:40 INFO - TinderboxPrint: CPU user
1,194.0 (12.5%) 19:28:40 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 23961600; Read time: 0; Write time: 10072 19:28:40 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5443584; Write bytes: 389935104; Read time: 892; Write time: 308536 19:28:41 INFO - Running post-run listener: _upload_blobber_files 19:28:41 INFO - Blob upload gear active. 19:28:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:41 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 19:28:41 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:41 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:42 INFO - (blobuploader) - INFO - Done attempting. 19:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:53 INFO - (blobuploader) - INFO - Done attempting. 19:28:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:53 INFO - (blobuploader) - INFO - Done attempting. 19:28:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:53 INFO - Return code: 0 19:28:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7793eac19049dce32516b0a954c5b86536c2ce97131177b42941bd7aed10f3e8ed021609d938ef9a714ec54a5199f532b0707e066fedca90bd7a4c7949089ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/005fef1e7b3b57124514b5fa812ea96a5fe79c17b74676e08d1b31438b73858f3752ab707875221cfaedad2b90229a3f49ffd1d0decb666743beceb78063282b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bbaa56d54c95be55e1c5311b3b84a01cb10e7926e4a770570db1d8153177664254051efda1e01a0d816c59668eef918d9faf6a22acd0f9ce32a7d59dcea385"} 19:28:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:53 INFO - Contents: 19:28:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7793eac19049dce32516b0a954c5b86536c2ce97131177b42941bd7aed10f3e8ed021609d938ef9a714ec54a5199f532b0707e066fedca90bd7a4c7949089ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/005fef1e7b3b57124514b5fa812ea96a5fe79c17b74676e08d1b31438b73858f3752ab707875221cfaedad2b90229a3f49ffd1d0decb666743beceb78063282b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bbaa56d54c95be55e1c5311b3b84a01cb10e7926e4a770570db1d8153177664254051efda1e01a0d816c59668eef918d9faf6a22acd0f9ce32a7d59dcea385"} 19:28:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:53 INFO - Copying logs to upload dir... 19:28:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.889258 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-01 19:28:53.696805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 19:28:53.700615) ========= 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=923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7793eac19049dce32516b0a954c5b86536c2ce97131177b42941bd7aed10f3e8ed021609d938ef9a714ec54a5199f532b0707e066fedca90bd7a4c7949089ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/005fef1e7b3b57124514b5fa812ea96a5fe79c17b74676e08d1b31438b73858f3752ab707875221cfaedad2b90229a3f49ffd1d0decb666743beceb78063282b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bbaa56d54c95be55e1c5311b3b84a01cb10e7926e4a770570db1d8153177664254051efda1e01a0d816c59668eef918d9faf6a22acd0f9ce32a7d59dcea385"} build_url:https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/IfBNxhL2QFSe1rcFaju9zQ/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/Mozilla-Inbound/sha512/a7793eac19049dce32516b0a954c5b86536c2ce97131177b42941bd7aed10f3e8ed021609d938ef9a714ec54a5199f532b0707e066fedca90bd7a4c7949089ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/005fef1e7b3b57124514b5fa812ea96a5fe79c17b74676e08d1b31438b73858f3752ab707875221cfaedad2b90229a3f49ffd1d0decb666743beceb78063282b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bbaa56d54c95be55e1c5311b3b84a01cb10e7926e4a770570db1d8153177664254051efda1e01a0d816c59668eef918d9faf6a22acd0f9ce32a7d59dcea385"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 19:28:53.725306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:28:53.725613) ========= 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=923d835db2ba3686ebe126b700000192-1470102771.266044-1794565315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:28:53.810026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 19:28:53.810345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 19:28:53.810626) ========= ========= Total master_lag: 0.17 =========