builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1470242119.7 results: success (0) buildid: 20160803080525 builduid: 57810839133a4137bdae12b663ef776e revision: 7f1b2e71efdcf31b521a3002719941252a8c517f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.704860) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.705434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.705789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.725755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.726127) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 09:35:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-08-03 09:35:20 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.901514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.901894) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.952198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:19.952602) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7f1b2e71efdcf31b521a3002719941252a8c517f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7f1b2e71efdcf31b521a3002719941252a8c517f --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=c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 09:35:20,776 truncating revision to first 12 chars 2016-08-03 09:35:20,776 Setting DEBUG logging. 2016-08-03 09:35:20,776 attempt 1/10 2016-08-03 09:35:20,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7f1b2e71efdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 09:35:21,076 unpacking tar archive at: mozilla-central-7f1b2e71efdc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:20.618481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:20.618819) ========= script_repo_revision: 7f1b2e71efdcf31b521a3002719941252a8c517f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:20.619275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:20.619550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 09:35:20.630624) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-03 09:35:20.631083) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:21 INFO - MultiFileLogger online at 20160803 09:35:21 in /builds/slave/test 09:35:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:35:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:21 INFO - {'append_to_log': False, 09:35:21 INFO - 'base_work_dir': '/builds/slave/test', 09:35:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:35:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:21 INFO - 'branch': 'Firefox-Non-PGO', 09:35:21 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:21 INFO - 'config_files': ('talos/linux_config.py',), 09:35:21 INFO - 'default_actions': ('clobber', 09:35:21 INFO - 'read-buildbot-config', 09:35:21 INFO - 'download-and-extract', 09:35:21 INFO - 'populate-webroot', 09:35:21 INFO - 'create-virtualenv', 09:35:21 INFO - 'install', 09:35:21 INFO - 'run-tests'), 09:35:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:21 INFO - 'download_minidump_stackwalk': True, 09:35:21 INFO - 'download_symbols': 'ondemand', 09:35:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:21 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:21 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:21 INFO - 'installer_path': 'installer.exe', 09:35:21 INFO - 'log_level': 'info', 09:35:21 INFO - 'log_name': 'talos', 09:35:21 INFO - 'log_to_console': True, 09:35:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:21 INFO - 'opt_config_files': (), 09:35:21 INFO - 'pip_index': False, 09:35:21 INFO - 'sps_profile': False, 09:35:21 INFO - 'sps_profile_interval': 0, 09:35:21 INFO - 'suite': 'dromaeojs', 09:35:21 INFO - 'system_bits': '32', 09:35:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:21 INFO - 'title': 'talos-linux64-ix-004', 09:35:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:21 INFO - 'use_talos_json': True, 09:35:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:21 INFO - 'work_dir': 'build'} 09:35:21 INFO - [mozharness: 2016-08-03 16:35:21.538764Z] Running clobber step. 09:35:21 INFO - Running pre-action listener: _resource_record_pre_action 09:35:21 INFO - Running main action method: clobber 09:35:21 INFO - rmtree: /builds/slave/test/build 09:35:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:22 INFO - Running post-action listener: _resource_record_post_action 09:35:22 INFO - [mozharness: 2016-08-03 16:35:22.528955Z] Finished clobber step (success) 09:35:22 INFO - [mozharness: 2016-08-03 16:35:22.529054Z] Running read-buildbot-config step. 09:35:22 INFO - Running pre-action listener: _resource_record_pre_action 09:35:22 INFO - Running main action method: read_buildbot_config 09:35:22 INFO - Using buildbot properties: 09:35:22 INFO - { 09:35:22 INFO - "project": "", 09:35:22 INFO - "product": "firefox", 09:35:22 INFO - "script_repo_revision": "production", 09:35:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:35:22 INFO - "repository": "", 09:35:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:35:22 INFO - "buildid": "20160803080525", 09:35:22 INFO - "pgo_build": "False", 09:35:22 INFO - "basedir": "/builds/slave/test", 09:35:22 INFO - "buildnumber": 578, 09:35:22 INFO - "slavename": "talos-linux64-ix-004", 09:35:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:35:22 INFO - "platform": "ubuntu64_hw", 09:35:22 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:35:22 INFO - "branch": "mozilla-central", 09:35:22 INFO - "repo_path": "mozilla-central", 09:35:22 INFO - "revision": "7f1b2e71efdcf31b521a3002719941252a8c517f", 09:35:22 INFO - "stage_platform": "linux64", 09:35:22 INFO - "builduid": "57810839133a4137bdae12b663ef776e", 09:35:22 INFO - "slavebuilddir": "test" 09:35:22 INFO - } 09:35:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:35:22 INFO - Running post-action listener: _resource_record_post_action 09:35:22 INFO - [mozharness: 2016-08-03 16:35:22.531497Z] Finished read-buildbot-config step (success) 09:35:22 INFO - [mozharness: 2016-08-03 16:35:22.531586Z] Running download-and-extract step. 09:35:22 INFO - Running pre-action listener: _resource_record_pre_action 09:35:22 INFO - Running main action method: download_and_extract 09:35:22 INFO - mkdir: /builds/slave/test/build/tests 09:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:22 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:35:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:35:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:35:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:35:23 INFO - Downloaded 1361 bytes. 09:35:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:35:23 INFO - Using the following test package requirements: 09:35:23 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:23 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:23 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:35:23 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'jsshell-linux-x86_64.zip'], 09:35:23 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:23 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:23 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:35:23 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:35:23 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:23 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35:23 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')]} 09:35:23 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:35:24 INFO - Downloaded 20240814 bytes. 09:35:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:35:25 INFO - Return code: 0 09:35:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:35: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')]} 09:35:25 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:35:28 INFO - Downloaded 20240814 bytes. 09:35:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:35:29 INFO - Return code: 0 09:35: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')]} 09:35:29 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:35:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:35:30 INFO - Downloaded 14413723 bytes. 09:35:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:35:30 INFO - Return code: 0 09:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:30 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:35:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:35:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:35:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:35:32 INFO - Downloaded 55575114 bytes. 09:35:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:35:32 INFO - mkdir: /builds/slave/test/properties 09:35:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:32 INFO - Contents: 09:35:32 INFO - build_url:https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:35:33 INFO - Running post-action listener: _resource_record_post_action 09:35:33 INFO - Running post-action listener: set_extra_try_arguments 09:35:33 INFO - [mozharness: 2016-08-03 16:35:33.130807Z] Finished download-and-extract step (success) 09:35:33 INFO - [mozharness: 2016-08-03 16:35:33.131040Z] Running populate-webroot step. 09:35:33 INFO - Running pre-action listener: _resource_record_pre_action 09:35:33 INFO - Running main action method: populate_webroot 09:35:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:33 INFO - '--tppagecycles', 09:35:33 INFO - '7'], 09:35:33 INFO - 'tests': ['tsvgm']}}, 09:35:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:35:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:35:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['damp', 'tps']}, 09:35:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'tests': ['damp', 'tps']}, 09:35:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['dromaeo_dom']}, 09:35:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['basic_compositor_video']}, 09:35:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:35:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['a11yr', 09:35:33 INFO - 'ts_paint', 09:35:33 INFO - 'tpaint', 09:35:33 INFO - 'sessionrestore', 09:35:33 INFO - 'sessionrestore_no_auto_restore', 09:35:33 INFO - 'tabpaint']}, 09:35:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:35:33 INFO - 'ts_paint', 09:35:33 INFO - 'tpaint', 09:35:33 INFO - 'sessionrestore', 09:35:33 INFO - 'sessionrestore_no_auto_restore', 09:35:33 INFO - 'tabpaint']}, 09:35:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:35:33 INFO - 'ts_paint', 09:35:33 INFO - 'tpaint', 09:35:33 INFO - 'sessionrestore', 09:35:33 INFO - 'sessionrestore_no_auto_restore', 09:35:33 INFO - 'tabpaint']}, 09:35:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:35:33 INFO - 'ts_paint', 09:35:33 INFO - 'tpaint', 09:35:33 INFO - 'sessionrestore', 09:35:33 INFO - 'sessionrestore_no_auto_restore', 09:35:33 INFO - 'tabpaint']}, 09:35:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['a11yr', 09:35:33 INFO - 'ts_paint', 09:35:33 INFO - 'tpaint', 09:35:33 INFO - 'sessionrestore', 09:35:33 INFO - 'sessionrestore_no_auto_restore', 09:35:33 INFO - 'tabpaint']}, 09:35:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['a11yr', 09:35:33 INFO - 'ts_paint', 09:35:33 INFO - 'tpaint', 09:35:33 INFO - 'sessionrestore', 09:35:33 INFO - 'sessionrestore_no_auto_restore', 09:35:33 INFO - 'tabpaint']}, 09:35:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['tsvgx', 09:35:33 INFO - 'tsvgr_opacity', 09:35:33 INFO - 'tart', 09:35:33 INFO - 'tscrollx', 09:35:33 INFO - 'cart']}, 09:35:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:35:33 INFO - 'tsvgr_opacity', 09:35:33 INFO - 'tart', 09:35:33 INFO - 'tscrollx', 09:35:33 INFO - 'cart']}, 09:35:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'talos_options': ['--disable-e10s'], 09:35:33 INFO - 'tests': ['tp5o']}, 09:35:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'tests': ['tp5o']}, 09:35:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'talos_options': ['--disable-e10s', 09:35:33 INFO - '--xperf_path', 09:35:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:33 INFO - 'tests': ['tp5n']}, 09:35:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:33 INFO - 'talos_options': ['--xperf_path', 09:35:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:33 INFO - 'tests': ['tp5n']}}, 09:35:33 INFO - 'talos.zip': {'path': '', 09:35:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:33 INFO - Running post-action listener: _resource_record_post_action 09:35:33 INFO - [mozharness: 2016-08-03 16:35:33.151034Z] Finished populate-webroot step (success) 09:35:33 INFO - [mozharness: 2016-08-03 16:35:33.151122Z] Running create-virtualenv step. 09:35:33 INFO - Running pre-action listener: _resource_record_pre_action 09:35:33 INFO - Running main action method: create_virtualenv 09:35:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:33 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 09:35:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:33 INFO - Using real prefix '/usr' 09:35:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:35 INFO - Installing pip.................done. 09:35:35 INFO - Return code: 0 09:35:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35:35 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')]} 09:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:35 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')]} 09:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:35 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:35 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 09:35:35 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 09:35:35 INFO - Using env: {'DISPLAY': ':0', 09:35:35 INFO - 'HOME': '/home/cltbld', 09:35:35 INFO - 'LANG': 'en_US.UTF-8', 09:35:35 INFO - 'LANGUAGE': 'en_US:en', 09:35:35 INFO - 'LOGNAME': 'cltbld', 09:35:35 INFO - 'MAIL': '/var/mail/cltbld', 09:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:35 INFO - 'MOZ_NO_REMOTE': '1', 09:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:35 INFO - 'NO_EM_RESTART': '1', 09:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:35 INFO - 'PWD': '/builds/slave/test', 09:35:35 INFO - 'SHELL': '/bin/bash', 09:35:35 INFO - 'SHLVL': '1', 09:35:35 INFO - 'TERM': 'linux', 09:35:35 INFO - 'TMOUT': '86400', 09:35:35 INFO - 'USER': 'cltbld', 09:35:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:35 INFO - '_': '/tools/buildbot/bin/python'} 09:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:35 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 09:35:35 INFO - Cleaning up... 09:35:35 INFO - Return code: 0 09:35:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:35:35 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')]} 09:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:35 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')]} 09:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:35 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:35 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 09:35:35 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 09:35:35 INFO - Using env: {'DISPLAY': ':0', 09:35:35 INFO - 'HOME': '/home/cltbld', 09:35:35 INFO - 'LANG': 'en_US.UTF-8', 09:35:35 INFO - 'LANGUAGE': 'en_US:en', 09:35:35 INFO - 'LOGNAME': 'cltbld', 09:35:35 INFO - 'MAIL': '/var/mail/cltbld', 09:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:35 INFO - 'MOZ_NO_REMOTE': '1', 09:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:35 INFO - 'NO_EM_RESTART': '1', 09:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:35 INFO - 'PWD': '/builds/slave/test', 09:35:35 INFO - 'SHELL': '/bin/bash', 09:35:35 INFO - 'SHLVL': '1', 09:35:35 INFO - 'TERM': 'linux', 09:35:35 INFO - 'TMOUT': '86400', 09:35:35 INFO - 'USER': 'cltbld', 09:35:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:35 INFO - '_': '/tools/buildbot/bin/python'} 09:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:36 INFO - Downloading/unpacking psutil>=3.1.1 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:38 INFO - Installing collected packages: psutil 09:35:38 INFO - Running setup.py install for psutil 09:35:38 INFO - building 'psutil._psutil_linux' extension 09:35:38 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 09:35:38 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 09:35:38 INFO - building 'psutil._psutil_posix' extension 09:35:38 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 09:35:38 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 09:35:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:38 INFO - Successfully installed psutil 09:35:38 INFO - Cleaning up... 09:35:38 INFO - Return code: 0 09:35:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:38 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:38 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 09:35:38 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 09:35:38 INFO - Using env: {'DISPLAY': ':0', 09:35:38 INFO - 'HOME': '/home/cltbld', 09:35:38 INFO - 'LANG': 'en_US.UTF-8', 09:35:38 INFO - 'LANGUAGE': 'en_US:en', 09:35:38 INFO - 'LOGNAME': 'cltbld', 09:35:38 INFO - 'MAIL': '/var/mail/cltbld', 09:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:38 INFO - 'MOZ_NO_REMOTE': '1', 09:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:38 INFO - 'NO_EM_RESTART': '1', 09:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:38 INFO - 'PWD': '/builds/slave/test', 09:35:38 INFO - 'SHELL': '/bin/bash', 09:35:38 INFO - 'SHLVL': '1', 09:35:38 INFO - 'TERM': 'linux', 09:35:38 INFO - 'TMOUT': '86400', 09:35:38 INFO - 'USER': 'cltbld', 09:35:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:38 INFO - '_': '/tools/buildbot/bin/python'} 09:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:35:40 INFO - Installing collected packages: mozsystemmonitor 09:35:40 INFO - Running setup.py install for mozsystemmonitor 09:35:40 INFO - Successfully installed mozsystemmonitor 09:35:40 INFO - Cleaning up... 09:35:41 INFO - Return code: 0 09:35:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:41 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:41 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 09:35:41 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 09:35:41 INFO - Using env: {'DISPLAY': ':0', 09:35:41 INFO - 'HOME': '/home/cltbld', 09:35:41 INFO - 'LANG': 'en_US.UTF-8', 09:35:41 INFO - 'LANGUAGE': 'en_US:en', 09:35:41 INFO - 'LOGNAME': 'cltbld', 09:35:41 INFO - 'MAIL': '/var/mail/cltbld', 09:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:41 INFO - 'MOZ_NO_REMOTE': '1', 09:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:41 INFO - 'NO_EM_RESTART': '1', 09:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:41 INFO - 'PWD': '/builds/slave/test', 09:35:41 INFO - 'SHELL': '/bin/bash', 09:35:41 INFO - 'SHLVL': '1', 09:35:41 INFO - 'TERM': 'linux', 09:35:41 INFO - 'TMOUT': '86400', 09:35:41 INFO - 'USER': 'cltbld', 09:35:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:41 INFO - '_': '/tools/buildbot/bin/python'} 09:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:41 INFO - Downloading/unpacking jsonschema==2.5.1 09:35:41 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 09:35:41 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 09:35:41 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 09:35:41 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 09:35:41 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 09:35:41 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 09:35:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:43 INFO - warning: no files found matching '*.txt' 09:35:43 INFO - no previously-included directories found matching 'build' 09:35:43 INFO - no previously-included directories found matching 'dist' 09:35:43 INFO - no previously-included directories found matching '.git*' 09:35:43 INFO - Installing collected packages: jsonschema, functools32 09:35:43 INFO - Running setup.py install for functools32 09:35:43 INFO - warning: no files found matching '*.txt' 09:35:43 INFO - no previously-included directories found matching 'build' 09:35:43 INFO - no previously-included directories found matching 'dist' 09:35:43 INFO - no previously-included directories found matching '.git*' 09:35:43 INFO - Successfully installed jsonschema functools32 09:35:43 INFO - Cleaning up... 09:35:43 INFO - Return code: 0 09:35:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:43 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:43 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 09:35:43 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 09:35:43 INFO - Using env: {'DISPLAY': ':0', 09:35:43 INFO - 'HOME': '/home/cltbld', 09:35:43 INFO - 'LANG': 'en_US.UTF-8', 09:35:43 INFO - 'LANGUAGE': 'en_US:en', 09:35:43 INFO - 'LOGNAME': 'cltbld', 09:35:43 INFO - 'MAIL': '/var/mail/cltbld', 09:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:43 INFO - 'MOZ_NO_REMOTE': '1', 09:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:43 INFO - 'NO_EM_RESTART': '1', 09:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:43 INFO - 'PWD': '/builds/slave/test', 09:35:43 INFO - 'SHELL': '/bin/bash', 09:35:43 INFO - 'SHLVL': '1', 09:35:43 INFO - 'TERM': 'linux', 09:35:43 INFO - 'TMOUT': '86400', 09:35:43 INFO - 'USER': 'cltbld', 09:35:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:43 INFO - '_': '/tools/buildbot/bin/python'} 09:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:35:43 INFO - Cleaning up... 09:35:43 INFO - Return code: 0 09:35:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:43 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:43 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 09:35:43 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 09:35:43 INFO - Using env: {'DISPLAY': ':0', 09:35:43 INFO - 'HOME': '/home/cltbld', 09:35:43 INFO - 'LANG': 'en_US.UTF-8', 09:35:43 INFO - 'LANGUAGE': 'en_US:en', 09:35:43 INFO - 'LOGNAME': 'cltbld', 09:35:43 INFO - 'MAIL': '/var/mail/cltbld', 09:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:43 INFO - 'MOZ_NO_REMOTE': '1', 09:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:43 INFO - 'NO_EM_RESTART': '1', 09:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:43 INFO - 'PWD': '/builds/slave/test', 09:35:43 INFO - 'SHELL': '/bin/bash', 09:35:43 INFO - 'SHLVL': '1', 09:35:43 INFO - 'TERM': 'linux', 09:35:43 INFO - 'TMOUT': '86400', 09:35:43 INFO - 'USER': 'cltbld', 09:35:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:43 INFO - '_': '/tools/buildbot/bin/python'} 09:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:35:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:35:45 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 09:35:45 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 09:35:45 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 09:35:45 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 09:35:45 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 09:35:45 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 09:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:35:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:35:46 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 09:35:46 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 09:35:46 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 09:35:46 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 09:35:46 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 09:35:46 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 09:35:46 INFO - Downloading docopt-0.6.1.tar.gz 09:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:35:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:35:46 INFO - Running setup.py install for blobuploader 09:35:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:35:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:35:46 INFO - Running setup.py install for requests 09:35:47 INFO - Running setup.py install for docopt 09:35:47 INFO - Successfully installed blobuploader requests docopt 09:35:47 INFO - Cleaning up... 09:35:47 INFO - Return code: 0 09:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:47 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:47 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 09:35:47 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 09:35:47 INFO - Using env: {'DISPLAY': ':0', 09:35:47 INFO - 'HOME': '/home/cltbld', 09:35:47 INFO - 'LANG': 'en_US.UTF-8', 09:35:47 INFO - 'LANGUAGE': 'en_US:en', 09:35:47 INFO - 'LOGNAME': 'cltbld', 09:35:47 INFO - 'MAIL': '/var/mail/cltbld', 09:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:47 INFO - 'MOZ_NO_REMOTE': '1', 09:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:47 INFO - 'NO_EM_RESTART': '1', 09:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:47 INFO - 'PWD': '/builds/slave/test', 09:35:47 INFO - 'SHELL': '/bin/bash', 09:35:47 INFO - 'SHLVL': '1', 09:35:47 INFO - 'TERM': 'linux', 09:35:47 INFO - 'TMOUT': '86400', 09:35:47 INFO - 'USER': 'cltbld', 09:35:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:47 INFO - '_': '/tools/buildbot/bin/python'} 09:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:47 INFO - Running setup.py (path:/tmp/pip-qWASHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:47 INFO - Running setup.py (path:/tmp/pip-5kPLGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:47 INFO - Running setup.py (path:/tmp/pip-OmMXh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:47 INFO - Running setup.py (path:/tmp/pip-kjsJNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:47 INFO - Running setup.py (path:/tmp/pip-OPad8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:47 INFO - Running setup.py (path:/tmp/pip-m4YbxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:47 INFO - Running setup.py (path:/tmp/pip-9KQEUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:47 INFO - Running setup.py (path:/tmp/pip-mozgeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:48 INFO - Running setup.py (path:/tmp/pip-K_HRa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:48 INFO - Running setup.py (path:/tmp/pip-5CGEPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:48 INFO - Running setup.py (path:/tmp/pip-YV96d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:48 INFO - Running setup.py (path:/tmp/pip-XDqw6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:48 INFO - Running setup.py (path:/tmp/pip-1ZEfjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:48 INFO - Running setup.py (path:/tmp/pip-l4Q8EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:48 INFO - Running setup.py (path:/tmp/pip-MpXdIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:48 INFO - Running setup.py (path:/tmp/pip-F5MW2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:48 INFO - Running setup.py (path:/tmp/pip-ev_ZWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:35:48 INFO - Running setup.py install for manifestparser 09:35:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:35:48 INFO - Running setup.py install for mozcrash 09:35:48 INFO - Running setup.py install for mozdebug 09:35:48 INFO - Running setup.py install for mozdevice 09:35:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Running setup.py install for mozfile 09:35:49 INFO - Running setup.py install for mozhttpd 09:35:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Running setup.py install for mozinfo 09:35:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Running setup.py install for mozInstall 09:35:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Running setup.py install for mozleak 09:35:49 INFO - Running setup.py install for mozlog 09:35:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Running setup.py install for moznetwork 09:35:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:35:49 INFO - Running setup.py install for mozprocess 09:35:49 INFO - Running setup.py install for mozprofile 09:35:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:35:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:35:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:35:50 INFO - Running setup.py install for mozrunner 09:35:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:35:50 INFO - Running setup.py install for mozscreenshot 09:35:50 INFO - Running setup.py install for moztest 09:35:50 INFO - Running setup.py install for mozversion 09:35:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:35:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:35:50 INFO - Cleaning up... 09:35:50 INFO - Return code: 0 09:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:50 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:50 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 09:35:50 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 09:35:50 INFO - Using env: {'DISPLAY': ':0', 09:35:50 INFO - 'HOME': '/home/cltbld', 09:35:50 INFO - 'LANG': 'en_US.UTF-8', 09:35:50 INFO - 'LANGUAGE': 'en_US:en', 09:35:50 INFO - 'LOGNAME': 'cltbld', 09:35:50 INFO - 'MAIL': '/var/mail/cltbld', 09:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:50 INFO - 'MOZ_NO_REMOTE': '1', 09:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:50 INFO - 'NO_EM_RESTART': '1', 09:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:50 INFO - 'PWD': '/builds/slave/test', 09:35:50 INFO - 'SHELL': '/bin/bash', 09:35:50 INFO - 'SHLVL': '1', 09:35:50 INFO - 'TERM': 'linux', 09:35:50 INFO - 'TMOUT': '86400', 09:35:50 INFO - 'USER': 'cltbld', 09:35:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:50 INFO - '_': '/tools/buildbot/bin/python'} 09:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:50 INFO - Running setup.py (path:/tmp/pip-s9RHBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:50 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)) 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:50 INFO - Running setup.py (path:/tmp/pip-d3dbFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:50 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)) 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:50 INFO - Running setup.py (path:/tmp/pip-BiiPN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:50 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)) 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:50 INFO - Running setup.py (path:/tmp/pip-OrKnxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:50 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)) 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:50 INFO - Running setup.py (path:/tmp/pip-9Y4kRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:51 INFO - Running setup.py (path:/tmp/pip-hdR6ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:51 INFO - Running setup.py (path:/tmp/pip-1MNZQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:51 INFO - Running setup.py (path:/tmp/pip-1B3WZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:51 INFO - Running setup.py (path:/tmp/pip-_JTQhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:51 INFO - Running setup.py (path:/tmp/pip-BxK3dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:51 INFO - Running setup.py (path:/tmp/pip-V8WNhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:51 INFO - Running setup.py (path:/tmp/pip-LfUcNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:51 INFO - Running setup.py (path:/tmp/pip-fLzd2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:51 INFO - Running setup.py (path:/tmp/pip-SfFLXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:51 INFO - Running setup.py (path:/tmp/pip-zVdoj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:51 INFO - Running setup.py (path:/tmp/pip-8zjy1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:51 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)) 09:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:51 INFO - Running setup.py (path:/tmp/pip-4WHCmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:51 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)) 09:35:51 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)) 09:35:51 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)) 09:35:51 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)) 09:35:51 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)) 09:35:51 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)) 09:35:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:35:51 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 09:35:51 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 09:35:51 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 09:35:51 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 09:35:51 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 09:35:51 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 09:35:53 INFO - Downloading blessings-1.6.tar.gz 09:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:35:53 INFO - Installing collected packages: blessings 09:35:53 INFO - Running setup.py install for blessings 09:35:53 INFO - Successfully installed blessings 09:35:53 INFO - Cleaning up... 09:35:54 INFO - Return code: 0 09:35:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:54 INFO - Reading from file tmpfile_stdout 09:35:54 INFO - Current package versions: 09:35:54 INFO - argparse == 1.2.1 09:35:54 INFO - blessings == 1.6 09:35:54 INFO - blobuploader == 1.2.4 09:35:54 INFO - docopt == 0.6.1 09:35:54 INFO - functools32 == 3.2.3-2 09:35:54 INFO - jsonschema == 2.5.1 09:35:54 INFO - manifestparser == 1.1 09:35:54 INFO - mozInstall == 1.12 09:35:54 INFO - mozcrash == 0.17 09:35:54 INFO - mozdebug == 0.1 09:35:54 INFO - mozdevice == 0.48 09:35:54 INFO - mozfile == 1.2 09:35:54 INFO - mozhttpd == 0.7 09:35:54 INFO - mozinfo == 0.9 09:35:54 INFO - mozleak == 0.1 09:35:54 INFO - mozlog == 3.3 09:35:54 INFO - moznetwork == 0.27 09:35:54 INFO - mozprocess == 0.23 09:35:54 INFO - mozprofile == 0.28 09:35:54 INFO - mozrunner == 6.12 09:35:54 INFO - mozscreenshot == 0.1 09:35:54 INFO - mozsystemmonitor == 0.3 09:35:54 INFO - moztest == 0.7 09:35:54 INFO - mozversion == 1.4 09:35:54 INFO - psutil == 3.1.1 09:35:54 INFO - requests == 1.2.3 09:35:54 INFO - wsgiref == 0.1.2 09:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:54 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 09:35:54 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 09:35:54 INFO - Using env: {'DISPLAY': ':0', 09:35:54 INFO - 'HOME': '/home/cltbld', 09:35:54 INFO - 'LANG': 'en_US.UTF-8', 09:35:54 INFO - 'LANGUAGE': 'en_US:en', 09:35:54 INFO - 'LOGNAME': 'cltbld', 09:35:54 INFO - 'MAIL': '/var/mail/cltbld', 09:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:54 INFO - 'MOZ_NO_REMOTE': '1', 09:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:54 INFO - 'NO_EM_RESTART': '1', 09:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:54 INFO - 'PWD': '/builds/slave/test', 09:35:54 INFO - 'SHELL': '/bin/bash', 09:35:54 INFO - 'SHLVL': '1', 09:35:54 INFO - 'TERM': 'linux', 09:35:54 INFO - 'TMOUT': '86400', 09:35:54 INFO - 'USER': 'cltbld', 09:35:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:54 INFO - '_': '/tools/buildbot/bin/python'} 09:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 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)) 09:35:54 INFO - Cleaning up... 09:35:54 INFO - Return code: 0 09:35:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', '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 09:35:54 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 09:35:54 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 09:35:54 INFO - Using env: {'DISPLAY': ':0', 09:35:54 INFO - 'HOME': '/home/cltbld', 09:35:54 INFO - 'LANG': 'en_US.UTF-8', 09:35:54 INFO - 'LANGUAGE': 'en_US:en', 09:35:54 INFO - 'LOGNAME': 'cltbld', 09:35:54 INFO - 'MAIL': '/var/mail/cltbld', 09:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:54 INFO - 'MOZ_NO_REMOTE': '1', 09:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:54 INFO - 'NO_EM_RESTART': '1', 09:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:54 INFO - 'PWD': '/builds/slave/test', 09:35:54 INFO - 'SHELL': '/bin/bash', 09:35:54 INFO - 'SHLVL': '1', 09:35:54 INFO - 'TERM': 'linux', 09:35:54 INFO - 'TMOUT': '86400', 09:35:54 INFO - 'USER': 'cltbld', 09:35:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:54 INFO - '_': '/tools/buildbot/bin/python'} 09:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:35:54 INFO - Cleaning up... 09:35:54 INFO - Return code: 0 09:35:54 INFO - Running post-action listener: _resource_record_post_action 09:35:54 INFO - Running post-action listener: _start_resource_monitoring 09:35:54 INFO - Starting resource monitoring. 09:35:54 INFO - [mozharness: 2016-08-03 16:35:54.745952Z] Finished create-virtualenv step (success) 09:35:54 INFO - [mozharness: 2016-08-03 16:35:54.746438Z] Running install step. 09:35:54 INFO - Running pre-action listener: _resource_record_pre_action 09:35:54 INFO - Running main action method: install 09:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:54 INFO - Reading from file tmpfile_stdout 09:35:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:35:55 INFO - Reading from file tmpfile_stdout 09:35:55 INFO - Output received: 09:35:55 INFO - Usage: mozinstall [options] installer 09:35:55 INFO - Options: 09:35:55 INFO - -h, --help show this help message and exit 09:35:55 INFO - -d DEST, --destination=DEST 09:35:55 INFO - Directory to install application into. [default: 09:35:55 INFO - "/builds/slave/test"] 09:35:55 INFO - --app=APP Application being installed. [default: firefox] 09:35:55 INFO - mkdir: /builds/slave/test/build/application 09:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:36:11 INFO - Reading from file tmpfile_stdout 09:36:11 INFO - Output received: 09:36:11 INFO - /builds/slave/test/build/application/firefox/firefox 09:36:11 INFO - Running post-action listener: _resource_record_post_action 09:36:11 INFO - [mozharness: 2016-08-03 16:36:11.062562Z] Finished install step (success) 09:36:11 INFO - [mozharness: 2016-08-03 16:36:11.062835Z] Running run-tests step. 09:36:11 INFO - Running pre-action listener: _resource_record_pre_action 09:36:11 INFO - Running main action method: run_tests 09:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:11 INFO - Python 2.7.3 09:36:11 INFO - Return code: 0 09:36:11 INFO - grabbing minidump binary from tooltool 09:36:11 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')]} 09:36:11 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 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:11 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 09:36:11 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 09:36:11 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 09:36:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:11 INFO - Return code: 0 09:36:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:36:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:36:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 09:36:11 INFO - Using env: {'DISPLAY': ':0', 09:36:11 INFO - 'HOME': '/home/cltbld', 09:36:11 INFO - 'LANG': 'en_US.UTF-8', 09:36:11 INFO - 'LANGUAGE': 'en_US:en', 09:36:11 INFO - 'LOGNAME': 'cltbld', 09:36:11 INFO - 'MAIL': '/var/mail/cltbld', 09:36:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:11 INFO - 'MOZ_NO_REMOTE': '1', 09:36:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:11 INFO - 'NO_EM_RESTART': '1', 09:36:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:11 INFO - 'PWD': '/builds/slave/test', 09:36:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:11 INFO - 'SHELL': '/bin/bash', 09:36:11 INFO - 'SHLVL': '1', 09:36:11 INFO - 'TERM': 'linux', 09:36:11 INFO - 'TMOUT': '86400', 09:36:11 INFO - 'USER': 'cltbld', 09:36:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645', 09:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:11 INFO - '_': '/tools/buildbot/bin/python'} 09:36:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:36:11 INFO - mozversion application_buildid: 20160803080525 09:36:11 INFO - mozversion application_changeset: 7f1b2e71efdcf31b521a3002719941252a8c517f 09:36:11 INFO - mozversion application_display_name: Nightly 09:36:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:11 INFO - mozversion application_name: Firefox 09:36:11 INFO - mozversion application_remotingname: firefox 09:36:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:36:11 INFO - mozversion application_vendor: Mozilla 09:36:11 INFO - mozversion application_version: 51.0a1 09:36:11 INFO - mozversion platform_buildid: 20160803080525 09:36:11 INFO - mozversion platform_changeset: 7f1b2e71efdcf31b521a3002719941252a8c517f 09:36:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:36:11 INFO - mozversion platform_version: 51.0a1 09:36:11 INFO - using testdate: 1470242171 09:36:11 INFO - actual date: 1470242171 09:36:11 INFO - starting webserver on 'localhost:41130' 09:36:11 INFO - SUITE-START | Running 2 tests 09:36:11 INFO - TEST-START | dromaeo_css 09:36:11 INFO - operating with platform_type : linux_ 09:36:11 INFO - Initialising browser for dromaeo_css test... 09:36:11 INFO - TEST-INFO | started process 12731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0hgD96/profile http://localhost:41130/getInfo.html) 09:36:15 INFO - PROCESS | 12731 | __metrics Screen width/height:1600/1200 09:36:15 INFO - PROCESS | 12731 | colorDepth:24 09:36:15 INFO - PROCESS | 12731 | Browser inner width/height: 1024/697 09:36:15 INFO - PROCESS | 12731 | __metrics 09:36:16 INFO - PROCESS | 12731 | 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" 09:36:16 INFO - PROCESS | 12731 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:17 INFO - TEST-INFO | 12731: exit 0 09:36:17 INFO - Browser initialized. 09:36:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:17 INFO - TEST-INFO | started process 12811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0hgD96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:29 INFO - PROCESS | 12811 | RSS: Main: 157442048 09:36:29 INFO - PROCESS | 12811 | 09:37:20 INFO - PROCESS | 12811 | 1470242240747 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] 09:39:34 INFO - PROCESS | 12811 | Cycle 1(1): loaded http://localhost:41130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41130/tests/dromaeo/cssquery-ext.html) 09:39:35 INFO - PROCESS | 12811 | RSS: Main: 246517760 09:39:35 INFO - PROCESS | 12811 | 09:42:38 INFO - PROCESS | 12811 | Cycle 1(1): loaded http://localhost:41130/tests/dromaeo/cssquery-ext.html (next: http://localhost:41130/tests/dromaeo/cssquery-jquery.html) 09:42:38 INFO - PROCESS | 12811 | RSS: Main: 245006336 09:42:38 INFO - PROCESS | 12811 | 09:45:41 INFO - PROCESS | 12811 | Cycle 1(1): loaded http://localhost:41130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41130/tests/dromaeo/cssquery-mootools.html) 09:45:41 INFO - PROCESS | 12811 | RSS: Main: 231067648 09:45:41 INFO - PROCESS | 12811 | 09:48:43 INFO - PROCESS | 12811 | Cycle 1(1): loaded http://localhost:41130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41130/tests/dromaeo/cssquery-prototype.html) 09:48:44 INFO - PROCESS | 12811 | RSS: Main: 188194816 09:48:44 INFO - PROCESS | 12811 | 09:51:47 INFO - PROCESS | 12811 | Cycle 1(1): loaded http://localhost:41130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41130/tests/dromaeo/cssquery-yui.html) 09:51:48 INFO - PROCESS | 12811 | RSS: Main: 189280256 09:51:48 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | Cycle 1(1): loaded http://localhost:41130/tests/dromaeo/cssquery-yui.html (next: http://localhost:41130/tests/dromaeo/cssquery-dojo.html) 09:54:51 INFO - PROCESS | 12811 | RSS: Main: 281702400 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | __start_tp_report 09:54:51 INFO - PROCESS | 12811 | _x_x_mozilla_page_load 09:54:51 INFO - PROCESS | 12811 | _x_x_mozilla_page_load_details 09:54:51 INFO - PROCESS | 12811 | |i|pagename|runs| 09:54:51 INFO - PROCESS | 12811 | |0;dojo.html;2697.581874809403;2699.514087464256;2736.9178924632256;2744.4511097780437;2752.8073034887566;4770.4513980892125;4843.200871856139;4938.728369939652;4988.40139183298;4992.151334273173;4884.951150488494;4885.682430642006;4887.926681099786;4890.413150421954;4927.137750893588;4422.867313980586;4453.864264612519;4475.060237350161;4483.058557702886;4526.705764125338;4433.490148632916;4488.730676159425;4508.77456127194;4529;4571.794269257892;4586.3579098926175;4603.516630753773;4613.146567884935;4634.930476042862;4639.164950308943;4395.406620106277;4445.5776701213335;4446.088551846864;4507.211238033364;4577.313402989545;4414.933775993362;4415.094905544356;4429.889252768674;4438.7114837535455;4512.458504979423;4908;4938.456769755324;4941.061198372297;4951.0840494508275;4963.40439147301;5046.419661738911;5177.042247184283;5215.582753379758;5280.9207861882105;5322.494363035544;5155.046316431472;5313.628046036779;5366.624336296461;5372.785088596452;5376.059189641836;4937.580305674058;4962.528559786814;4972.925406118911;4984.2025275955675;4986.177280748709;5269.736513174403;5377.085895397791;5450.127979523258;5460.699661518575;5478.506934375846;5227.895442091213;5258.631895767336;5268.604854635841;5285.995660824431;5287.7884884604955;5297.152455607084;5301.1783173608155;5320.17537281722;5337.2794672719465;5355.410904800468;5029.346184995927;5207.635465517377;5242.554382877498;5246.370435547682;5262.158054711228;5245.632805703641;5281.181416880389;5291.497307755757;5311.17676760095;5319.069162896555;4509.436320459942;4511.796969136397;4511.954880451219;4521.864344069683;4560.5211452796975;3833.463315135883;3890.7081968851885;3930.4890364253038;3951.762894226298;3981.203759248162;4547.136044151601;4565.589096981287;4572.4055872736335;4628.930566041512;4637.1421287062;5332.33345831771;5343.973280133574;5348.946510534923;5352.57179425645;5397.082495975694;4414.845480408235;4487.932681009787;4524.9547504524535;4577.748223847654;4630.259158534618;4750.8337208197545;4773.522647735199;4784.2823576463115;4837.419509658864;4838.298446725205;4952.529509696573;4959.256111583291;4959.578435832995;4967.652264341461;5004.624653150955;5163.3545806774155;5247.291615631841;5251.343582052244;5305.071612467726;5361.919571206357;4938.75306234694;4940.6788558743565;4944.110060189057;4966.428860680923;4996.7001979881325;5200.739963001759;5211.504907033977;5214.634975551675;5221.138512145453;5267.78928842842;5097.9490205098955;5251.26482292487;5267.5522580579545;5268.394134674561;5298.94701053;5144.074066668036;5175.844724658266;5197.974010129925;5256.553192978639;5264.736763161904;5180.870478238075;5192.532672059533;5199.194124910494;5215.13950198213;5254.605904557097;4815.085133824562;4837.105135549935;5017.448080711192;5110.795568177231;5178.352705911761;5160.535551800356;5196;5208.218767184952;5246.658967167122;5253.369595648546;5036.320096787033;5070.163423035306;5087.618428617794;5088.465711100281;5127.66670166438 09:54:51 INFO - PROCESS | 12811 | |1;ext.html;558.4108765252658;558.656426297827;565.6860442454437;572.507643426653;573.3549756523912;29288.560671589945;39216.21567568651;41137;41306.586934130646;44527.33209001859;40764.59235407645;40870.18259634806;40922.79538602303;41155;41213;7495.100587929443;7627.2372762723835;7631.3894888408795;7631.65657545409;7636.312731854132;7635.045619297588;7743;7747.225277472264;7772.417068719868;7831.451798374116;7789.844203115934;7805.297523222909;7816.335611473031;7867.527948323091;7870.921290787076;7823.10034346049;7864.095629002681;7867.055953285585;7869.13439521655;7874.527528348317;7688.038995125609;7728;7745.806354841117;7762.068551773767;7768.41736869737;39002.609973900464;39280.41079383811;39339;39349.803250983845;39407.211855762725;2941.4411261860178;3057.5719399284117;3095.9535606965915;3145.418097651942;3185.1877771168206;28838.279043023882;29120.854395728096;29181.124566263046;29418.41163176746;29544.704552954412;3372.780769249991;3395.8302084895904;3409.7954122752712;3444.328355970587;3479.982600087009;239793;240278;240905.99999999825;241561;241568;53356;53652;53720.462795372325;53760.73119634377;53770.46229537654;33376;34653.65346346555;34711.652883471346;36246.63753362485;36292.27415451676;13655.726885462234;13806.447742090404;13824.101433406997;13846.10000349974;13849.23829189384;9802.9019709802;9866.358686685342;9882.703518894445;9885.703428897;9898.307118501636;18654.16056277471;18665.626687466174;18694.626107477776;18756.155972981247;18796.906015469835;6801.727930882709;6805.795826125224;6881.483888708367;6890.655467226618;6913;808.8220591469867;902.0348227396754;920.4983284110176;994.9701508954743;1057.5293994172519;27631;28310.15069547917;29031.7096829029;29434.411311774074;29634.259143521154;749.5128166691694;961.5144352102144;962.7496850818698;1000.6697789729371;1044.2429238801808;14539.3457294422;15121.621959451102;15173.696526069638;15283.847161528465;15578.454754083552;378518;381236;382922;383081;384220;48389.27416088691;48844.51155488471;48855.02289954252;48881.5111848877;48948.510514895104;1097.1277834121893;1164.2083383299437;1167.7139100920328;1178.5757127433944;1186.655869797749;28232.43535129245;29644.55533166961;29933.55099673463;30026;30528.389432211676;43227.78386108049;43793.12413751643;43794.781026094664;43819;43837;296542;296586;297178;298486;420667;37590;40008.399874001334;40515.1896962065;40539.79730101331;41105.1778964413;43102.35346469743;43742.343864841416;43865.56134438615;43993.34009989789;44097.11805763931;37066.62933370632;37246.44130338101;37370.626293736714;37667.623323767504;38283.42574861435;36474;36515.63484365122;36799;37197.44203836999;37485.43771843479;36888.26223475569;37055.444168338036;37374.252514949;37450.43824342582;38265.4260186103;31951.201219968756;34129.65870341265;34396.82801585976;34564.48153277753;34609.65390346065;25872.8706356467;26336.34159146037;26410;26495.205143845717;26545.867270663523 09:54:51 INFO - PROCESS | 12811 | |2;jquery.html;335.285841158333;345.590475286785;357.60127457884465;366.4155671703632;367.1573738270669;12723.681907952307;12878.871211287897;13631.591052268435;16765.904261967255;16944.491665250032;15949.52151435456;16009.519714408558;16370.754438683429;16399.67200655986;16537.503874883772;5022.02070596233;5029.421616514092;5090.109230884599;5126.641135120543;5133.307003554528;3715.8142092895246;5036.320096786942;5085.720285384303;5090.389153301609;5578.219049333076;5823.475887170154;5899.351071382166;5909.261342332208;5915.645061296314;5920.674362910038;4883.243097319921;5096.61775366849;5134.897302053975;5933.406659334075;5940.257467816523;4864.246041863516;5033.395992480926;5051.318072060261;5051.671641343338;5056.367954005749;11767.764644707144;12104.878951210463;12112.394380281039;12117.091218158674;12122.39388030595;1838.9632207355778;1898.3260942365537;1977.6736838421643;2034.6337659221335;2328.580855446019;8783.73648790531;8791.824163516694;8982.595783189772;8982.730518084469;12054.61371942229;1634.8610368118725;1679.6388776413007;1725.3616162020007;1735.2798588585722;1738.8087310395847;72202;74904.62547687281;75286.87069694014;76067.61966190189;77962.61018694927;8547.658093676308;8805.207531322212;9148.817023659489;9237.722868313827;9375.812483750287;11164.106871450265;11212.159088068427;11256;11279.266847654877;11324.716882078013;6736.393724564715;6820.329019390281;6854.246032936373;6855.451563874878;7061.223265440797;6677.632730199788;6804.353586409283;6952.513324067267;7061.082059332254;7070.080889484334;3429.4684323929832;3499.9650003499637;3521.6126226115107;3596.2088340565033;3624.7825130492256;1672.339425926752;1721.8549664473235;1744.433059255747;1754.2369069454828;1764.2766465748982;883.2845395229884;894.2398960883197;918.7703074231442;927.7355953553205;941.8587211918267;16113.758293625606;16480.917595412186;16861;17705.468835934942;18100;857.1514200941148;870.1516021878745;889.515214208258;902.359324879343;926.2219735422143;9595.90404095964;9753.366031207948;9982.60069597208;9992.500374981222;10156.746081348025;381758;403466;406362;408327;409445;49787.50212497901;53456;85697;88123.11876881149;88221;882.8278485695228;910.3991365698607;920.9125133112477;923.0308176414737;924.2882980105281;15709.685806284038;15771.132587707787;16345.427910023092;16461.176941153135;16683.16584170811;35811.64188358187;38612.99999999888;40737.79631101825;41104.58895411008;41749.58250417457;53200.73399632977;54486;54557.72721136369;54676.48799606016;55757.721211393684;7517.586532740533;7528.548287102792;7602.771916842504;7817.101033381234;7825.217478252357;11605.825912611486;12029.218100823418;12178.512859485521;12200;12635.305058221886;9255.213306868991;9777.902220977983;9919.15687166599;9967.750806229613;10230.539625717009;10224.335418197794;10348.172146228435;10378.06597406237;10388.37669739818;10592.152627789605;9854.26093043039;9904.752381190528;9932.503374831374;10346.844797327896;10366.222533309881;7473.140588832136;7578.242175782378;7648.388128949782;7718.189590093184;7872.803179920548;4931.901361972668;8110.797230069295;8783.121687831166;9828.16460600857;9829.115379615869 09:54:51 INFO - PROCESS | 12811 | |3;mootools.html;1272.5482453728932;1412.8304603447589;1427.6145440731002;1482.7108713800806;1687.1395588249989;6645.933540664592;7391.150017747954;7735.497192682472;7738.806529836764;7922.207779222089;7755.534667919928;7826.72606458774;7830.41271904608;7834.804129896741;7841.215878412156;2207.724034495692;2221.5112675211426;2228.832837537183;2232.363776323748;2234.597772400967;2157.2880949286778;2208.3485371815273;2218.3566765637947;2222.51104756954;2225.5771403433378;2148.9677654835114;2189.8467107302495;2204.019211450905;2206.6138425775425;2207.4260692219977;2087.4468265909622;2088.1960445228547;2093.194120263694;2100.170432679083;2101.4116047506723;2106.31544747956;2160.902759375832;2161.1571487120036;2161.297578287047;2163.4807646164963;7642.235776422369;7779.572123533203;7799.96100019502;7862.68549258029;7902.723404680809;4320.935185972213;4501.392312037899;4509.1658043262105;4510.458744950594;4512;2777.9444411111867;2829.349249672566;2903.11455006223;2910.3451723362073;2918.64976202857;869.4783130121939;882.6822343956171;887.6671248281895;909.9818003639956;923.169147767015;10132.54403551842;10143.28996970205;10194.745131371701;10197.796044079078;10254.948725256327;3787.14789172434;3953.327934251184;4065;4103.261412945699;4111.9177616447505;8283.08886022537;8284.627191776384;8307.460015098999;8323.708670196515;8327.791805204797;4345.739255644671;4362.498312694081;4368.257396242647;4387.605115539617;4389.670774691911;3535.2045789697627;3967.900802479961;4090.6318431341324;4098.262312783668;4141.503019637663;3506.5441492605796;3506.6493350664728;3616.5479315085613;3617.6924961378577;3627.093226693327;1058.2909450668071;1085.4409978860892;1086.9782604347868;1088.7441451258949;1092.1426680056277;773.2460850670664;811.4684881402691;811.7564730580802;815.3843847894801;826.0582935453588;5018.623603229772;5020.347354843847;5035.949640503548;5057.620678449131;5077.746112694351;374.99812500937867;388.76868263383244;390.2039838728961;395.20366461579937;397.3959581436201;3360.428727116396;3426.8286585670617;3532.8056956867617;3559.626239244894;3652.470391793175;9431.858522122173;9925.454100024424;9936.403815771077;9944.701658950244;9960.501974901372;9842.80314393708;9843.114119729258;9850.162736167505;9864.950675246579;9865.852012219822;7017.298270173044;7159.140903091662;7187.712491500281;7233.638318083969;7261.092363454568;5119.692818430906;5158.561522270499;5191.870203244949;5214.374275087014;5235.319408476874;8579.528125952882;8608.182222688834;8795.824083518422;8940.597673104596;8975.192232699088;8902.821943560963;9050.411723237969;9061.77345566366;9281.48951807657;9439.244860411014;6416.197975253093;6782.186137663314;7340.70637174507;7498.137714162941;7532;6659.733610655713;7439.590822504814;7491.363234124942;7615.5430674159725;7628.275313845176;6491.675416229075;6515.381038801306;6552.1154644124335;6662.467002639681;6693.09643198162;6479.352064793483;6516.380943810331;6552.967235163794;6645.667716614246;6658.533902626769;6306.369363063841;6430;6433.935660643334;6440.355964403522;6443.516736244894;4452.065066336106;4466.776661166864;4543.250363689954;4580;4652.511486293891;4293.742375457483;4431.468223813163;4508.842190523316;4547.840825571089;4628.629709623289 09:54:51 INFO - PROCESS | 12811 | |4;prototype.html;283.55765006589723;285.60301181357903;289.3980520517324;290.7470500664422;292.909198148574;4924.78384726873;4926.926096108552;4934.950650493494;4945.109880221563;4947.455779864212;4832.637552183583;4843.39457567804;4875.512448755123;4877.731724755137;4906.607471402288;3551.236484155906;3643.908902277451;3694.4827724118645;3741.86903458379;3793.905152371199;3786.772793632391;3787.8484860605545;3792.2225943681615;3801.2967600993907;3812.5043744313202;3751.8124093795336;3772.5850156482766;3781.4138808484727;3783.281176576442;3783.69730421567;3558.34170678424;3637.508936293606;3748.475213470089;3767.8492860285555;3776.131489757344;3318.5685860837934;3320.9078280683257;3330.283988942365;3332.4334863073336;3335.116194208537;4725.031368569435;4742.553521176074;4747.074320507502;4752;4758.286257061434;4216.2199993001395;4310.504292006428;4311.8490852820005;4337.917799456247;4345.869623911288;5048.343715317022;5055.317532133152;5072.416672082721;5077.162268225738;5079.31429257053;3622.9094272643133;3638.308721342963;3645.2527231917393;3645.2891686121216;3648.6533779290926;5153;5258.579313654898;5314.73426328682;5336.386315573681;5346.03771321162;3731.384321586962;3774.339490589191;3778.4130665120715;3781.5273090863643;3783.1677031053123;3820.4078367853026;3828.3874580067054;3834.8082595870096;3835.1179228777537;3864.2078373933277;4365.956340436618;4368.672349573794;4376.934345984812;4390.868273951786;4393.121375724868;4986.950130498722;5064.316317297192;5071.87320316995;5081.347217121115;5081.695098294114;1314.7041915569112;1315.7565850317721;1323.6293837725452;1328.7873940169527;1330.9534166304134;845.6575087089739;848.3849209323315;860.8636599688476;861.4658911474926;877.2368039805283;4429.247028005247;4435.669299210224;4449.154660614473;4450.421445212167;4476.798544065525;5171.870703232449;5175.792968281226;5176.430592634807;5189.766460509286;5201.661891977085;4334.436523251957;4475.977620111878;4485.577787994512;4489.708168969007;4494.303382975644;2747.766439852635;2747.8184380716484;2748.8213266137636;2771.196353057631;2773.6547774329433;4839.1531481991215;4848.17581011229;4856.587190088811;4864.416270047617;4870.8782280442565;5146.974265128651;5294.258803767476;5304.151335786333;5311.7344132793205;5336.786528538815;4794;4847.103285892122;4849.854504364875;4855.587275081658;4863.148948933993;5134.512221338967;5145.867909060001;5147.933132825026;5181.844544663666;5204.73976301191;4927.827526036572;5060.645754797129;5074.923876141935;5097.745112744422;5123.282740416419;4811.831585894477;4831.710097394168;4841.12859685246;4857.684250523705;4857.878553036202;3693.6121707220354;3697.6487233712755;3736.8318425671455;3747.8688245912354;3757.793321367351;4995.425526064549;5171.689698618095;5224.843254702365;5234.63357564982;5243.947560524346;4971.53339764763;4998.500749625187;4999.250112483157;5012.749362531786;5013.473585273494;4991.5008499151245;4993.475685053162;5053.2420136979745;5080.263361812443;5081.9745901271735;4853.878653033702;4913.385826771653;4931.556159945622;5002.324686167321;5003.249512573143;4881.072596206709;4958.206686930074;4996.800127994839;5035.295058691713;5039.294498770102;4964.411388355691;4970.552650261494;4971.527704868032;4974.104661161025;4991.650584459198 09:54:51 INFO - PROCESS | 12811 | |5;yui.html;624.4629618528066;642.0145077306336;655.5935320101538;705.6789160931777;722.4256715910852;11746;12403.069769767259;12413.131080824345;12434.191777534454;12454.564090256843;12492.437840297185;12603.306818125022;12617.684557886034;12647.936760316186;12692;628.6636649392576;746.164295988491;771.178694690156;781.281221276427;790.1624278265028;780.6955287437904;790.4269404681588;791.0823444804029;791.1771757372326;791.5765065689857;845.2055068235838;845.8731190321439;847.9533625650587;848.2620120495178;849.842779085868;667.1027468055457;783.8158032862273;826.5825757992236;837.9497230166179;838.3544670603632;604.7429842316998;607.7872744539376;608.2913405882142;608.3399511529996;608.3794529579848;11996.520139194421;12019.699507512294;12036.939815300868;12038.4582693779;12044.036477081812;11085.390303533302;11701.590444334493;11885.465154068088;11909.821352679717;13294.65387524377;9868.753281167956;10054.195664346835;11719.882801171965;11816.500924491582;11829.171957962946;4086;4088.8773336799645;4106.609872062179;4134.627883490501;4292.098659281554;62915.37084629141;63376.36623633797;63552;63563.3643663562;65050.3494965049;9450.48022358763;9559.235261179088;9711.174550163316;9726.36778609388;10110.342827716175;17309.7403538947;17327.306907723803;17327.740083898752;17350.65298694019;17353.4793956179;6454.806355809334;6519.608823470607;6526.24948130971;6527.2167339919515;6544.214694236627;3823.1397935464297;3826.7512611680154;3841.0397400649836;3910.589388114264;3972.900677483086;2749.670039595261;2807.3122085089285;2834.844083575423;2838.6309779728504;2849.074050933455;446.1834842238695;448.5402462475988;457.13601293555206;460.22222444069416;464.3104989091197;516.5093161496518;550.9256250406144;554.2517601238377;568.1335962656981;572.4418691775486;7840.803979900548;8037.517748935083;8284.71003514874;8439.198276163756;8568.742937711879;504.83088165464983;536.1796451429319;536.5385768239311;551.9282493275848;570.3640440908357;3315.5689760331;3419.504171895061;3469.670381313771;3677.6506231907924;3827.732058755916;57778.7111064442;58481.415185847596;75445.62277188578;95189;100482.49758751306;70108;76156.23843761491;79400.60299698464;80489.19510804935;84696;65070;69138;69743;71097;72814;7863.764087077397;8464.788380290542;8568.186022327869;8678.305735541267;8724.912750872663;42763.35854962116;43141.352879707454;43235.9191020227;43529.34705979476;43879.122417552106;59971;62888;63111.6844415775;63263;65504.34495654982;11131.332120072822;11307.717307067389;11431.142664300378;11646.475908583965;11720.648380548597;13187.53843615469;13201.405936732677;13298.202107873558;13313;13514.729705406033;12110.757784844078;12263.707702304122;12569.1201615886;13170.07809453329;13194;12011.339376334385;12172.75654486923;12220.450079746255;12485.876271135641;12946.870531294566;11687.123465739933;11993.760124797629;12161.148719589544;12380.81428778587;12508.374581270718;9860.211183105477;10074.44590547527;10080.445575493419;10106.6462673809;10288.588456461657;9271.76820579491;9316;10550.155987520826;10618.469076546296;10639.787204255717 09:54:51 INFO - PROCESS | 12811 | __end_tp_report 09:54:51 INFO - PROCESS | 12811 | __start_cc_report 09:54:51 INFO - PROCESS | 12811 | _x_x_mozilla_cycle_collect,1226 09:54:51 INFO - PROCESS | 12811 | __end_cc_report 09:54:51 INFO - PROCESS | 12811 | __startTimestamp1470243291260__endTimestamp 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | ------- Summary: start ------- 09:54:51 INFO - PROCESS | 12811 | Number of tests: 6 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | [#0] dojo.html Cycles:165 Average:4879.41 Median:4986.18 stddev:522.42 (10.5%) stddev-sans-first:495.20 09:54:51 INFO - PROCESS | 12811 | Values: 2697.6 2699.5 2736.9 2744.5 2752.8 4770.5 4843.2 4938.7 4988.4 4992.2 4885.0 4885.7 4887.9 4890.4 4927.1 4422.9 4453.9 4475.1 4483.1 4526.7 4433.5 4488.7 4508.8 4529.0 4571.8 4586.4 4603.5 4613.1 4634.9 4639.2 4395.4 4445.6 4446.1 4507.2 4577.3 4414.9 4415.1 4429.9 4438.7 4512.5 4908.0 4938.5 4941.1 4951.1 4963.4 5046.4 5177.0 5215.6 5280.9 5322.5 5155.0 5313.6 5366.6 5372.8 5376.1 4937.6 4962.5 4972.9 4984.2 4986.2 5269.7 5377.1 5450.1 5460.7 5478.5 5227.9 5258.6 5268.6 5286.0 5287.8 5297.2 5301.2 5320.2 5337.3 5355.4 5029.3 5207.6 5242.6 5246.4 5262.2 5245.6 5281.2 5291.5 5311.2 5319.1 4509.4 4511.8 4512.0 4521.9 4560.5 3833.5 3890.7 3930.5 3951.8 3981.2 4547.1 4565.6 4572.4 4628.9 4637.1 5332.3 5344.0 5348.9 5352.6 5397.1 4414.8 4487.9 4525.0 4577.7 4630.3 4750.8 4773.5 4784.3 4837.4 4838.3 4952.5 4959.3 4959.6 4967.7 5004.6 5163.4 5247.3 5251.3 5305.1 5361.9 4938.8 4940.7 4944.1 4966.4 4996.7 5200.7 5211.5 5214.6 5221.1 5267.8 5097.9 5251.3 5267.6 5268.4 5298.9 5144.1 5175.8 5198.0 5256.6 5264.7 5180.9 5192.5 5199.2 5215.1 5254.6 4815.1 4837.1 5017.4 5110.8 5178.4 5160.5 5196.0 5208.2 5246.7 5253.4 5036.3 5070.2 5087.6 5088.5 5127.7 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | [#1] ext.html Cycles:180 Average:47278.30 Median:210602.71 stddev:84564.90 (40.2%) stddev-sans-first:84729.37 09:54:51 INFO - PROCESS | 12811 | Values: 558.4 558.7 565.7 572.5 573.4 29288.6 39216.2 41137.0 41306.6 44527.3 40764.6 40870.2 40922.8 41155.0 41213.0 7495.1 7627.2 7631.4 7631.7 7636.3 7635.0 7743.0 7747.2 7772.4 7831.5 7789.8 7805.3 7816.3 7867.5 7870.9 7823.1 7864.1 7867.1 7869.1 7874.5 7688.0 7728.0 7745.8 7762.1 7768.4 39002.6 39280.4 39339.0 39349.8 39407.2 2941.4 3057.6 3096.0 3145.4 3185.2 28838.3 29120.9 29181.1 29418.4 29544.7 3372.8 3395.8 3409.8 3444.3 3480.0 239793.0 240278.0 240906.0 241561.0 241568.0 53356.0 53652.0 53720.5 53760.7 53770.5 33376.0 34653.7 34711.7 36246.6 36292.3 13655.7 13806.4 13824.1 13846.1 13849.2 9802.9 9866.4 9882.7 9885.7 9898.3 18654.2 18665.6 18694.6 18756.2 18796.9 6801.7 6805.8 6881.5 6890.7 6913.0 808.8 902.0 920.5 995.0 1057.5 27631.0 28310.2 29031.7 29434.4 29634.3 749.5 961.5 962.7 1000.7 1044.2 14539.3 15121.6 15173.7 15283.8 15578.5 378518.0 381236.0 382922.0 383081.0 384220.0 48389.3 48844.5 48855.0 48881.5 48948.5 1097.1 1164.2 1167.7 1178.6 1186.7 28232.4 29644.6 29933.6 30026.0 30528.4 43227.8 43793.1 43794.8 43819.0 43837.0 296542.0 296586.0 297178.0 298486.0 420667.0 37590.0 40008.4 40515.2 40539.8 41105.2 43102.4 43742.3 43865.6 43993.3 44097.1 37066.6 37246.4 37370.6 37667.6 38283.4 36474.0 36515.6 36799.0 37197.4 37485.4 36888.3 37055.4 37374.3 37450.4 38265.4 31951.2 34129.7 34396.8 34564.5 34609.7 25872.9 26336.3 26410.0 26495.2 26545.9 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | [#2] jquery.html Cycles:180 Average:24397.99 Median:5054.02 stddev:66543.06 (1316.6%) stddev-sans-first:66705.20 09:54:51 INFO - PROCESS | 12811 | Values: 335.3 345.6 357.6 366.4 367.2 12723.7 12878.9 13631.6 16765.9 16944.5 15949.5 16009.5 16370.8 16399.7 16537.5 5022.0 5029.4 5090.1 5126.6 5133.3 3715.8 5036.3 5085.7 5090.4 5578.2 5823.5 5899.4 5909.3 5915.6 5920.7 4883.2 5096.6 5134.9 5933.4 5940.3 4864.2 5033.4 5051.3 5051.7 5056.4 11767.8 12104.9 12112.4 12117.1 12122.4 1839.0 1898.3 1977.7 2034.6 2328.6 8783.7 8791.8 8982.6 8982.7 12054.6 1634.9 1679.6 1725.4 1735.3 1738.8 72202.0 74904.6 75286.9 76067.6 77962.6 8547.7 8805.2 9148.8 9237.7 9375.8 11164.1 11212.2 11256.0 11279.3 11324.7 6736.4 6820.3 6854.2 6855.5 7061.2 6677.6 6804.4 6952.5 7061.1 7070.1 3429.5 3500.0 3521.6 3596.2 3624.8 1672.3 1721.9 1744.4 1754.2 1764.3 883.3 894.2 918.8 927.7 941.9 16113.8 16480.9 16861.0 17705.5 18100.0 857.2 870.2 889.5 902.4 926.2 9595.9 9753.4 9982.6 9992.5 10156.7 381758.0 403466.0 406362.0 408327.0 409445.0 49787.5 53456.0 85697.0 88123.1 88221.0 882.8 910.4 920.9 923.0 924.3 15709.7 15771.1 16345.4 16461.2 16683.2 35811.6 38613.0 40737.8 41104.6 41749.6 53200.7 54486.0 54557.7 54676.5 55757.7 7517.6 7528.5 7602.8 7817.1 7825.2 11605.8 12029.2 12178.5 12200.0 12635.3 9255.2 9777.9 9919.2 9967.8 10230.5 10224.3 10348.2 10378.1 10388.4 10592.2 9854.3 9904.8 9932.5 10346.8 10366.2 7473.1 7578.2 7648.4 7718.2 7872.8 4931.9 8110.8 8783.1 9828.2 9829.1 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | [#3] mootools.html Cycles:180 Average:5053.76 Median:5019.49 stddev:2876.76 (57.3%) stddev-sans-first:2870.80 09:54:51 INFO - PROCESS | 12811 | Values: 1272.5 1412.8 1427.6 1482.7 1687.1 6645.9 7391.2 7735.5 7738.8 7922.2 7755.5 7826.7 7830.4 7834.8 7841.2 2207.7 2221.5 2228.8 2232.4 2234.6 2157.3 2208.3 2218.4 2222.5 2225.6 2149.0 2189.8 2204.0 2206.6 2207.4 2087.4 2088.2 2093.2 2100.2 2101.4 2106.3 2160.9 2161.2 2161.3 2163.5 7642.2 7779.6 7800.0 7862.7 7902.7 4320.9 4501.4 4509.2 4510.5 4512.0 2777.9 2829.3 2903.1 2910.3 2918.6 869.5 882.7 887.7 910.0 923.2 10132.5 10143.3 10194.7 10197.8 10254.9 3787.1 3953.3 4065.0 4103.3 4111.9 8283.1 8284.6 8307.5 8323.7 8327.8 4345.7 4362.5 4368.3 4387.6 4389.7 3535.2 3967.9 4090.6 4098.3 4141.5 3506.5 3506.6 3616.5 3617.7 3627.1 1058.3 1085.4 1087.0 1088.7 1092.1 773.2 811.5 811.8 815.4 826.1 5018.6 5020.3 5035.9 5057.6 5077.7 375.0 388.8 390.2 395.2 397.4 3360.4 3426.8 3532.8 3559.6 3652.5 9431.9 9925.5 9936.4 9944.7 9960.5 9842.8 9843.1 9850.2 9865.0 9865.9 7017.3 7159.1 7187.7 7233.6 7261.1 5119.7 5158.6 5191.9 5214.4 5235.3 8579.5 8608.2 8795.8 8940.6 8975.2 8902.8 9050.4 9061.8 9281.5 9439.2 6416.2 6782.2 7340.7 7498.1 7532.0 6659.7 7439.6 7491.4 7615.5 7628.3 6491.7 6515.4 6552.1 6662.5 6693.1 6479.4 6516.4 6553.0 6645.7 6658.5 6306.4 6430.0 6433.9 6440.4 6443.5 4452.1 4466.8 4543.3 4580.0 4652.5 4293.7 4431.5 4508.8 4547.8 4628.6 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | [#4] prototype.html Cycles:180 Average:4204.27 Median:4842.26 stddev:1211.73 (25.0%) stddev-sans-first:1178.85 09:54:51 INFO - PROCESS | 12811 | Values: 283.6 285.6 289.4 290.7 292.9 4924.8 4926.9 4935.0 4945.1 4947.5 4832.6 4843.4 4875.5 4877.7 4906.6 3551.2 3643.9 3694.5 3741.9 3793.9 3786.8 3787.8 3792.2 3801.3 3812.5 3751.8 3772.6 3781.4 3783.3 3783.7 3558.3 3637.5 3748.5 3767.8 3776.1 3318.6 3320.9 3330.3 3332.4 3335.1 4725.0 4742.6 4747.1 4752.0 4758.3 4216.2 4310.5 4311.8 4337.9 4345.9 5048.3 5055.3 5072.4 5077.2 5079.3 3622.9 3638.3 3645.3 3645.3 3648.7 5153.0 5258.6 5314.7 5336.4 5346.0 3731.4 3774.3 3778.4 3781.5 3783.2 3820.4 3828.4 3834.8 3835.1 3864.2 4366.0 4368.7 4376.9 4390.9 4393.1 4987.0 5064.3 5071.9 5081.3 5081.7 1314.7 1315.8 1323.6 1328.8 1331.0 845.7 848.4 860.9 861.5 877.2 4429.2 4435.7 4449.2 4450.4 4476.8 5171.9 5175.8 5176.4 5189.8 5201.7 4334.4 4476.0 4485.6 4489.7 4494.3 2747.8 2747.8 2748.8 2771.2 2773.7 4839.2 4848.2 4856.6 4864.4 4870.9 5147.0 5294.3 5304.2 5311.7 5336.8 4794.0 4847.1 4849.9 4855.6 4863.1 5134.5 5145.9 5147.9 5181.8 5204.7 4927.8 5060.6 5074.9 5097.7 5123.3 4811.8 4831.7 4841.1 4857.7 4857.9 3693.6 3697.6 3736.8 3747.9 3757.8 4995.4 5171.7 5224.8 5234.6 5243.9 4971.5 4998.5 4999.3 5012.7 5013.5 4991.5 4993.5 5053.2 5080.3 5082.0 4853.9 4913.4 4931.6 5002.3 5003.2 4881.1 4958.2 4996.8 5035.3 5039.3 4964.4 4970.6 4971.5 4974.1 4991.7 09:54:51 INFO - PROCESS | 12811 | 09:54:51 INFO - PROCESS | 12811 | [#5] yui.html Cycles:180 Average:16884.42 Median:458.68 stddev:23198.67 (5057.7%) stddev-sans-first:23231.62 09:54:51 INFO - PROCESS | 12811 | Values: 624.5 642.0 655.6 705.7 722.4 11746.0 12403.1 12413.1 12434.2 12454.6 12492.4 12603.3 12617.7 12647.9 12692.0 628.7 746.2 771.2 781.3 790.2 780.7 790.4 791.1 791.2 791.6 845.2 845.9 848.0 848.3 849.8 667.1 783.8 826.6 837.9 838.4 604.7 607.8 608.3 608.3 608.4 11996.5 12019.7 12036.9 12038.5 12044.0 11085.4 11701.6 11885.5 11909.8 13294.7 9868.8 10054.2 11719.9 11816.5 11829.2 4086.0 4088.9 4106.6 4134.6 4292.1 62915.4 63376.4 63552.0 63563.4 65050.3 9450.5 9559.2 9711.2 9726.4 10110.3 17309.7 17327.3 17327.7 17350.7 17353.5 6454.8 6519.6 6526.2 6527.2 6544.2 3823.1 3826.8 3841.0 3910.6 3972.9 2749.7 2807.3 2834.8 2838.6 2849.1 446.2 448.5 457.1 460.2 464.3 516.5 550.9 554.3 568.1 572.4 7840.8 8037.5 8284.7 8439.2 8568.7 504.8 536.2 536.5 551.9 570.4 3315.6 3419.5 3469.7 3677.7 3827.7 57778.7 58481.4 75445.6 95189.0 100482.5 70108.0 76156.2 79400.6 80489.2 84696.0 65070.0 69138.0 69743.0 71097.0 72814.0 7863.8 8464.8 8568.2 8678.3 8724.9 42763.4 43141.4 43235.9 43529.3 43879.1 59971.0 62888.0 63111.7 63263.0 65504.3 11131.3 11307.7 11431.1 11646.5 11720.6 13187.5 13201.4 13298.2 13313.0 13514.7 12110.8 12263.7 12569.1 13170.1 13194.0 12011.3 12172.8 12220.5 12485.9 12946.9 11687.1 11993.8 12161.1 12380.8 12508.4 9860.2 10074.4 10080.4 10106.6 10288.6 9271.8 9316.0 10550.2 10618.5 10639.8 09:54:51 INFO - PROCESS | 12811 | -------- Summary: end -------- 09:54:51 INFO - PROCESS | 12811 | 09:54:52 INFO - TEST-INFO | 12811: exit 0 09:54:52 INFO - TEST-OK | dromaeo_css | took 1120790ms 09:54:52 INFO - TEST-START | kraken 09:54:52 INFO - operating with platform_type : linux_ 09:54:52 INFO - Initialising browser for kraken test... 09:54:52 INFO - TEST-INFO | started process 13004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEGI7Hd/profile http://localhost:41130/getInfo.html) 09:54:56 INFO - PROCESS | 13004 | __metrics Screen width/height:1600/1200 09:54:56 INFO - PROCESS | 13004 | colorDepth:24 09:54:56 INFO - PROCESS | 13004 | Browser inner width/height: 1024/697 09:54:56 INFO - PROCESS | 13004 | __metrics 09:54:57 INFO - PROCESS | 13004 | 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" 09:54:57 INFO - PROCESS | 13004 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:54:58 INFO - TEST-INFO | 13004: exit 0 09:54:58 INFO - Browser initialized. 09:54:58 INFO - Running cycle 1/1 for kraken test... 09:54:58 INFO - TEST-INFO | started process 13085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEGI7Hd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:10 INFO - PROCESS | 13085 | RSS: Main: 157278208 09:55:10 INFO - PROCESS | 13085 | 09:55:12 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41130/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:13 INFO - PROCESS | 13085 | RSS: Main: 214183936 09:55:13 INFO - PROCESS | 13085 | 09:55:16 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41130/tests/kraken/driver.html?testName=audio-dft) 09:55:17 INFO - PROCESS | 13085 | RSS: Main: 192102400 09:55:17 INFO - PROCESS | 13085 | 09:55:20 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41130/tests/kraken/driver.html?testName=audio-fft) 09:55:20 INFO - PROCESS | 13085 | RSS: Main: 271110144 09:55:20 INFO - PROCESS | 13085 | 09:55:23 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41130/tests/kraken/driver.html?testName=audio-oscillator) 09:55:23 INFO - PROCESS | 13085 | RSS: Main: 180330496 09:55:23 INFO - PROCESS | 13085 | 09:55:25 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:26 INFO - PROCESS | 13085 | RSS: Main: 185135104 09:55:26 INFO - PROCESS | 13085 | 09:55:29 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41130/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:30 INFO - PROCESS | 13085 | RSS: Main: 222117888 09:55:30 INFO - PROCESS | 13085 | 09:55:33 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41130/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:34 INFO - PROCESS | 13085 | RSS: Main: 215511040 09:55:34 INFO - PROCESS | 13085 | 09:55:37 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41130/tests/kraken/driver.html?testName=json-parse-financial) 09:55:38 INFO - PROCESS | 13085 | RSS: Main: 218730496 09:55:38 INFO - PROCESS | 13085 | 09:55:39 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:40 INFO - PROCESS | 13085 | RSS: Main: 184410112 09:55:40 INFO - PROCESS | 13085 | 09:55:42 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:42 INFO - PROCESS | 13085 | RSS: Main: 190316544 09:55:42 INFO - PROCESS | 13085 | 09:55:44 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:45 INFO - PROCESS | 13085 | RSS: Main: 193810432 09:55:45 INFO - PROCESS | 13085 | 09:55:48 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:49 INFO - PROCESS | 13085 | RSS: Main: 188579840 09:55:49 INFO - PROCESS | 13085 | 09:55:51 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:52 INFO - PROCESS | 13085 | RSS: Main: 192847872 09:55:52 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | Cycle 1(1): loaded http://localhost:41130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41130/tests/kraken/driver.html?testName=ai-astar) 09:55:54 INFO - PROCESS | 13085 | RSS: Main: 243560448 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | __start_tp_report 09:55:54 INFO - PROCESS | 13085 | _x_x_mozilla_page_load 09:55:54 INFO - PROCESS | 13085 | _x_x_mozilla_page_load_details 09:55:54 INFO - PROCESS | 13085 | |i|pagename|runs| 09:55:54 INFO - PROCESS | 13085 | |0;ai-astar;106;115;115;116;116;115;115;114;114;115 09:55:54 INFO - PROCESS | 13085 | |1;audio-beat-detection;154;123;126;201;130;124;146;123;163;124 09:55:54 INFO - PROCESS | 13085 | |2;audio-dft;162;162;162;163;162;160;160;161;161;161 09:55:54 INFO - PROCESS | 13085 | |3;audio-fft;79;76;75;123;75;79;76;75;111;75 09:55:54 INFO - PROCESS | 13085 | |4;audio-oscillator;87;86;119;84;86;85;119;85;85;131 09:55:54 INFO - PROCESS | 13085 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 09:55:54 INFO - PROCESS | 13085 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;146 09:55:54 INFO - PROCESS | 13085 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;94;95 09:55:54 INFO - PROCESS | 13085 | |8;json-parse-financial;65;64;63;63;63;64;63;64;64;64 09:55:54 INFO - PROCESS | 13085 | |9;json-stringify-tinderbox;64;65;66;65;65;65;66;66;65;65 09:55:54 INFO - PROCESS | 13085 | |10;stanford-crypto-aes;79;79;78;79;80;90;82;78;79;77 09:55:54 INFO - PROCESS | 13085 | |11;stanford-crypto-ccm;130;139;130;140;128;128;132;129;181;139 09:55:54 INFO - PROCESS | 13085 | |12;stanford-crypto-pbkdf2;167;166;170;164;163;167;164;169;166;168 09:55:54 INFO - PROCESS | 13085 | |13;stanford-crypto-sha256-iterative;66;71;67;68;65;70;65;67;66;66 09:55:54 INFO - PROCESS | 13085 | __end_tp_report 09:55:54 INFO - PROCESS | 13085 | __start_cc_report 09:55:54 INFO - PROCESS | 13085 | _x_x_mozilla_cycle_collect,1959 09:55:54 INFO - PROCESS | 13085 | __end_cc_report 09:55:54 INFO - PROCESS | 13085 | __startTimestamp1470243354572__endTimestamp 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | ------- Summary: start ------- 09:55:54 INFO - PROCESS | 13085 | Number of tests: 14 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.92 (2.5%) stddev-sans-first:0.71 09:55:54 INFO - PROCESS | 13085 | Values: 106.0 115.0 115.0 116.0 116.0 115.0 115.0 114.0 114.0 115.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:138.00 stddev:25.49 (18.5%) stddev-sans-first:26.63 09:55:54 INFO - PROCESS | 13085 | Values: 154.0 123.0 126.0 201.0 130.0 124.0 146.0 123.0 163.0 124.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 09:55:54 INFO - PROCESS | 13085 | Values: 162.0 162.0 162.0 163.0 162.0 160.0 160.0 161.0 161.0 161.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#3] audio-fft Cycles:10 Average:84.40 Median:75.50 stddev:17.48 (23.2%) stddev-sans-first:18.43 09:55:54 INFO - PROCESS | 13085 | Values: 79.0 76.0 75.0 123.0 75.0 79.0 76.0 75.0 111.0 75.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:18.46 (21.7%) stddev-sans-first:19.24 09:55:54 INFO - PROCESS | 13085 | Values: 87.0 86.0 119.0 84.0 86.0 85.0 119.0 85.0 85.0 131.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:55:54 INFO - PROCESS | 13085 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 09:55:54 INFO - PROCESS | 13085 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:55:54 INFO - PROCESS | 13085 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 09:55:54 INFO - PROCESS | 13085 | Values: 65.0 64.0 63.0 63.0 63.0 64.0 63.0 64.0 64.0 64.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 09:55:54 INFO - PROCESS | 13085 | Values: 64.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 65.0 65.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:3.73 (4.7%) stddev-sans-first:3.93 09:55:54 INFO - PROCESS | 13085 | Values: 79.0 79.0 78.0 79.0 80.0 90.0 82.0 78.0 79.0 77.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:135.50 stddev:15.98 (11.8%) stddev-sans-first:16.71 09:55:54 INFO - PROCESS | 13085 | Values: 130.0 139.0 130.0 140.0 128.0 128.0 132.0 129.0 181.0 139.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 09:55:54 INFO - PROCESS | 13085 | Values: 167.0 166.0 170.0 164.0 163.0 167.0 164.0 169.0 166.0 168.0 09:55:54 INFO - PROCESS | 13085 | 09:55:54 INFO - PROCESS | 13085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.02 (3.0%) stddev-sans-first:2.11 09:55:54 INFO - PROCESS | 13085 | Values: 66.0 71.0 67.0 68.0 65.0 70.0 65.0 67.0 66.0 66.0 09:55:54 INFO - PROCESS | 13085 | -------- Summary: end -------- 09:55:54 INFO - PROCESS | 13085 | 09:55:55 INFO - TEST-INFO | 13085: exit 0 09:55:55 INFO - TEST-OK | kraken | took 63561ms 09:55:55 INFO - SUITE-END | took 1184s 09:55:55 INFO - Completed test suite (00:19:44) 09:55:55 INFO - javascript benchmark 09:55:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.581874809403, 2699.514087464256, 2736.9178924632256, 2744.4511097780437, 2752.8073034887566, 4770.4513980892125, 4843.200871856139, 4938.728369939652, 4988.40139183298, 4992.151334273173, 4884.951150488494, 4885.682430642006, 4887.926681099786, 4890.413150421954, 4927.137750893588, 4422.867313980586, 4453.864264612519, 4475.060237350161, 4483.058557702886, 4526.705764125338, 4433.490148632916, 4488.730676159425, 4508.77456127194, 4529.0, 4571.794269257892, 4586.3579098926175, 4603.516630753773, 4613.146567884935, 4634.930476042862, 4639.164950308943, 4395.406620106277, 4445.5776701213335, 4446.088551846864, 4507.211238033364, 4577.313402989545, 4414.933775993362, 4415.094905544356, 4429.889252768674, 4438.7114837535455, 4512.458504979423, 4908.0, 4938.456769755324, 4941.061198372297, 4951.0840494508275, 4963.40439147301, 5046.419661738911, 5177.042247184283, 5215.582753379758, 5280.9207861882105, 5322.494363035544, 5155.046316431472, 5313.628046036779, 5366.624336296461, 5372.785088596452, 5376.059189641836, 4937.580305674058, 4962.528559786814, 4972.925406118911, 4984.2025275955675, 4986.177280748709, 5269.736513174403, 5377.085895397791, 5450.127979523258, 5460.699661518575, 5478.506934375846, 5227.895442091213, 5258.631895767336, 5268.604854635841, 5285.995660824431, 5287.7884884604955, 5297.152455607084, 5301.1783173608155, 5320.17537281722, 5337.2794672719465, 5355.410904800468, 5029.346184995927, 5207.635465517377, 5242.554382877498, 5246.370435547682, 5262.158054711228, 5245.632805703641, 5281.181416880389, 5291.497307755757, 5311.17676760095, 5319.069162896555, 4509.436320459942, 4511.796969136397, 4511.954880451219, 4521.864344069683, 4560.5211452796975, 3833.463315135883, 3890.7081968851885, 3930.4890364253038, 3951.762894226298, 3981.203759248162, 4547.136044151601, 4565.589096981287, 4572.4055872736335, 4628.930566041512, 4637.1421287062, 5332.33345831771, 5343.973280133574, 5348.946510534923, 5352.57179425645, 5397.082495975694, 4414.845480408235, 4487.932681009787, 4524.9547504524535, 4577.748223847654, 4630.259158534618, 4750.8337208197545, 4773.522647735199, 4784.2823576463115, 4837.419509658864, 4838.298446725205, 4952.529509696573, 4959.256111583291, 4959.578435832995, 4967.652264341461, 5004.624653150955, 5163.3545806774155, 5247.291615631841, 5251.343582052244, 5305.071612467726, 5361.919571206357, 4938.75306234694, 4940.6788558743565, 4944.110060189057, 4966.428860680923, 4996.7001979881325, 5200.739963001759, 5211.504907033977, 5214.634975551675, 5221.138512145453, 5267.78928842842, 5097.9490205098955, 5251.26482292487, 5267.5522580579545, 5268.394134674561, 5298.94701053, 5144.074066668036, 5175.844724658266, 5197.974010129925, 5256.553192978639, 5264.736763161904, 5180.870478238075, 5192.532672059533, 5199.194124910494, 5215.13950198213, 5254.605904557097, 4815.085133824562, 4837.105135549935, 5017.448080711192, 5110.795568177231, 5178.352705911761, 5160.535551800356, 5196.0, 5208.218767184952, 5246.658967167122, 5253.369595648546, 5036.320096787033, 5070.163423035306, 5087.618428617794, 5088.465711100281, 5127.66670166438], "value": 4845.341661139823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.4108765252658, 558.656426297827, 565.6860442454437, 572.507643426653, 573.3549756523912, 29288.560671589945, 39216.21567568651, 41137.0, 41306.586934130646, 44527.33209001859, 40764.59235407645, 40870.18259634806, 40922.79538602303, 41155.0, 41213.0, 7495.100587929443, 7627.2372762723835, 7631.3894888408795, 7631.65657545409, 7636.312731854132, 7635.045619297588, 7743.0, 7747.225277472264, 7772.417068719868, 7831.451798374116, 7789.844203115934, 7805.297523222909, 7816.335611473031, 7867.527948323091, 7870.921290787076, 7823.10034346049, 7864.095629002681, 7867.055953285585, 7869.13439521655, 7874.527528348317, 7688.038995125609, 7728.0, 7745.806354841117, 7762.068551773767, 7768.41736869737, 39002.609973900464, 39280.41079383811, 39339.0, 39349.803250983845, 39407.211855762725, 2941.4411261860178, 3057.5719399284117, 3095.9535606965915, 3145.418097651942, 3185.1877771168206, 28838.279043023882, 29120.854395728096, 29181.124566263046, 29418.41163176746, 29544.704552954412, 3372.780769249991, 3395.8302084895904, 3409.7954122752712, 3444.328355970587, 3479.982600087009, 239793.0, 240278.0, 240905.99999999825, 241561.0, 241568.0, 53356.0, 53652.0, 53720.462795372325, 53760.73119634377, 53770.46229537654, 33376.0, 34653.65346346555, 34711.652883471346, 36246.63753362485, 36292.27415451676, 13655.726885462234, 13806.447742090404, 13824.101433406997, 13846.10000349974, 13849.23829189384, 9802.9019709802, 9866.358686685342, 9882.703518894445, 9885.703428897, 9898.307118501636, 18654.16056277471, 18665.626687466174, 18694.626107477776, 18756.155972981247, 18796.906015469835, 6801.727930882709, 6805.795826125224, 6881.483888708367, 6890.655467226618, 6913.0, 808.8220591469867, 902.0348227396754, 920.4983284110176, 994.9701508954743, 1057.5293994172519, 27631.0, 28310.15069547917, 29031.7096829029, 29434.411311774074, 29634.259143521154, 749.5128166691694, 961.5144352102144, 962.7496850818698, 1000.6697789729371, 1044.2429238801808, 14539.3457294422, 15121.621959451102, 15173.696526069638, 15283.847161528465, 15578.454754083552, 378518.0, 381236.0, 382922.0, 383081.0, 384220.0, 48389.27416088691, 48844.51155488471, 48855.02289954252, 48881.5111848877, 48948.510514895104, 1097.1277834121893, 1164.2083383299437, 1167.7139100920328, 1178.5757127433944, 1186.655869797749, 28232.43535129245, 29644.55533166961, 29933.55099673463, 30026.0, 30528.389432211676, 43227.78386108049, 43793.12413751643, 43794.781026094664, 43819.0, 43837.0, 296542.0, 296586.0, 297178.0, 298486.0, 420667.0, 37590.0, 40008.399874001334, 40515.1896962065, 40539.79730101331, 41105.1778964413, 43102.35346469743, 43742.343864841416, 43865.56134438615, 43993.34009989789, 44097.11805763931, 37066.62933370632, 37246.44130338101, 37370.626293736714, 37667.623323767504, 38283.42574861435, 36474.0, 36515.63484365122, 36799.0, 37197.44203836999, 37485.43771843479, 36888.26223475569, 37055.444168338036, 37374.252514949, 37450.43824342582, 38265.4260186103, 31951.201219968756, 34129.65870341265, 34396.82801585976, 34564.48153277753, 34609.65390346065, 25872.8706356467, 26336.34159146037, 26410.0, 26495.205143845717, 26545.867270663523], "value": 17599.37069631739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.285841158333, 345.590475286785, 357.60127457884465, 366.4155671703632, 367.1573738270669, 12723.681907952307, 12878.871211287897, 13631.591052268435, 16765.904261967255, 16944.491665250032, 15949.52151435456, 16009.519714408558, 16370.754438683429, 16399.67200655986, 16537.503874883772, 5022.02070596233, 5029.421616514092, 5090.109230884599, 5126.641135120543, 5133.307003554528, 3715.8142092895246, 5036.320096786942, 5085.720285384303, 5090.389153301609, 5578.219049333076, 5823.475887170154, 5899.351071382166, 5909.261342332208, 5915.645061296314, 5920.674362910038, 4883.243097319921, 5096.61775366849, 5134.897302053975, 5933.406659334075, 5940.257467816523, 4864.246041863516, 5033.395992480926, 5051.318072060261, 5051.671641343338, 5056.367954005749, 11767.764644707144, 12104.878951210463, 12112.394380281039, 12117.091218158674, 12122.39388030595, 1838.9632207355778, 1898.3260942365537, 1977.6736838421643, 2034.6337659221335, 2328.580855446019, 8783.73648790531, 8791.824163516694, 8982.595783189772, 8982.730518084469, 12054.61371942229, 1634.8610368118725, 1679.6388776413007, 1725.3616162020007, 1735.2798588585722, 1738.8087310395847, 72202.0, 74904.62547687281, 75286.87069694014, 76067.61966190189, 77962.61018694927, 8547.658093676308, 8805.207531322212, 9148.817023659489, 9237.722868313827, 9375.812483750287, 11164.106871450265, 11212.159088068427, 11256.0, 11279.266847654877, 11324.716882078013, 6736.393724564715, 6820.329019390281, 6854.246032936373, 6855.451563874878, 7061.223265440797, 6677.632730199788, 6804.353586409283, 6952.513324067267, 7061.082059332254, 7070.080889484334, 3429.4684323929832, 3499.9650003499637, 3521.6126226115107, 3596.2088340565033, 3624.7825130492256, 1672.339425926752, 1721.8549664473235, 1744.433059255747, 1754.2369069454828, 1764.2766465748982, 883.2845395229884, 894.2398960883197, 918.7703074231442, 927.7355953553205, 941.8587211918267, 16113.758293625606, 16480.917595412186, 16861.0, 17705.468835934942, 18100.0, 857.1514200941148, 870.1516021878745, 889.515214208258, 902.359324879343, 926.2219735422143, 9595.90404095964, 9753.366031207948, 9982.60069597208, 9992.500374981222, 10156.746081348025, 381758.0, 403466.0, 406362.0, 408327.0, 409445.0, 49787.50212497901, 53456.0, 85697.0, 88123.11876881149, 88221.0, 882.8278485695228, 910.3991365698607, 920.9125133112477, 923.0308176414737, 924.2882980105281, 15709.685806284038, 15771.132587707787, 16345.427910023092, 16461.176941153135, 16683.16584170811, 35811.64188358187, 38612.99999999888, 40737.79631101825, 41104.58895411008, 41749.58250417457, 53200.73399632977, 54486.0, 54557.72721136369, 54676.48799606016, 55757.721211393684, 7517.586532740533, 7528.548287102792, 7602.771916842504, 7817.101033381234, 7825.217478252357, 11605.825912611486, 12029.218100823418, 12178.512859485521, 12200.0, 12635.305058221886, 9255.213306868991, 9777.902220977983, 9919.15687166599, 9967.750806229613, 10230.539625717009, 10224.335418197794, 10348.172146228435, 10378.06597406237, 10388.37669739818, 10592.152627789605, 9854.26093043039, 9904.752381190528, 9932.503374831374, 10346.844797327896, 10366.222533309881, 7473.140588832136, 7578.242175782378, 7648.388128949782, 7718.189590093184, 7872.803179920548, 4931.901361972668, 8110.797230069295, 8783.121687831166, 9828.16460600857, 9829.115379615869], "value": 7922.507340237051, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.5482453728932, 1412.8304603447589, 1427.6145440731002, 1482.7108713800806, 1687.1395588249989, 6645.933540664592, 7391.150017747954, 7735.497192682472, 7738.806529836764, 7922.207779222089, 7755.534667919928, 7826.72606458774, 7830.41271904608, 7834.804129896741, 7841.215878412156, 2207.724034495692, 2221.5112675211426, 2228.832837537183, 2232.363776323748, 2234.597772400967, 2157.2880949286778, 2208.3485371815273, 2218.3566765637947, 2222.51104756954, 2225.5771403433378, 2148.9677654835114, 2189.8467107302495, 2204.019211450905, 2206.6138425775425, 2207.4260692219977, 2087.4468265909622, 2088.1960445228547, 2093.194120263694, 2100.170432679083, 2101.4116047506723, 2106.31544747956, 2160.902759375832, 2161.1571487120036, 2161.297578287047, 2163.4807646164963, 7642.235776422369, 7779.572123533203, 7799.96100019502, 7862.68549258029, 7902.723404680809, 4320.935185972213, 4501.392312037899, 4509.1658043262105, 4510.458744950594, 4512.0, 2777.9444411111867, 2829.349249672566, 2903.11455006223, 2910.3451723362073, 2918.64976202857, 869.4783130121939, 882.6822343956171, 887.6671248281895, 909.9818003639956, 923.169147767015, 10132.54403551842, 10143.28996970205, 10194.745131371701, 10197.796044079078, 10254.948725256327, 3787.14789172434, 3953.327934251184, 4065.0, 4103.261412945699, 4111.9177616447505, 8283.08886022537, 8284.627191776384, 8307.460015098999, 8323.708670196515, 8327.791805204797, 4345.739255644671, 4362.498312694081, 4368.257396242647, 4387.605115539617, 4389.670774691911, 3535.2045789697627, 3967.900802479961, 4090.6318431341324, 4098.262312783668, 4141.503019637663, 3506.5441492605796, 3506.6493350664728, 3616.5479315085613, 3617.6924961378577, 3627.093226693327, 1058.2909450668071, 1085.4409978860892, 1086.9782604347868, 1088.7441451258949, 1092.1426680056277, 773.2460850670664, 811.4684881402691, 811.7564730580802, 815.3843847894801, 826.0582935453588, 5018.623603229772, 5020.347354843847, 5035.949640503548, 5057.620678449131, 5077.746112694351, 374.99812500937867, 388.76868263383244, 390.2039838728961, 395.20366461579937, 397.3959581436201, 3360.428727116396, 3426.8286585670617, 3532.8056956867617, 3559.626239244894, 3652.470391793175, 9431.858522122173, 9925.454100024424, 9936.403815771077, 9944.701658950244, 9960.501974901372, 9842.80314393708, 9843.114119729258, 9850.162736167505, 9864.950675246579, 9865.852012219822, 7017.298270173044, 7159.140903091662, 7187.712491500281, 7233.638318083969, 7261.092363454568, 5119.692818430906, 5158.561522270499, 5191.870203244949, 5214.374275087014, 5235.319408476874, 8579.528125952882, 8608.182222688834, 8795.824083518422, 8940.597673104596, 8975.192232699088, 8902.821943560963, 9050.411723237969, 9061.77345566366, 9281.48951807657, 9439.244860411014, 6416.197975253093, 6782.186137663314, 7340.70637174507, 7498.137714162941, 7532.0, 6659.733610655713, 7439.590822504814, 7491.363234124942, 7615.5430674159725, 7628.275313845176, 6491.675416229075, 6515.381038801306, 6552.1154644124335, 6662.467002639681, 6693.09643198162, 6479.352064793483, 6516.380943810331, 6552.967235163794, 6645.667716614246, 6658.533902626769, 6306.369363063841, 6430.0, 6433.935660643334, 6440.355964403522, 6443.516736244894, 4452.065066336106, 4466.776661166864, 4543.250363689954, 4580.0, 4652.511486293891, 4293.742375457483, 4431.468223813163, 4508.842190523316, 4547.840825571089, 4628.629709623289], "value": 3981.888941939414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.55765006589723, 285.60301181357903, 289.3980520517324, 290.7470500664422, 292.909198148574, 4924.78384726873, 4926.926096108552, 4934.950650493494, 4945.109880221563, 4947.455779864212, 4832.637552183583, 4843.39457567804, 4875.512448755123, 4877.731724755137, 4906.607471402288, 3551.236484155906, 3643.908902277451, 3694.4827724118645, 3741.86903458379, 3793.905152371199, 3786.772793632391, 3787.8484860605545, 3792.2225943681615, 3801.2967600993907, 3812.5043744313202, 3751.8124093795336, 3772.5850156482766, 3781.4138808484727, 3783.281176576442, 3783.69730421567, 3558.34170678424, 3637.508936293606, 3748.475213470089, 3767.8492860285555, 3776.131489757344, 3318.5685860837934, 3320.9078280683257, 3330.283988942365, 3332.4334863073336, 3335.116194208537, 4725.031368569435, 4742.553521176074, 4747.074320507502, 4752.0, 4758.286257061434, 4216.2199993001395, 4310.504292006428, 4311.8490852820005, 4337.917799456247, 4345.869623911288, 5048.343715317022, 5055.317532133152, 5072.416672082721, 5077.162268225738, 5079.31429257053, 3622.9094272643133, 3638.308721342963, 3645.2527231917393, 3645.2891686121216, 3648.6533779290926, 5153.0, 5258.579313654898, 5314.73426328682, 5336.386315573681, 5346.03771321162, 3731.384321586962, 3774.339490589191, 3778.4130665120715, 3781.5273090863643, 3783.1677031053123, 3820.4078367853026, 3828.3874580067054, 3834.8082595870096, 3835.1179228777537, 3864.2078373933277, 4365.956340436618, 4368.672349573794, 4376.934345984812, 4390.868273951786, 4393.121375724868, 4986.950130498722, 5064.316317297192, 5071.87320316995, 5081.347217121115, 5081.695098294114, 1314.7041915569112, 1315.7565850317721, 1323.6293837725452, 1328.7873940169527, 1330.9534166304134, 845.6575087089739, 848.3849209323315, 860.8636599688476, 861.4658911474926, 877.2368039805283, 4429.247028005247, 4435.669299210224, 4449.154660614473, 4450.421445212167, 4476.798544065525, 5171.870703232449, 5175.792968281226, 5176.430592634807, 5189.766460509286, 5201.661891977085, 4334.436523251957, 4475.977620111878, 4485.577787994512, 4489.708168969007, 4494.303382975644, 2747.766439852635, 2747.8184380716484, 2748.8213266137636, 2771.196353057631, 2773.6547774329433, 4839.1531481991215, 4848.17581011229, 4856.587190088811, 4864.416270047617, 4870.8782280442565, 5146.974265128651, 5294.258803767476, 5304.151335786333, 5311.7344132793205, 5336.786528538815, 4794.0, 4847.103285892122, 4849.854504364875, 4855.587275081658, 4863.148948933993, 5134.512221338967, 5145.867909060001, 5147.933132825026, 5181.844544663666, 5204.73976301191, 4927.827526036572, 5060.645754797129, 5074.923876141935, 5097.745112744422, 5123.282740416419, 4811.831585894477, 4831.710097394168, 4841.12859685246, 4857.684250523705, 4857.878553036202, 3693.6121707220354, 3697.6487233712755, 3736.8318425671455, 3747.8688245912354, 3757.793321367351, 4995.425526064549, 5171.689698618095, 5224.843254702365, 5234.63357564982, 5243.947560524346, 4971.53339764763, 4998.500749625187, 4999.250112483157, 5012.749362531786, 5013.473585273494, 4991.5008499151245, 4993.475685053162, 5053.2420136979745, 5080.263361812443, 5081.9745901271735, 4853.878653033702, 4913.385826771653, 4931.556159945622, 5002.324686167321, 5003.249512573143, 4881.072596206709, 4958.206686930074, 4996.800127994839, 5035.295058691713, 5039.294498770102, 4964.411388355691, 4970.552650261494, 4971.527704868032, 4974.104661161025, 4991.650584459198], "value": 3815.7180271216494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.4629618528066, 642.0145077306336, 655.5935320101538, 705.6789160931777, 722.4256715910852, 11746.0, 12403.069769767259, 12413.131080824345, 12434.191777534454, 12454.564090256843, 12492.437840297185, 12603.306818125022, 12617.684557886034, 12647.936760316186, 12692.0, 628.6636649392576, 746.164295988491, 771.178694690156, 781.281221276427, 790.1624278265028, 780.6955287437904, 790.4269404681588, 791.0823444804029, 791.1771757372326, 791.5765065689857, 845.2055068235838, 845.8731190321439, 847.9533625650587, 848.2620120495178, 849.842779085868, 667.1027468055457, 783.8158032862273, 826.5825757992236, 837.9497230166179, 838.3544670603632, 604.7429842316998, 607.7872744539376, 608.2913405882142, 608.3399511529996, 608.3794529579848, 11996.520139194421, 12019.699507512294, 12036.939815300868, 12038.4582693779, 12044.036477081812, 11085.390303533302, 11701.590444334493, 11885.465154068088, 11909.821352679717, 13294.65387524377, 9868.753281167956, 10054.195664346835, 11719.882801171965, 11816.500924491582, 11829.171957962946, 4086.0, 4088.8773336799645, 4106.609872062179, 4134.627883490501, 4292.098659281554, 62915.37084629141, 63376.36623633797, 63552.0, 63563.3643663562, 65050.3494965049, 9450.48022358763, 9559.235261179088, 9711.174550163316, 9726.36778609388, 10110.342827716175, 17309.7403538947, 17327.306907723803, 17327.740083898752, 17350.65298694019, 17353.4793956179, 6454.806355809334, 6519.608823470607, 6526.24948130971, 6527.2167339919515, 6544.214694236627, 3823.1397935464297, 3826.7512611680154, 3841.0397400649836, 3910.589388114264, 3972.900677483086, 2749.670039595261, 2807.3122085089285, 2834.844083575423, 2838.6309779728504, 2849.074050933455, 446.1834842238695, 448.5402462475988, 457.13601293555206, 460.22222444069416, 464.3104989091197, 516.5093161496518, 550.9256250406144, 554.2517601238377, 568.1335962656981, 572.4418691775486, 7840.803979900548, 8037.517748935083, 8284.71003514874, 8439.198276163756, 8568.742937711879, 504.83088165464983, 536.1796451429319, 536.5385768239311, 551.9282493275848, 570.3640440908357, 3315.5689760331, 3419.504171895061, 3469.670381313771, 3677.6506231907924, 3827.732058755916, 57778.7111064442, 58481.415185847596, 75445.62277188578, 95189.0, 100482.49758751306, 70108.0, 76156.23843761491, 79400.60299698464, 80489.19510804935, 84696.0, 65070.0, 69138.0, 69743.0, 71097.0, 72814.0, 7863.764087077397, 8464.788380290542, 8568.186022327869, 8678.305735541267, 8724.912750872663, 42763.35854962116, 43141.352879707454, 43235.9191020227, 43529.34705979476, 43879.122417552106, 59971.0, 62888.0, 63111.6844415775, 63263.0, 65504.34495654982, 11131.332120072822, 11307.717307067389, 11431.142664300378, 11646.475908583965, 11720.648380548597, 13187.53843615469, 13201.405936732677, 13298.202107873558, 13313.0, 13514.729705406033, 12110.757784844078, 12263.707702304122, 12569.1201615886, 13170.07809453329, 13194.0, 12011.339376334385, 12172.75654486923, 12220.450079746255, 12485.876271135641, 12946.870531294566, 11687.123465739933, 11993.760124797629, 12161.148719589544, 12380.81428778587, 12508.374581270718, 9860.211183105477, 10074.44590547527, 10080.445575493419, 10106.6462673809, 10288.588456461657, 9271.76820579491, 9316.0, 10550.155987520826, 10618.469076546296, 10639.787204255717], "value": 6454.426048187828, "unit": "score"}], "name": "dromaeo_css", "value": 6361.255148304352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 126.0, 201.0, 130.0, 124.0, 146.0, 123.0, 163.0, 124.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 75.0, 123.0, 75.0, 79.0, 76.0, 75.0, 111.0, 75.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 119.0, 84.0, 86.0, 85.0, 119.0, 85.0, 85.0, 131.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 80.0, 90.0, 82.0, 78.0, 79.0, 77.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 130.0, 140.0, 128.0, 128.0, 132.0, 129.0, 181.0, 139.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 170.0, 164.0, 163.0, 167.0, 164.0, 169.0, 166.0, 168.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 67.0, 68.0, 65.0, 70.0, 65.0, 67.0, 66.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1535.8999999999999, "alertThreshold": 2.0}]} 09:55:55 INFO - Return code: 0 09:55:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:55:55 INFO - # TBPL SUCCESS # 09:55:55 INFO - Running post-action listener: _resource_record_post_action 09:55:55 INFO - [mozharness: 2016-08-03 16:55:55.893863Z] Finished run-tests step (success) 09:55:55 INFO - Running post-run listener: _resource_record_post_run 09:55:55 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521691136; Read time: 16; Write time: 444980 09:55:55 INFO - TinderboxPrint: CPU usage
13.0% 09:55:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:55:55 INFO - TinderboxPrint: I/O write bytes / time
521,691,136 / 444,980 09:55:55 INFO - TinderboxPrint: CPU idle
8,339.1 (87.0%) 09:55:55 INFO - TinderboxPrint: CPU user
1,201.9 (12.5%) 09:55:55 INFO - TinderboxPrint: Swap in / out
0 / 0 09:55:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237162496; Read time: 0; Write time: 235604 09:55:55 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 284528640; Read time: 0; Write time: 209376 09:55:56 INFO - Running post-run listener: _upload_blobber_files 09:55:56 INFO - Blob upload gear active. 09:55:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:55:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:55:56 INFO - (blobuploader) - INFO - Open directory for files ... 09:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:57 INFO - (blobuploader) - INFO - Done attempting. 09:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:58 INFO - (blobuploader) - INFO - Done attempting. 09:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:02 INFO - (blobuploader) - INFO - Done attempting. 09:56:02 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:02 INFO - Return code: 0 09:56:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447e2baebd7b8d807aee4154ca8b1f7c8df1f98dd2a2566e3b6e05351943fdf0e3edd503ca831695c6bbe0dcdc279e7d8af18d76cf3dd1e7b719ea1fab66f33d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f93797dc3237f03ba9a16c8aaf1fe2ca711401657e167f696bdd36a75ec5e23147cb91433fe6efbc2a4f79fed1ebf28407b7c3742eaf9f338ebeea7372a78956", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b02fa114ae3e8c4f5b933db62af4bafc6dc007aabaed3a0777c67c477cdf0839cb3b97f78079ea815f89e4ab14c6859af9ac484dad5213051d322c858443cb3"} 09:56:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:02 INFO - Contents: 09:56:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447e2baebd7b8d807aee4154ca8b1f7c8df1f98dd2a2566e3b6e05351943fdf0e3edd503ca831695c6bbe0dcdc279e7d8af18d76cf3dd1e7b719ea1fab66f33d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f93797dc3237f03ba9a16c8aaf1fe2ca711401657e167f696bdd36a75ec5e23147cb91433fe6efbc2a4f79fed1ebf28407b7c3742eaf9f338ebeea7372a78956", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b02fa114ae3e8c4f5b933db62af4bafc6dc007aabaed3a0777c67c477cdf0839cb3b97f78079ea815f89e4ab14c6859af9ac484dad5213051d322c858443cb3"} 09:56:02 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:02 INFO - Copying logs to upload dir... 09:56:02 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.313449 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-03 09:56:01.962649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 09:56:01.966438) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447e2baebd7b8d807aee4154ca8b1f7c8df1f98dd2a2566e3b6e05351943fdf0e3edd503ca831695c6bbe0dcdc279e7d8af18d76cf3dd1e7b719ea1fab66f33d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f93797dc3237f03ba9a16c8aaf1fe2ca711401657e167f696bdd36a75ec5e23147cb91433fe6efbc2a4f79fed1ebf28407b7c3742eaf9f338ebeea7372a78956", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b02fa114ae3e8c4f5b933db62af4bafc6dc007aabaed3a0777c67c477cdf0839cb3b97f78079ea815f89e4ab14c6859af9ac484dad5213051d322c858443cb3"} build_url:https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447e2baebd7b8d807aee4154ca8b1f7c8df1f98dd2a2566e3b6e05351943fdf0e3edd503ca831695c6bbe0dcdc279e7d8af18d76cf3dd1e7b719ea1fab66f33d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f93797dc3237f03ba9a16c8aaf1fe2ca711401657e167f696bdd36a75ec5e23147cb91433fe6efbc2a4f79fed1ebf28407b7c3742eaf9f338ebeea7372a78956", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b02fa114ae3e8c4f5b933db62af4bafc6dc007aabaed3a0777c67c477cdf0839cb3b97f78079ea815f89e4ab14c6859af9ac484dad5213051d322c858443cb3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 09:56:01.992291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:56:01.992663) ========= 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=c6927cf182745ad25b1d38b9000001fe-1470242119.655222-2070885645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:56:02.077846) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 09:56:02.078189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 09:56:02.078478) ========= ========= Total master_lag: 0.17 =========