builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1469984834.45 results: success (0) buildid: 20160731084225 builduid: cb36e4f38c1043568407e3f793a0594e revision: 79b9736303b6148e7d92d5609e58f8d3aa43b9f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.448022) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.448572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.448854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.505834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.506129) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 10:07:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2016-07-31 10:07:15 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.632103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.632411) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014228 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.681789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:14.682149) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 79b9736303b6148e7d92d5609e58f8d3aa43b9f1 --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 79b9736303b6148e7d92d5609e58f8d3aa43b9f1 --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=9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 10:07:15,234 truncating revision to first 12 chars 2016-07-31 10:07:15,234 Setting DEBUG logging. 2016-07-31 10:07:15,234 attempt 1/10 2016-07-31 10:07:15,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/79b9736303b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 10:07:15,849 unpacking tar archive at: mozilla-central-79b9736303b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:15.653472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:15.654010) ========= script_repo_revision: 79b9736303b6148e7d92d5609e58f8d3aa43b9f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:15.654421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:15.654798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 10:07:15.663494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-31 10:07:15.664094) ========= /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=9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:16 INFO - MultiFileLogger online at 20160731 10:07:16 in /builds/slave/test 10:07:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:07:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:16 INFO - {'append_to_log': False, 10:07:16 INFO - 'base_work_dir': '/builds/slave/test', 10:07:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:07:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:16 INFO - 'branch': 'Firefox-Non-PGO', 10:07:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:16 INFO - 'config_files': ('talos/linux_config.py',), 10:07:16 INFO - 'default_actions': ('clobber', 10:07:16 INFO - 'read-buildbot-config', 10:07:16 INFO - 'download-and-extract', 10:07:16 INFO - 'populate-webroot', 10:07:16 INFO - 'create-virtualenv', 10:07:16 INFO - 'install', 10:07:16 INFO - 'run-tests'), 10:07:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:16 INFO - 'download_minidump_stackwalk': True, 10:07:16 INFO - 'download_symbols': 'ondemand', 10:07:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:16 INFO - 'installer_path': 'installer.exe', 10:07:16 INFO - 'log_level': 'info', 10:07:16 INFO - 'log_name': 'talos', 10:07:16 INFO - 'log_to_console': True, 10:07:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:16 INFO - 'opt_config_files': (), 10:07:16 INFO - 'pip_index': False, 10:07:16 INFO - 'sps_profile': False, 10:07:16 INFO - 'sps_profile_interval': 0, 10:07:16 INFO - 'suite': 'dromaeojs', 10:07:16 INFO - 'system_bits': '32', 10:07:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:16 INFO - 'title': 'talos-linux64-ix-029', 10:07:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:16 INFO - 'use_talos_json': True, 10:07:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:16 INFO - 'work_dir': 'build'} 10:07:16 INFO - [mozharness: 2016-07-31 17:07:16.306112Z] Running clobber step. 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: clobber 10:07:16 INFO - rmtree: /builds/slave/test/build 10:07:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:16 INFO - Running post-action listener: _resource_record_post_action 10:07:16 INFO - [mozharness: 2016-07-31 17:07:16.755616Z] Finished clobber step (success) 10:07:16 INFO - [mozharness: 2016-07-31 17:07:16.755718Z] Running read-buildbot-config step. 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: read_buildbot_config 10:07:16 INFO - Using buildbot properties: 10:07:16 INFO - { 10:07:16 INFO - "project": "", 10:07:16 INFO - "product": "firefox", 10:07:16 INFO - "script_repo_revision": "production", 10:07:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:07:16 INFO - "repository": "", 10:07:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:07:16 INFO - "buildid": "20160731084225", 10:07:16 INFO - "pgo_build": "False", 10:07:16 INFO - "basedir": "/builds/slave/test", 10:07:16 INFO - "buildnumber": 575, 10:07:16 INFO - "slavename": "talos-linux64-ix-029", 10:07:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:07:16 INFO - "platform": "ubuntu64_hw", 10:07:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:07:16 INFO - "branch": "mozilla-central", 10:07:16 INFO - "repo_path": "mozilla-central", 10:07:16 INFO - "revision": "79b9736303b6148e7d92d5609e58f8d3aa43b9f1", 10:07:16 INFO - "stage_platform": "linux64", 10:07:16 INFO - "builduid": "cb36e4f38c1043568407e3f793a0594e", 10:07:16 INFO - "slavebuilddir": "test" 10:07:16 INFO - } 10:07:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:07:16 INFO - Running post-action listener: _resource_record_post_action 10:07:16 INFO - [mozharness: 2016-07-31 17:07:16.758178Z] Finished read-buildbot-config step (success) 10:07:16 INFO - [mozharness: 2016-07-31 17:07:16.758268Z] Running download-and-extract step. 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: download_and_extract 10:07:16 INFO - mkdir: /builds/slave/test/build/tests 10:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:16 INFO - https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:07:17 INFO - Downloaded 1361 bytes. 10:07:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:17 INFO - Using the following test package requirements: 10:07:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'jsshell-linux-x86_64.zip'], 10:07:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:17 INFO - https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:18 INFO - Downloaded 20234384 bytes. 10:07:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:20 INFO - Return code: 0 10:07:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:20 INFO - https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:25 INFO - Downloaded 20234384 bytes. 10:07:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:26 INFO - Return code: 0 10:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:26 INFO - https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:07:27 INFO - Downloaded 14413723 bytes. 10:07:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:07:27 INFO - Return code: 0 10:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:27 INFO - https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:07:29 INFO - Downloaded 55654612 bytes. 10:07:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:29 INFO - mkdir: /builds/slave/test/properties 10:07:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:29 INFO - Contents: 10:07:29 INFO - build_url:https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:29 INFO - Running post-action listener: _resource_record_post_action 10:07:29 INFO - Running post-action listener: set_extra_try_arguments 10:07:29 INFO - [mozharness: 2016-07-31 17:07:29.862198Z] Finished download-and-extract step (success) 10:07:29 INFO - [mozharness: 2016-07-31 17:07:29.862430Z] Running populate-webroot step. 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: populate_webroot 10:07:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:29 INFO - '--tppagecycles', 10:07:29 INFO - '7'], 10:07:29 INFO - 'tests': ['tsvgm']}}, 10:07:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['damp', 'tps']}, 10:07:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'tests': ['damp', 'tps']}, 10:07:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['dromaeo_dom']}, 10:07:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['basic_compositor_video']}, 10:07:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:07:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['a11yr', 10:07:29 INFO - 'ts_paint', 10:07:29 INFO - 'tpaint', 10:07:29 INFO - 'sessionrestore', 10:07:29 INFO - 'sessionrestore_no_auto_restore', 10:07:29 INFO - 'tabpaint']}, 10:07:29 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:29 INFO - 'ts_paint', 10:07:29 INFO - 'tpaint', 10:07:29 INFO - 'sessionrestore', 10:07:29 INFO - 'sessionrestore_no_auto_restore', 10:07:29 INFO - 'tabpaint']}, 10:07:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:29 INFO - 'ts_paint', 10:07:29 INFO - 'tpaint', 10:07:29 INFO - 'sessionrestore', 10:07:29 INFO - 'sessionrestore_no_auto_restore', 10:07:29 INFO - 'tabpaint']}, 10:07:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:29 INFO - 'ts_paint', 10:07:29 INFO - 'tpaint', 10:07:29 INFO - 'sessionrestore', 10:07:29 INFO - 'sessionrestore_no_auto_restore', 10:07:29 INFO - 'tabpaint']}, 10:07:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['a11yr', 10:07:29 INFO - 'ts_paint', 10:07:29 INFO - 'tpaint', 10:07:29 INFO - 'sessionrestore', 10:07:29 INFO - 'sessionrestore_no_auto_restore', 10:07:29 INFO - 'tabpaint']}, 10:07:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['a11yr', 10:07:29 INFO - 'ts_paint', 10:07:29 INFO - 'tpaint', 10:07:29 INFO - 'sessionrestore', 10:07:29 INFO - 'sessionrestore_no_auto_restore', 10:07:29 INFO - 'tabpaint']}, 10:07:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['tsvgx', 10:07:29 INFO - 'tsvgr_opacity', 10:07:29 INFO - 'tart', 10:07:29 INFO - 'tscrollx', 10:07:29 INFO - 'cart']}, 10:07:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:29 INFO - 'tsvgr_opacity', 10:07:29 INFO - 'tart', 10:07:29 INFO - 'tscrollx', 10:07:29 INFO - 'cart']}, 10:07:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'talos_options': ['--disable-e10s'], 10:07:29 INFO - 'tests': ['tp5o']}, 10:07:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'tests': ['tp5o']}, 10:07:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'talos_options': ['--disable-e10s', 10:07:29 INFO - '--xperf_path', 10:07:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:29 INFO - 'tests': ['tp5n']}, 10:07:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:29 INFO - 'talos_options': ['--xperf_path', 10:07:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:29 INFO - 'tests': ['tp5n']}}, 10:07:29 INFO - 'talos.zip': {'path': '', 10:07:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:29 INFO - Running post-action listener: _resource_record_post_action 10:07:29 INFO - [mozharness: 2016-07-31 17:07:29.884773Z] Finished populate-webroot step (success) 10:07:29 INFO - [mozharness: 2016-07-31 17:07:29.884863Z] Running create-virtualenv step. 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: create_virtualenv 10:07:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:07:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:29 INFO - Using real prefix '/usr' 10:07:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:33 INFO - Installing pip.................done. 10:07:33 INFO - Return code: 0 10:07:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:33 INFO - Using env: {'DISPLAY': ':0', 10:07:33 INFO - 'HOME': '/home/cltbld', 10:07:33 INFO - 'LANG': 'en_US.UTF-8', 10:07:33 INFO - 'LANGUAGE': 'en_US:en', 10:07:33 INFO - 'LOGNAME': 'cltbld', 10:07:33 INFO - 'MAIL': '/var/mail/cltbld', 10:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:33 INFO - 'MOZ_NO_REMOTE': '1', 10:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:33 INFO - 'NO_EM_RESTART': '1', 10:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:33 INFO - 'PWD': '/builds/slave/test', 10:07:33 INFO - 'SHELL': '/bin/bash', 10:07:33 INFO - 'SHLVL': '1', 10:07:33 INFO - 'TERM': 'linux', 10:07:33 INFO - 'TMOUT': '86400', 10:07:33 INFO - 'USER': 'cltbld', 10:07:33 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:33 INFO - '_': '/tools/buildbot/bin/python'} 10:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:07:33 INFO - Cleaning up... 10:07:33 INFO - Return code: 0 10:07:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:07:33 INFO - Using env: {'DISPLAY': ':0', 10:07:33 INFO - 'HOME': '/home/cltbld', 10:07:33 INFO - 'LANG': 'en_US.UTF-8', 10:07:33 INFO - 'LANGUAGE': 'en_US:en', 10:07:33 INFO - 'LOGNAME': 'cltbld', 10:07:33 INFO - 'MAIL': '/var/mail/cltbld', 10:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:33 INFO - 'MOZ_NO_REMOTE': '1', 10:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:33 INFO - 'NO_EM_RESTART': '1', 10:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:33 INFO - 'PWD': '/builds/slave/test', 10:07:33 INFO - 'SHELL': '/bin/bash', 10:07:33 INFO - 'SHLVL': '1', 10:07:33 INFO - 'TERM': 'linux', 10:07:33 INFO - 'TMOUT': '86400', 10:07:33 INFO - 'USER': 'cltbld', 10:07:33 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:33 INFO - '_': '/tools/buildbot/bin/python'} 10:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:33 INFO - Downloading/unpacking psutil>=3.1.1 10:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:35 INFO - Installing collected packages: psutil 10:07:35 INFO - Running setup.py install for psutil 10:07:35 INFO - building 'psutil._psutil_linux' extension 10:07:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:07:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:07:36 INFO - building 'psutil._psutil_posix' extension 10:07:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:07:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:07:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:37 INFO - Successfully installed psutil 10:07:37 INFO - Cleaning up... 10:07:37 INFO - Return code: 0 10:07:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:37 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:37 INFO - Using env: {'DISPLAY': ':0', 10:07:37 INFO - 'HOME': '/home/cltbld', 10:07:37 INFO - 'LANG': 'en_US.UTF-8', 10:07:37 INFO - 'LANGUAGE': 'en_US:en', 10:07:37 INFO - 'LOGNAME': 'cltbld', 10:07:37 INFO - 'MAIL': '/var/mail/cltbld', 10:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:37 INFO - 'MOZ_NO_REMOTE': '1', 10:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:37 INFO - 'NO_EM_RESTART': '1', 10:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:37 INFO - 'PWD': '/builds/slave/test', 10:07:37 INFO - 'SHELL': '/bin/bash', 10:07:37 INFO - 'SHLVL': '1', 10:07:37 INFO - 'TERM': 'linux', 10:07:37 INFO - 'TMOUT': '86400', 10:07:37 INFO - 'USER': 'cltbld', 10:07:37 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:37 INFO - '_': '/tools/buildbot/bin/python'} 10:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:07:39 INFO - Installing collected packages: mozsystemmonitor 10:07:39 INFO - Running setup.py install for mozsystemmonitor 10:07:39 INFO - Successfully installed mozsystemmonitor 10:07:39 INFO - Cleaning up... 10:07:39 INFO - Return code: 0 10:07:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:39 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:07:39 INFO - Using env: {'DISPLAY': ':0', 10:07:39 INFO - 'HOME': '/home/cltbld', 10:07:39 INFO - 'LANG': 'en_US.UTF-8', 10:07:39 INFO - 'LANGUAGE': 'en_US:en', 10:07:39 INFO - 'LOGNAME': 'cltbld', 10:07:39 INFO - 'MAIL': '/var/mail/cltbld', 10:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:39 INFO - 'MOZ_NO_REMOTE': '1', 10:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:39 INFO - 'NO_EM_RESTART': '1', 10:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:39 INFO - 'PWD': '/builds/slave/test', 10:07:39 INFO - 'SHELL': '/bin/bash', 10:07:39 INFO - 'SHLVL': '1', 10:07:39 INFO - 'TERM': 'linux', 10:07:39 INFO - 'TMOUT': '86400', 10:07:39 INFO - 'USER': 'cltbld', 10:07:39 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:39 INFO - '_': '/tools/buildbot/bin/python'} 10:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:41 INFO - warning: no files found matching '*.txt' 10:07:41 INFO - no previously-included directories found matching 'build' 10:07:41 INFO - no previously-included directories found matching 'dist' 10:07:41 INFO - no previously-included directories found matching '.git*' 10:07:41 INFO - Installing collected packages: jsonschema, functools32 10:07:41 INFO - Running setup.py install for functools32 10:07:41 INFO - warning: no files found matching '*.txt' 10:07:41 INFO - no previously-included directories found matching 'build' 10:07:41 INFO - no previously-included directories found matching 'dist' 10:07:41 INFO - no previously-included directories found matching '.git*' 10:07:41 INFO - Successfully installed jsonschema functools32 10:07:41 INFO - Cleaning up... 10:07:42 INFO - Return code: 0 10:07:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:42 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:07:42 INFO - Using env: {'DISPLAY': ':0', 10:07:42 INFO - 'HOME': '/home/cltbld', 10:07:42 INFO - 'LANG': 'en_US.UTF-8', 10:07:42 INFO - 'LANGUAGE': 'en_US:en', 10:07:42 INFO - 'LOGNAME': 'cltbld', 10:07:42 INFO - 'MAIL': '/var/mail/cltbld', 10:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:42 INFO - 'MOZ_NO_REMOTE': '1', 10:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:42 INFO - 'NO_EM_RESTART': '1', 10:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:42 INFO - 'PWD': '/builds/slave/test', 10:07:42 INFO - 'SHELL': '/bin/bash', 10:07:42 INFO - 'SHLVL': '1', 10:07:42 INFO - 'TERM': 'linux', 10:07:42 INFO - 'TMOUT': '86400', 10:07:42 INFO - 'USER': 'cltbld', 10:07:42 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:42 INFO - '_': '/tools/buildbot/bin/python'} 10:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:07:42 INFO - Cleaning up... 10:07:42 INFO - Return code: 0 10:07:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:42 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:07:42 INFO - Using env: {'DISPLAY': ':0', 10:07:42 INFO - 'HOME': '/home/cltbld', 10:07:42 INFO - 'LANG': 'en_US.UTF-8', 10:07:42 INFO - 'LANGUAGE': 'en_US:en', 10:07:42 INFO - 'LOGNAME': 'cltbld', 10:07:42 INFO - 'MAIL': '/var/mail/cltbld', 10:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:42 INFO - 'MOZ_NO_REMOTE': '1', 10:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:42 INFO - 'NO_EM_RESTART': '1', 10:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:42 INFO - 'PWD': '/builds/slave/test', 10:07:42 INFO - 'SHELL': '/bin/bash', 10:07:42 INFO - 'SHLVL': '1', 10:07:42 INFO - 'TERM': 'linux', 10:07:42 INFO - 'TMOUT': '86400', 10:07:42 INFO - 'USER': 'cltbld', 10:07:42 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:42 INFO - '_': '/tools/buildbot/bin/python'} 10:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:45 INFO - Downloading docopt-0.6.1.tar.gz 10:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:45 INFO - Running setup.py install for blobuploader 10:07:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:45 INFO - Running setup.py install for requests 10:07:45 INFO - Running setup.py install for docopt 10:07:45 INFO - Successfully installed blobuploader requests docopt 10:07:45 INFO - Cleaning up... 10:07:45 INFO - Return code: 0 10:07:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:45 INFO - Running setup.py (path:/tmp/pip-xUB5uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:45 INFO - Running setup.py (path:/tmp/pip-_zLVJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:46 INFO - Running setup.py (path:/tmp/pip-mk2urO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:46 INFO - Running setup.py (path:/tmp/pip-9K0fmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:46 INFO - Running setup.py (path:/tmp/pip-9X16Yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:46 INFO - Running setup.py (path:/tmp/pip-369Nm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:46 INFO - Running setup.py (path:/tmp/pip-lxUQ0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:46 INFO - Running setup.py (path:/tmp/pip-Sk8REg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:46 INFO - Running setup.py (path:/tmp/pip-fVuIz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:46 INFO - Running setup.py (path:/tmp/pip-C5nY4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:46 INFO - Running setup.py (path:/tmp/pip-c6QFTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:46 INFO - Running setup.py (path:/tmp/pip-affuGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:46 INFO - Running setup.py (path:/tmp/pip-mxJfQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:46 INFO - Running setup.py (path:/tmp/pip-qPYjp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:46 INFO - Running setup.py (path:/tmp/pip-SGVEGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:46 INFO - Running setup.py (path:/tmp/pip-s92VUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:47 INFO - Running setup.py (path:/tmp/pip-wYNtR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:47 INFO - Running setup.py install for manifestparser 10:07:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Running setup.py install for mozcrash 10:07:47 INFO - Running setup.py install for mozdebug 10:07:47 INFO - Running setup.py install for mozdevice 10:07:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Running setup.py install for mozfile 10:07:47 INFO - Running setup.py install for mozhttpd 10:07:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Running setup.py install for mozinfo 10:07:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Running setup.py install for mozInstall 10:07:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Running setup.py install for mozleak 10:07:48 INFO - Running setup.py install for mozlog 10:07:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Running setup.py install for moznetwork 10:07:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Running setup.py install for mozprocess 10:07:48 INFO - Running setup.py install for mozprofile 10:07:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Running setup.py install for mozrunner 10:07:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Running setup.py install for mozscreenshot 10:07:48 INFO - Running setup.py install for moztest 10:07:48 INFO - Running setup.py install for mozversion 10:07:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:48 INFO - Cleaning up... 10:07:48 INFO - Return code: 0 10:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:48 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:48 INFO - Using env: {'DISPLAY': ':0', 10:07:48 INFO - 'HOME': '/home/cltbld', 10:07:48 INFO - 'LANG': 'en_US.UTF-8', 10:07:48 INFO - 'LANGUAGE': 'en_US:en', 10:07:48 INFO - 'LOGNAME': 'cltbld', 10:07:48 INFO - 'MAIL': '/var/mail/cltbld', 10:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:48 INFO - 'MOZ_NO_REMOTE': '1', 10:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:48 INFO - 'NO_EM_RESTART': '1', 10:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:48 INFO - 'PWD': '/builds/slave/test', 10:07:48 INFO - 'SHELL': '/bin/bash', 10:07:48 INFO - 'SHLVL': '1', 10:07:48 INFO - 'TERM': 'linux', 10:07:48 INFO - 'TMOUT': '86400', 10:07:48 INFO - 'USER': 'cltbld', 10:07:48 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:48 INFO - '_': '/tools/buildbot/bin/python'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:49 INFO - Running setup.py (path:/tmp/pip-zgS9dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:49 INFO - Running setup.py (path:/tmp/pip-_IzqVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:49 INFO - Running setup.py (path:/tmp/pip-7F5CYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:49 INFO - Running setup.py (path:/tmp/pip-ezfoFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:49 INFO - Running setup.py (path:/tmp/pip-nZIynu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:49 INFO - Running setup.py (path:/tmp/pip-_aYpwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:49 INFO - Running setup.py (path:/tmp/pip-Nx1EzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:49 INFO - Running setup.py (path:/tmp/pip-E5PZlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:49 INFO - Running setup.py (path:/tmp/pip-GEuBNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:49 INFO - Running setup.py (path:/tmp/pip-38_VYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:49 INFO - Running setup.py (path:/tmp/pip-OJlR8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:49 INFO - Running setup.py (path:/tmp/pip-_PcwCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:50 INFO - Running setup.py (path:/tmp/pip-F1KfWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:50 INFO - Running setup.py (path:/tmp/pip-33OpkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:50 INFO - Running setup.py (path:/tmp/pip-AYWRzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:50 INFO - Running setup.py (path:/tmp/pip-6Qjd54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:50 INFO - Running setup.py (path:/tmp/pip-1lw0rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:52 INFO - Downloading blessings-1.6.tar.gz 10:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:52 INFO - Installing collected packages: blessings 10:07:52 INFO - Running setup.py install for blessings 10:07:52 INFO - Successfully installed blessings 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:52 INFO - Reading from file tmpfile_stdout 10:07:52 INFO - Current package versions: 10:07:52 INFO - argparse == 1.2.1 10:07:52 INFO - blessings == 1.6 10:07:52 INFO - blobuploader == 1.2.4 10:07:52 INFO - docopt == 0.6.1 10:07:52 INFO - functools32 == 3.2.3-2 10:07:52 INFO - jsonschema == 2.5.1 10:07:52 INFO - manifestparser == 1.1 10:07:52 INFO - mozInstall == 1.12 10:07:52 INFO - mozcrash == 0.17 10:07:52 INFO - mozdebug == 0.1 10:07:52 INFO - mozdevice == 0.48 10:07:52 INFO - mozfile == 1.2 10:07:52 INFO - mozhttpd == 0.7 10:07:52 INFO - mozinfo == 0.9 10:07:52 INFO - mozleak == 0.1 10:07:52 INFO - mozlog == 3.3 10:07:52 INFO - moznetwork == 0.27 10:07:52 INFO - mozprocess == 0.23 10:07:52 INFO - mozprofile == 0.28 10:07:52 INFO - mozrunner == 6.12 10:07:52 INFO - mozscreenshot == 0.1 10:07:52 INFO - mozsystemmonitor == 0.3 10:07:52 INFO - moztest == 0.7 10:07:52 INFO - mozversion == 1.4 10:07:52 INFO - psutil == 3.1.1 10:07:52 INFO - requests == 1.2.3 10:07:52 INFO - wsgiref == 0.1.2 10:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 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 0x27f3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:07:53 INFO - Cleaning up... 10:07:53 INFO - Return code: 0 10:07:53 INFO - Running post-action listener: _resource_record_post_action 10:07:53 INFO - Running post-action listener: _start_resource_monitoring 10:07:53 INFO - Starting resource monitoring. 10:07:53 INFO - [mozharness: 2016-07-31 17:07:53.201460Z] Finished create-virtualenv step (success) 10:07:53 INFO - [mozharness: 2016-07-31 17:07:53.201893Z] Running install step. 10:07:53 INFO - Running pre-action listener: _resource_record_pre_action 10:07:53 INFO - Running main action method: install 10:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:53 INFO - Reading from file tmpfile_stdout 10:07:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:53 INFO - Reading from file tmpfile_stdout 10:07:53 INFO - Output received: 10:07:53 INFO - Usage: mozinstall [options] installer 10:07:53 INFO - Options: 10:07:53 INFO - -h, --help show this help message and exit 10:07:53 INFO - -d DEST, --destination=DEST 10:07:53 INFO - Directory to install application into. [default: 10:07:53 INFO - "/builds/slave/test"] 10:07:53 INFO - --app=APP Application being installed. [default: firefox] 10:07:53 INFO - mkdir: /builds/slave/test/build/application 10:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:08:09 INFO - Reading from file tmpfile_stdout 10:08:09 INFO - Output received: 10:08:09 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:09 INFO - Running post-action listener: _resource_record_post_action 10:08:09 INFO - [mozharness: 2016-07-31 17:08:09.495490Z] Finished install step (success) 10:08:09 INFO - [mozharness: 2016-07-31 17:08:09.495833Z] Running run-tests step. 10:08:09 INFO - Running pre-action listener: _resource_record_pre_action 10:08:09 INFO - Running main action method: run_tests 10:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:09 INFO - Python 2.7.3 10:08:09 INFO - Return code: 0 10:08:09 INFO - grabbing minidump binary from tooltool 10:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:09 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 0x2ab23b0>, '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 0x2ab32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:08:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:08:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:08:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:09 INFO - Return code: 0 10:08:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:09 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/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:08:09 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/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:08:09 INFO - Using env: {'DISPLAY': ':0', 10:08:09 INFO - 'HOME': '/home/cltbld', 10:08:09 INFO - 'LANG': 'en_US.UTF-8', 10:08:09 INFO - 'LANGUAGE': 'en_US:en', 10:08:09 INFO - 'LOGNAME': 'cltbld', 10:08:09 INFO - 'MAIL': '/var/mail/cltbld', 10:08:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:09 INFO - 'MOZ_NO_REMOTE': '1', 10:08:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:09 INFO - 'NO_EM_RESTART': '1', 10:08:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:09 INFO - 'PWD': '/builds/slave/test', 10:08:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:09 INFO - 'SHELL': '/bin/bash', 10:08:09 INFO - 'SHLVL': '1', 10:08:09 INFO - 'TERM': 'linux', 10:08:09 INFO - 'TMOUT': '86400', 10:08:09 INFO - 'USER': 'cltbld', 10:08:09 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334', 10:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:09 INFO - '_': '/tools/buildbot/bin/python'} 10:08:09 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/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:08:09 INFO - mozversion application_buildid: 20160731084225 10:08:09 INFO - mozversion application_changeset: 79b9736303b6148e7d92d5609e58f8d3aa43b9f1 10:08:09 INFO - mozversion application_display_name: Nightly 10:08:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:09 INFO - mozversion application_name: Firefox 10:08:09 INFO - mozversion application_remotingname: firefox 10:08:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:08:09 INFO - mozversion application_vendor: Mozilla 10:08:09 INFO - mozversion application_version: 50.0a1 10:08:09 INFO - mozversion platform_buildid: 20160731084225 10:08:09 INFO - mozversion platform_changeset: 79b9736303b6148e7d92d5609e58f8d3aa43b9f1 10:08:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:08:09 INFO - mozversion platform_version: 50.0a1 10:08:09 INFO - using testdate: 1469984889 10:08:09 INFO - actual date: 1469984889 10:08:09 INFO - starting webserver on 'localhost:55369' 10:08:09 INFO - SUITE-START | Running 2 tests 10:08:09 INFO - TEST-START | dromaeo_css 10:08:09 INFO - operating with platform_type : linux_ 10:08:09 INFO - Initialising browser for dromaeo_css test... 10:08:09 INFO - TEST-INFO | started process 4996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSOdTt/profile http://localhost:55369/getInfo.html) 10:08:14 INFO - PROCESS | 4996 | __metrics Screen width/height:1600/1200 10:08:14 INFO - PROCESS | 4996 | colorDepth:24 10:08:14 INFO - PROCESS | 4996 | Browser inner width/height: 1024/697 10:08:14 INFO - PROCESS | 4996 | __metrics 10:08:15 INFO - PROCESS | 4996 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:08:15 INFO - PROCESS | 4996 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:15 INFO - PROCESS | 4996 | console.error: PushService: 10:08:15 INFO - PROCESS | 4996 | stateChangeProcessEnqueue: Error transitioning state 10:08:15 INFO - PROCESS | 4996 | UnknownError 10:08:16 INFO - TEST-INFO | 4996: exit 0 10:08:16 INFO - Browser initialized. 10:08:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:16 INFO - TEST-INFO | started process 5075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSOdTt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:28 INFO - PROCESS | 5075 | RSS: Main: 156950528 10:08:28 INFO - PROCESS | 5075 | 10:09:20 INFO - PROCESS | 5075 | 1469984960592 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:11:32 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:55369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55369/tests/dromaeo/cssquery-ext.html) 10:11:33 INFO - PROCESS | 5075 | RSS: Main: 249790464 10:11:33 INFO - PROCESS | 5075 | 10:14:36 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:55369/tests/dromaeo/cssquery-ext.html (next: http://localhost:55369/tests/dromaeo/cssquery-jquery.html) 10:14:36 INFO - PROCESS | 5075 | RSS: Main: 238379008 10:14:36 INFO - PROCESS | 5075 | 10:17:38 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:55369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55369/tests/dromaeo/cssquery-mootools.html) 10:17:39 INFO - PROCESS | 5075 | RSS: Main: 219000832 10:17:39 INFO - PROCESS | 5075 | 10:20:41 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:55369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55369/tests/dromaeo/cssquery-prototype.html) 10:20:42 INFO - PROCESS | 5075 | RSS: Main: 188526592 10:20:42 INFO - PROCESS | 5075 | 10:23:45 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:55369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55369/tests/dromaeo/cssquery-yui.html) 10:23:45 INFO - PROCESS | 5075 | RSS: Main: 188600320 10:23:45 INFO - PROCESS | 5075 | 10:26:48 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:55369/tests/dromaeo/cssquery-yui.html (next: http://localhost:55369/tests/dromaeo/cssquery-dojo.html) 10:26:49 INFO - PROCESS | 5075 | RSS: Main: 266383360 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | __start_tp_report 10:26:49 INFO - PROCESS | 5075 | _x_x_mozilla_page_load 10:26:49 INFO - PROCESS | 5075 | _x_x_mozilla_page_load_details 10:26:49 INFO - PROCESS | 5075 | |i|pagename|runs| 10:26:49 INFO - PROCESS | 5075 | |0;dojo.html;2644.3785710358065;2654.230273220766;2687.234138270592;2697.298702337393;2699.3656490724675;4638.698484598499;4698.90602187956;4753.239481682931;4799.232122860343;4810.278458231267;4763.0950119477275;4774.73738944358;4775.11660342836;4792.976035119828;4859.246816743402;4343.86968390948;4362.585554372329;4445.711028783135;4501.144782491333;4546.954530454686;4451.755153466542;4488.730676159425;4503.144402563519;4512.029913568582;4520.29935360018;4303.440552728125;4336.089421221515;4340.934885976713;4344.152890186415;4356.825726970949;4382.2331092059085;4389.275769498029;4393.6704747144095;4490.259107247301;4491.101779644085;4412.4043254160915;4432.091421258634;4433.512313645497;4472.993576445274;4477.283634618446;4628.467726211495;4822.975885120587;4882.170031094723;4886.706797592155;4891.853244402673;5120.923186152173;5164.741762911839;5178.6116041297055;5204.947950520522;5263.26314315996;5221.634485586011;5254.52709256165;5261.263423120766;5272.367315922075;5289.074411977888;4688.203005489075;4734.786934587952;4898.093852637237;4903.362562866804;4909.214525675875;5215.452377500308;5268.683878967197;5302.3637163540625;5306.204069389545;5321.3348331458565;5035;5092.898142037138;5093.567046800989;5095.210242412432;5098.872528186825;4995.125852975715;5116.258142569307;5123.2827404163445;5182.067227898939;5186.6369354144845;5085.821996230115;5149.073166830007;5152.6650767699975;5185.377754669464;5201.583873290203;5110.310108135429;5111.897762044739;5120.846374608767;5121.3854337479;5176.922346164811;4173.061061261253;4219.51475580306;4287.206866729665;4296.312589985588;4333.826646934087;3725.0501122213664;3755.9061023474087;3765.566959799658;3773.6981041516615;3840.231953609289;4450.287953927356;4451.465824101128;4453.4433195850515;4489.124620698998;4506.526814684476;4996.525330093636;5158.948410515922;5164.8967020659375;5165.328507294028;5207.973960130175;4354.346847972829;4378.387025816388;4431.091626216617;4435.512093669694;4492.618127459203;4597.839075632337;4625.259958406638;4627.421572303462;4632.559906808848;4671.159191345522;4837.637177211794;4864.464908860023;4874.8781280467565;4882.121218180761;4927.60579153674;4990;5100.030994111107;5151.639385242997;5158.484151584811;5221.347331583552;4882.92675609859;4885.096257192431;4896.338994235733;4899.216125419915;4929.457759646364;5098.855878666124;5101.260317254051;5104.310918026167;5108.56577190943;5116.181410974226;4992.176290911959;5065.417476990193;5077.39071311445;5111.565516930954;5144.0997825381155;4985.152524070989;4988;4992.750362481789;4999.400071991385;5057.064443078042;4983.953369792239;4999.875003124951;5004.599632029356;5017.774200161075;5036.899262014813;4755.5719985201495;4844.878878028077;4879.194932836042;4882.755862206946;4947.406311242674;5030.170021946338;5045.293658887832;5047.066292735855;5053.595712343077;5095.26118712792;4934.9753251233515;4952.554270115563;4953.603711703127;4953.7523123844385;4997.300377947163 10:26:49 INFO - PROCESS | 5075 | |1;ext.html;558.5252535344957;571.991420128698;575.8646718021267;577.197695203667;582.2459914410838;28069.298267543323;30706.692933070663;30843.22891927703;39655.80172099135;41138.7943060285;41542;42054.57945420545;42086;42177;42234.15531689372;7706.306432421081;7857.607119644023;7862.803429914241;7863.174366691501;7864.370850331959;7438.442116841232;7619.352355049828;7632.694692212305;7792.883106753403;7863.410244231677;10003.59985600575;10261.692149235534;10279.794404111914;10638.893611063868;10664.520096595672;10143.847842282372;10189.337693050002;10200.081992620626;10208.336458130272;10215.795684086352;9953.651622193189;9998.600055997751;10021.148202402732;10023.298369114165;10023.899761002369;39974.80012599948;40465;40480.59519404827;40519;40569.797151014354;3012.487877060905;3086.35186610812;3474.617792042873;3487.808170550619;3548.077499850032;29709.70290297091;29939.401211975855;30034.69965300341;30416.8479157605;31494.842525787226;3254.9186270343193;3270.8364581770816;3308.586426696663;3359.8488068036995;3456.1359660084977;263594;264499;264519.6774016137;264964;265093;32063;50229.24656130161;50373.24440133401;50437;50459.74770126126;32561.348773024405;34905.12737181591;35024;35061.29877402489;35073.12317192039;12922.741545169043;13042.54351097726;13062.738745225042;13063.34683265833;13065.346732663329;10455.424951627734;10499.842502362471;10508.369497830156;10510.054095131474;10510.159187265;6593.142891424084;7823.217678232131;8053.758387248392;8091.271785539329;8111.716089936824;3105.627324721048;3130.906072817819;3138.356636889432;3163.4938409854312;3167.889123880653;838.7777239031661;863.447393668053;892.3396686451979;948.0188005414363;966.792139689956;25434;25989.870050649624;26011.479770404487;26496.60255096175;26720.465590688076;844.5861527851308;873.3275377958936;943.3490891284991;972.5137431284357;977.5796407544682;14187.361568729226;14429.85570144306;14511.927440362731;14813.33339999681;15112.546623601309;430787;433651;433966;434203;434756;33110.50334244988;33257.3348533028;33257.66742332594;33363.499547506806;33366.16584585405;1147.300146910384;1156.4911438966828;1184.0705046538426;1184.7867383870641;1185.6739396665987;27036;28230.576541352308;28438.573421398283;28714.282142945758;31426.565976871916;49962;50593.24110138424;50807.49192508028;50863.74568127136;50921.74539127281;361787;367946;368509;369783;371251;32872.34255314928;34507.341508896985;39888.40167397433;40359.39460908147;40623.39064914088;39176.80411597924;42988;43229.56770432255;43660.345094822966;43668.344974824766;36886.26227475489;37213.44179837359;37654.435183472815;37660.62339376681;38012.80993595014;36059.27881442409;36583.26833463369;36699;36975.630243698295;37456.81271593625;36001.27997439984;36479;36798.44802327914;36845.44731828971;37486.812565937;31691.52462713107;34029.731816031075;34060.659393405746;34452.310953781285;34697.306053879285;25541.3614659635;25929;26094.76219685471;26111;26208.344791379604 10:26:49 INFO - PROCESS | 5075 | |2;jquery.html;342.13462253625886;358.56792564959244;365.4408754605454;373.2739821048062;389.72719096632363;12706.809397859028;16563.50309490716;16863.662726745457;17996.190171442282;18188.545286367847;17118.572035699082;17136.05751683657;17246.223919923603;17337.393191238276;17383.82616173838;5135.794568217267;5362.383325917511;5559.082751346023;5594.300712410949;5690.231818704484;3479.7042251408534;5320.6275560710765;5529.640573362719;5570.025245582027;5578.3584887737825;5586.162075688659;5632.042552766019;5654.886902261952;5655.1517272409055;5656.632318899258;5440.238366628675;5564.33228012637;5593.804216852391;5659.377468478485;5661.377248502682;5447.210154527611;5449.809256675997;5451.236826844245;5452.563794896399;5456.945430545723;11815.704607384798;16266.593335166597;20127.698084528743;20206.09072591737;20297.49256268605;1865.291189348039;1877.6901811201135;1916.3867562380044;2171.413718296067;2191.2111639809655;8894.377393582452;9069.591868365873;9116.954415227881;9404.482753448558;9582.712518624383;1669.6076422040933;1737.4961261234353;1738.8782785205042;1757.5254681236122;1772.452472143983;67004.6649766753;70653;72259;72875.63562182155;73432.26567734308;10150.187984961185;10312.381257124596;10437;10443.216758743125;10592.205584581186;14050.718985620231;14069;14076;14091.929540352232;14102.71794564103;7203.675834587351;7217.170025447036;7358.5584864907205;7391;7432.442566807511;6788.287229840895;6795.626240556718;6858.862822743617;7046.084009078787;7050.717971281194;4338.436003319548;4405.977970110129;4415.757133357632;4427.468703755506;4526.592606665416;1798.1009495252374;1821.6447792680565;1837.6875931091479;1844.3913508542148;1844.4546525794317;820.4584973917187;869.8695195720693;870.5473153959905;904.9592968086621;910.5128756115447;16514.339426422808;17196.828031719524;17440;17805.46583602494;18108.456746297634;813.5403497024281;831.5135645647364;838.7861095420628;849.3332733804058;872.3021582733787;9301.116393942564;9864.704058878246;9960.850587241197;9967.601295948225;9972.750681233027;396507;403798;404132;408123;408321;49598.50401496011;58467.41532584705;79628.20371796323;80198.5990070046;83377;905.0361365146098;911.6809116809063;913.2420091324185;914.346242436661;918.5453200665713;15211;15283.159426231665;15441.768373474182;15681.294341754421;15759.921200393925;37710.24579508449;37922.62077379191;38263.42604860985;38326.61673383231;38797;49558.752206238736;51075.74462127814;52627;52904.47095528995;54088;7368.115826100902;7780.3386712130105;7868.960655196687;7979.241972012649;8041.67833286662;10339.431331276852;12135.271883687006;12319.322437266037;12654.291670624349;12661.240325580495;9434.198093162158;9800.166985806287;10326.638567650096;10336.844947325646;10469.671702715605;10494.326786999844;10502.842457362993;10705.036546710833;11023;11095.389753563308;9954.900450995687;10105.24210684187;10169.491525423551;10221.233407494616;10548.525316360628;7611;7889.447738658238;7938.920610793818;7941.642626081955;8082.393820463371;8073.555954422563;9523.523823808644;10232.744181395525;10370.325928814604;10371.481425928523 10:26:49 INFO - PROCESS | 5075 | |3;mootools.html;1191.1007189571872;1353.0461024977392;1389.3886689856463;1427.7430062588737;1616.5554472520064;6344.80965571033;7199.892001619974;7389.482736208468;7470.850582988337;7633.541987480741;7360.337569618733;7403.703851845919;7404.851902961937;7424.703011879518;7428.220036896116;2188.518525924298;2214;2215.180383258197;2216.279709094543;2217.9667304990357;2122.246602456129;2133.605283022638;2197.8571392859494;2198.9010494527706;2205.547862688153;2120.204923153817;2125.2242931330106;2128.30829980257;2128.723265975421;2197.604431202383;2129.116416687073;2142.5500644864596;2147.2162660628915;2154.9461263468384;2155.3426205007468;2003.8797672139717;2101.5166511702396;2102.180149741602;2104.200403846544;2104.5580428110115;7327.7435289765135;7504.061992250969;7538.660760265801;7562.735304264324;7563.848723025564;4241.257779888538;4436;4438.334249862546;4443.066955939256;4448.555144485558;2767.4326763013737;2906.7819913506573;2949.8230106193696;2951.5277555591;2954.556816477524;880.6565439478609;888.626776753765;896.4307664633005;929.3076657889848;934.9158575728217;10096.646617368431;10151.64469243573;10158.949205254;10215.89784102157;10242.53908574116;3777.131259810204;3921.7254792164276;4004.819783109767;4057.594240575978;4060.7360521566;8148.470349427268;8150.38872084596;8150.959245203855;8151.714689985822;8157.469764465291;4379.0366119453665;4381.518033016429;4386.846460373871;4388.71473354231;4392.626626736699;3512.2624248908014;3883.805809709503;4027.4764280643913;4039.8586049488126;4052.4731784867777;3271.2312606537444;3325;3388.6272510023878;3407.2844702612233;3434.4504879219203;1005.1707341443339;1094.2504384496644;1102.3330884814573;1106.286445242814;1111.727626731456;790.1150711203373;811.3752410643772;826.3430572694722;826.4504104770381;831.8294749576322;4865.513448655177;4987.675801072919;4997.90004199914;5029.321041659329;5123.410807757155;414.29569731456644;427.23524890445753;431.8985038515946;431.9654427645781;433.59675501783016;3505.1762835733584;3600.8739694111105;3602.243528858969;3641.253543023674;3661.3409586274724;8917.955410223038;9239.891213054341;9264.212541934012;9359.812803743887;9381.29640276982;9103.135202155785;9300.72097837066;9311.208547273422;9312.580933857993;9334.579943902541;6922.619255940972;7021.684024218923;7022.4382049436945;7028.824279393056;7033.7538186164265;4950.158473059517;4959.652824302264;5031.094403007493;5146.176611742103;5238.449962754008;8580.613872375634;8628.094050124646;8696.608652610774;8745.387822852339;8754.69358572447;8062.7581172564915;8428.45215061019;8436.029856566329;8782.516961567175;8816.603252853765;5875.676837773964;6658.3674550917585;6800.863982720417;6803.693833777591;6804.183497980274;6525.738970441319;6585.242697089704;6585.374389432996;6592.406683398517;6941.236463989058;6391.58454700443;6484.610923344614;6555.4427873631275;6597.109390232257;6621.9337806621315;6525.608463492205;6533.379328963741;6538.8365290868105;6561.3438656134;6568.573042752206;5978.133170690313;6076.51387888959;6081.604695694766;6082.300535438481;6084.39156084388;4480.574345437179;4489.753063581404;4503.639708823352;4577.862664120082;4673.3457315976475;4567.040921406542;4594.770261486846;4596.862094137181;4631.374764406762;4778.354922085613 10:26:49 INFO - PROCESS | 5075 | |4;prototype.html;285.2497930442935;286.1729601451806;286.75052704147396;287.1257022366893;292.81698938163646;4828.855134345971;4891.8043278268915;4891.853244402665;4907.681000734954;4910.361652985116;4805.855824325267;4858.295547145671;4867.123917694814;4876.829310974116;4879.682820616657;3612.8554857805657;3731.347014272505;3738.5887552369218;3779.9433008504757;3817.675497582695;3795.2978698940647;3815.702661095227;3825.617438256166;3837.4052021936645;3844.5770965193806;3759.8684046058393;3777.3956167013284;3781.2626537825136;3783.6405541473655;3806.5067380865576;3588.067102553342;3643.362411577963;3773.1699026214187;3774.2074164425503;3798.753081049737;3326.434506133963;3331.6168640606397;3334.7665663403573;3338.3657105150187;3355.3457075870215;4700.388949436551;4700.623950083985;4705.435347758256;4709.646776491777;4711.929321060187;4146.067134894654;4306.590873866978;4323.11376167888;4336.761478118702;4343.239933011742;4984.700917944935;5007.699538027694;5010.569873611295;5013.849584512471;5035.219540971156;3641.18073433478;3646.197836475971;3651.1784848408897;3654.835532401048;3678.3746763050076;5128.538431541179;5312.574994000471;5329.934013197376;5341.225522299244;5344.759485823147;3681.668649821529;3703.0742314421395;3707.610700876423;3712.461693054492;3712.4988126603103;3743.831527581265;3751.174741556853;3752.2870654575545;3754.2866855297407;3761.8495260189834;4269.420314483661;4277.807498662568;4279.636230920407;4294.334378171388;4308.547602501755;4851.454641234896;5035.823746168867;5060.139776238048;5072.721000345016;5074.3657042869645;1288.4524077267124;1296.500847173845;1312.8512551517422;1316.5128902306208;1319.5579480873823;826.6941231744294;849.2993280543576;869.8782170496136;870.4429165334191;876.82901834143;4384.145091707086;4454.933176002362;4488.798004089824;4501.954980450219;4508.120916421332;5152.819651312186;5174.353205849269;5186.351706036746;5189.247559103909;5204.34945631796;4520.412346395014;4533.886652833706;4538.773061346919;4541.9545804542195;4556.658250631216;2640.9471810564064;2757.7038791767836;2768.792340574465;2793.6368272124496;2798.6781520125446;4908.594788553654;4929.285253638274;4932.26016097581;4961.131801934647;4969.4782047884455;5114.616403769732;5370.838874833761;5397.595180361489;5402.432744561765;5414.269073675004;4934.506549345037;4949.430815456197;4971.801127954841;4989.3264409305;5014.52362025607;5246.3704355477585;5249.632525723316;5262.500062494057;5276.788928442819;5277.393099793419;4997.725125118153;5110.565601923878;5151.974240128776;5155.123628983007;5174.586033117266;4894.479343138358;4913.336699545515;4913.385826771653;4933.925991110208;4954.299906550867;3750.118722100359;3761.5110035695184;3770.510648293963;3777.905552361213;3780.2061567071223;5123.6157288202785;5194.766235519335;5224.634275600672;5236.581073514034;5242.501962313574;5006.724630145377;5034.28834196375;5043.394792624908;5062.594992400525;5068.366454193226;5043.899122017612;5061.13960626687;5073.492650734897;5083.364579427572;5089.694618322913;4773.809047638195;4928.334674818853;4940.975295123501;4967.155583550732;4998.925016124688;4907.33750943618;5053.620978426559;5084.466131056186;5088.084144853962;5103.132467480463;4832.299316599003;4876;4905.1416002200185;4917.926231106465;4948 10:26:49 INFO - PROCESS | 5075 | |5;yui.html;575.3958343739074;625.262190615074;685.5886468119126;702.231056992593;723.7901008707472;12257;12562.685932851684;12918.354082295882;12978.351082445864;13020.739585208303;12883.484660613587;12973.351332433387;13040.673983150426;13057.804132938014;13067.607971760839;620.7330847735471;637.3912913167914;638.9297177310492;731.6597782031367;746.4998451037791;638.7285403703431;735.6836560279078;763.0461922596754;765.9195784442637;769.9653515591784;793.5437123653893;794.7417089445925;795.3756301303478;796.3509739562268;796.8446153000167;790.5335851847437;794.1066300412036;794.233564610154;794.2772077409587;794.7575989323254;478.52386875059193;570.0394834703537;588.7085892483205;589.4989259129749;591.6391001489088;13077.411516481781;13106.14810037354;13107.410166542528;13112.672183195402;13123.934380328037;11594.942025289904;11703.473343699468;11742.58900938463;12038.939805300917;12258.75482490354;9811.166050885684;9946.701598952042;10079.748006299827;11476.598319058876;11671.824922626167;4046.271671099201;4101.507819061701;4124.1133156371525;4135.1316223592785;4148.357004664282;58990.70504647492;59737.068190445505;60263;60372.698136509476;61904;9503.28725345602;9843.212542996544;10048.69853904384;10160.288779785493;10220.751434684358;17470.126493675267;17540.5614859627;17587.56031099233;17611;17636.118194090242;6433.549651524442;6614.173228346457;6719;6747.595144291358;6815.965920170367;3562.412201986695;3576.6065732769375;3591.856325746941;3611.963880361215;3629.6914762245506;2686.8925242990063;2772.223777342347;2776.1810265971585;2777.180731684158;2777.9722202778116;483.5164835164835;493.0853267189384;494.84659755475917;495.34119620904113;502.7787773379701;492.21246006390203;495.60104116186096;503.6575128912375;526.210683974039;550.3450893436798;6508.9023664645065;6751.311563703031;6797.52417330792;6931;7110.5022648414115;475.6218806049199;478.8228355508484;488.6066716293347;495.15081634996153;533.2561077297149;3341.4987751836934;3358.378699940519;3394.6435624259593;3417.1457135716073;3557.7153827693724;90378.54810726036;94122;96681.51659241659;97040.51479742557;98165.50917245368;66112.6694366525;68223;82370;82854.17145828585;84976;59856.401435985084;69170.9624355635;70782.2921770786;72288.63855680688;72725;7871.724489642835;8257.38069644767;8325.125861784425;8460.873086903579;8499.627866551318;43417;43544.12911741811;43881.56118438902;44095.11809763851;44272.55727442684;39631;47749.76125119352;62103;62935;64904;10932.398718070583;11224.55101795919;11563.88436115628;11722.765544688888;11866.406679666155;12497.25016499013;12787.232766034067;12906.483740650645;13148.671283217613;13152;10772.622958196425;10899.78200435971;11158.553657853596;11556.364399957747;11603.303801771921;10652.360858348524;11258.21192516516;12293.508259669514;12321.876781232073;12327.630171094881;11449.59926402572;11513.597024104116;12678.366081696062;12702.047346448868;12734.745305094031;10006.29955903109;10135.7466063349;10255.7436064099;10371.533281002525;10371.844422333521;9402.712378009812;9545.379550329206;10121.431435544278;10195.184385249015;10198.272136082875 10:26:49 INFO - PROCESS | 5075 | __end_tp_report 10:26:49 INFO - PROCESS | 5075 | __start_cc_report 10:26:49 INFO - PROCESS | 5075 | _x_x_mozilla_cycle_collect,1001 10:26:49 INFO - PROCESS | 5075 | __end_cc_report 10:26:49 INFO - PROCESS | 5075 | __startTimestamp1469986009098__endTimestamp 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | ------- Summary: start ------- 10:26:49 INFO - PROCESS | 5075 | Number of tests: 6 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | [#0] dojo.html Cycles:165 Average:4754.11 Median:4896.34 stddev:507.45 (10.4%) stddev-sans-first:481.26 10:26:49 INFO - PROCESS | 5075 | Values: 2644.4 2654.2 2687.2 2697.3 2699.4 4638.7 4698.9 4753.2 4799.2 4810.3 4763.1 4774.7 4775.1 4793.0 4859.2 4343.9 4362.6 4445.7 4501.1 4547.0 4451.8 4488.7 4503.1 4512.0 4520.3 4303.4 4336.1 4340.9 4344.2 4356.8 4382.2 4389.3 4393.7 4490.3 4491.1 4412.4 4432.1 4433.5 4473.0 4477.3 4628.5 4823.0 4882.2 4886.7 4891.9 5120.9 5164.7 5178.6 5204.9 5263.3 5221.6 5254.5 5261.3 5272.4 5289.1 4688.2 4734.8 4898.1 4903.4 4909.2 5215.5 5268.7 5302.4 5306.2 5321.3 5035.0 5092.9 5093.6 5095.2 5098.9 4995.1 5116.3 5123.3 5182.1 5186.6 5085.8 5149.1 5152.7 5185.4 5201.6 5110.3 5111.9 5120.8 5121.4 5176.9 4173.1 4219.5 4287.2 4296.3 4333.8 3725.1 3755.9 3765.6 3773.7 3840.2 4450.3 4451.5 4453.4 4489.1 4506.5 4996.5 5158.9 5164.9 5165.3 5208.0 4354.3 4378.4 4431.1 4435.5 4492.6 4597.8 4625.3 4627.4 4632.6 4671.2 4837.6 4864.5 4874.9 4882.1 4927.6 4990.0 5100.0 5151.6 5158.5 5221.3 4882.9 4885.1 4896.3 4899.2 4929.5 5098.9 5101.3 5104.3 5108.6 5116.2 4992.2 5065.4 5077.4 5111.6 5144.1 4985.2 4988.0 4992.8 4999.4 5057.1 4984.0 4999.9 5004.6 5017.8 5036.9 4755.6 4844.9 4879.2 4882.8 4947.4 5030.2 5045.3 5047.1 5053.6 5095.3 4935.0 4952.6 4953.6 4953.8 4997.3 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | [#1] ext.html Cycles:180 Average:49692.89 Median:35042.65 stddev:95807.78 (273.4%) stddev-sans-first:96005.52 10:26:49 INFO - PROCESS | 5075 | Values: 558.5 572.0 575.9 577.2 582.2 28069.3 30706.7 30843.2 39655.8 41138.8 41542.0 42054.6 42086.0 42177.0 42234.2 7706.3 7857.6 7862.8 7863.2 7864.4 7438.4 7619.4 7632.7 7792.9 7863.4 10003.6 10261.7 10279.8 10638.9 10664.5 10143.8 10189.3 10200.1 10208.3 10215.8 9953.7 9998.6 10021.1 10023.3 10023.9 39974.8 40465.0 40480.6 40519.0 40569.8 3012.5 3086.4 3474.6 3487.8 3548.1 29709.7 29939.4 30034.7 30416.8 31494.8 3254.9 3270.8 3308.6 3359.8 3456.1 263594.0 264499.0 264519.7 264964.0 265093.0 32063.0 50229.2 50373.2 50437.0 50459.7 32561.3 34905.1 35024.0 35061.3 35073.1 12922.7 13042.5 13062.7 13063.3 13065.3 10455.4 10499.8 10508.4 10510.1 10510.2 6593.1 7823.2 8053.8 8091.3 8111.7 3105.6 3130.9 3138.4 3163.5 3167.9 838.8 863.4 892.3 948.0 966.8 25434.0 25989.9 26011.5 26496.6 26720.5 844.6 873.3 943.3 972.5 977.6 14187.4 14429.9 14511.9 14813.3 15112.5 430787.0 433651.0 433966.0 434203.0 434756.0 33110.5 33257.3 33257.7 33363.5 33366.2 1147.3 1156.5 1184.1 1184.8 1185.7 27036.0 28230.6 28438.6 28714.3 31426.6 49962.0 50593.2 50807.5 50863.7 50921.7 361787.0 367946.0 368509.0 369783.0 371251.0 32872.3 34507.3 39888.4 40359.4 40623.4 39176.8 42988.0 43229.6 43660.3 43668.3 36886.3 37213.4 37654.4 37660.6 38012.8 36059.3 36583.3 36699.0 36975.6 37456.8 36001.3 36479.0 36798.4 36845.4 37486.8 31691.5 34029.7 34060.7 34452.3 34697.3 25541.4 25929.0 26094.8 26111.0 26208.3 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | [#2] jquery.html Cycles:180 Average:24630.19 Median:27042.67 stddev:66603.09 (246.3%) stddev-sans-first:66764.96 10:26:49 INFO - PROCESS | 5075 | Values: 342.1 358.6 365.4 373.3 389.7 12706.8 16563.5 16863.7 17996.2 18188.5 17118.6 17136.1 17246.2 17337.4 17383.8 5135.8 5362.4 5559.1 5594.3 5690.2 3479.7 5320.6 5529.6 5570.0 5578.4 5586.2 5632.0 5654.9 5655.2 5656.6 5440.2 5564.3 5593.8 5659.4 5661.4 5447.2 5449.8 5451.2 5452.6 5456.9 11815.7 16266.6 20127.7 20206.1 20297.5 1865.3 1877.7 1916.4 2171.4 2191.2 8894.4 9069.6 9117.0 9404.5 9582.7 1669.6 1737.5 1738.9 1757.5 1772.5 67004.7 70653.0 72259.0 72875.6 73432.3 10150.2 10312.4 10437.0 10443.2 10592.2 14050.7 14069.0 14076.0 14091.9 14102.7 7203.7 7217.2 7358.6 7391.0 7432.4 6788.3 6795.6 6858.9 7046.1 7050.7 4338.4 4406.0 4415.8 4427.5 4526.6 1798.1 1821.6 1837.7 1844.4 1844.5 820.5 869.9 870.5 905.0 910.5 16514.3 17196.8 17440.0 17805.5 18108.5 813.5 831.5 838.8 849.3 872.3 9301.1 9864.7 9960.9 9967.6 9972.8 396507.0 403798.0 404132.0 408123.0 408321.0 49598.5 58467.4 79628.2 80198.6 83377.0 905.0 911.7 913.2 914.3 918.5 15211.0 15283.2 15441.8 15681.3 15759.9 37710.2 37922.6 38263.4 38326.6 38797.0 49558.8 51075.7 52627.0 52904.5 54088.0 7368.1 7780.3 7869.0 7979.2 8041.7 10339.4 12135.3 12319.3 12654.3 12661.2 9434.2 9800.2 10326.6 10336.8 10469.7 10494.3 10502.8 10705.0 11023.0 11095.4 9954.9 10105.2 10169.5 10221.2 10548.5 7611.0 7889.4 7938.9 7941.6 8082.4 8073.6 9523.5 10232.7 10370.3 10371.5 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | [#3] mootools.html Cycles:180 Average:4907.20 Median:4907.84 stddev:2733.50 (55.7%) stddev-sans-first:2726.90 10:26:49 INFO - PROCESS | 5075 | Values: 1191.1 1353.0 1389.4 1427.7 1616.6 6344.8 7199.9 7389.5 7470.9 7633.5 7360.3 7403.7 7404.9 7424.7 7428.2 2188.5 2214.0 2215.2 2216.3 2218.0 2122.2 2133.6 2197.9 2198.9 2205.5 2120.2 2125.2 2128.3 2128.7 2197.6 2129.1 2142.6 2147.2 2154.9 2155.3 2003.9 2101.5 2102.2 2104.2 2104.6 7327.7 7504.1 7538.7 7562.7 7563.8 4241.3 4436.0 4438.3 4443.1 4448.6 2767.4 2906.8 2949.8 2951.5 2954.6 880.7 888.6 896.4 929.3 934.9 10096.6 10151.6 10158.9 10215.9 10242.5 3777.1 3921.7 4004.8 4057.6 4060.7 8148.5 8150.4 8151.0 8151.7 8157.5 4379.0 4381.5 4386.8 4388.7 4392.6 3512.3 3883.8 4027.5 4039.9 4052.5 3271.2 3325.0 3388.6 3407.3 3434.5 1005.2 1094.3 1102.3 1106.3 1111.7 790.1 811.4 826.3 826.5 831.8 4865.5 4987.7 4997.9 5029.3 5123.4 414.3 427.2 431.9 432.0 433.6 3505.2 3600.9 3602.2 3641.3 3661.3 8918.0 9239.9 9264.2 9359.8 9381.3 9103.1 9300.7 9311.2 9312.6 9334.6 6922.6 7021.7 7022.4 7028.8 7033.8 4950.2 4959.7 5031.1 5146.2 5238.4 8580.6 8628.1 8696.6 8745.4 8754.7 8062.8 8428.5 8436.0 8782.5 8816.6 5875.7 6658.4 6800.9 6803.7 6804.2 6525.7 6585.2 6585.4 6592.4 6941.2 6391.6 6484.6 6555.4 6597.1 6621.9 6525.6 6533.4 6538.8 6561.3 6568.6 5978.1 6076.5 6081.6 6082.3 6084.4 4480.6 4489.8 4503.6 4577.9 4673.3 4567.0 4594.8 4596.9 4631.4 4778.4 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | [#4] prototype.html Cycles:180 Average:4215.27 Median:4862.71 stddev:1221.61 (25.1%) stddev-sans-first:1188.89 10:26:49 INFO - PROCESS | 5075 | Values: 285.2 286.2 286.8 287.1 292.8 4828.9 4891.8 4891.9 4907.7 4910.4 4805.9 4858.3 4867.1 4876.8 4879.7 3612.9 3731.3 3738.6 3779.9 3817.7 3795.3 3815.7 3825.6 3837.4 3844.6 3759.9 3777.4 3781.3 3783.6 3806.5 3588.1 3643.4 3773.2 3774.2 3798.8 3326.4 3331.6 3334.8 3338.4 3355.3 4700.4 4700.6 4705.4 4709.6 4711.9 4146.1 4306.6 4323.1 4336.8 4343.2 4984.7 5007.7 5010.6 5013.8 5035.2 3641.2 3646.2 3651.2 3654.8 3678.4 5128.5 5312.6 5329.9 5341.2 5344.8 3681.7 3703.1 3707.6 3712.5 3712.5 3743.8 3751.2 3752.3 3754.3 3761.8 4269.4 4277.8 4279.6 4294.3 4308.5 4851.5 5035.8 5060.1 5072.7 5074.4 1288.5 1296.5 1312.9 1316.5 1319.6 826.7 849.3 869.9 870.4 876.8 4384.1 4454.9 4488.8 4502.0 4508.1 5152.8 5174.4 5186.4 5189.2 5204.3 4520.4 4533.9 4538.8 4542.0 4556.7 2640.9 2757.7 2768.8 2793.6 2798.7 4908.6 4929.3 4932.3 4961.1 4969.5 5114.6 5370.8 5397.6 5402.4 5414.3 4934.5 4949.4 4971.8 4989.3 5014.5 5246.4 5249.6 5262.5 5276.8 5277.4 4997.7 5110.6 5152.0 5155.1 5174.6 4894.5 4913.3 4913.4 4933.9 4954.3 3750.1 3761.5 3770.5 3777.9 3780.2 5123.6 5194.8 5224.6 5236.6 5242.5 5006.7 5034.3 5043.4 5062.6 5068.4 5043.9 5061.1 5073.5 5083.4 5089.7 4773.8 4928.3 4941.0 4967.2 4998.9 4907.3 5053.6 5084.5 5088.1 5103.1 4832.3 4876.0 4905.1 4917.9 4948.0 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - PROCESS | 5075 | [#5] yui.html Cycles:180 Average:16960.97 Median:24112.69 stddev:23934.87 (99.3%) stddev-sans-first:23970.39 10:26:49 INFO - PROCESS | 5075 | Values: 575.4 625.3 685.6 702.2 723.8 12257.0 12562.7 12918.4 12978.4 13020.7 12883.5 12973.4 13040.7 13057.8 13067.6 620.7 637.4 638.9 731.7 746.5 638.7 735.7 763.0 765.9 770.0 793.5 794.7 795.4 796.4 796.8 790.5 794.1 794.2 794.3 794.8 478.5 570.0 588.7 589.5 591.6 13077.4 13106.1 13107.4 13112.7 13123.9 11594.9 11703.5 11742.6 12038.9 12258.8 9811.2 9946.7 10079.7 11476.6 11671.8 4046.3 4101.5 4124.1 4135.1 4148.4 58990.7 59737.1 60263.0 60372.7 61904.0 9503.3 9843.2 10048.7 10160.3 10220.8 17470.1 17540.6 17587.6 17611.0 17636.1 6433.5 6614.2 6719.0 6747.6 6816.0 3562.4 3576.6 3591.9 3612.0 3629.7 2686.9 2772.2 2776.2 2777.2 2778.0 483.5 493.1 494.8 495.3 502.8 492.2 495.6 503.7 526.2 550.3 6508.9 6751.3 6797.5 6931.0 7110.5 475.6 478.8 488.6 495.2 533.3 3341.5 3358.4 3394.6 3417.1 3557.7 90378.5 94122.0 96681.5 97040.5 98165.5 66112.7 68223.0 82370.0 82854.2 84976.0 59856.4 69171.0 70782.3 72288.6 72725.0 7871.7 8257.4 8325.1 8460.9 8499.6 43417.0 43544.1 43881.6 44095.1 44272.6 39631.0 47749.8 62103.0 62935.0 64904.0 10932.4 11224.6 11563.9 11722.8 11866.4 12497.3 12787.2 12906.5 13148.7 13152.0 10772.6 10899.8 11158.6 11556.4 11603.3 10652.4 11258.2 12293.5 12321.9 12327.6 11449.6 11513.6 12678.4 12702.0 12734.7 10006.3 10135.7 10255.7 10371.5 10371.8 9402.7 9545.4 10121.4 10195.2 10198.3 10:26:49 INFO - PROCESS | 5075 | -------- Summary: end -------- 10:26:49 INFO - PROCESS | 5075 | 10:26:49 INFO - TEST-INFO | 5075: exit 0 10:26:49 INFO - TEST-OK | dromaeo_css | took 1120112ms 10:26:49 INFO - TEST-START | kraken 10:26:49 INFO - operating with platform_type : linux_ 10:26:49 INFO - Initialising browser for kraken test... 10:26:49 INFO - TEST-INFO | started process 5261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnbpeX/profile http://localhost:55369/getInfo.html) 10:26:54 INFO - PROCESS | 5261 | __metrics Screen width/height:1600/1200 10:26:54 INFO - PROCESS | 5261 | colorDepth:24 10:26:54 INFO - PROCESS | 5261 | Browser inner width/height: 1024/697 10:26:54 INFO - PROCESS | 5261 | __metrics 10:26:55 INFO - PROCESS | 5261 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:26:55 INFO - PROCESS | 5261 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:56 INFO - TEST-INFO | 5261: exit 0 10:26:56 INFO - Browser initialized. 10:26:56 INFO - Running cycle 1/1 for kraken test... 10:26:56 INFO - TEST-INFO | started process 5341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnbpeX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:07 INFO - PROCESS | 5341 | RSS: Main: 157028352 10:27:07 INFO - PROCESS | 5341 | 10:27:10 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55369/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:11 INFO - PROCESS | 5341 | RSS: Main: 213192704 10:27:11 INFO - PROCESS | 5341 | 10:27:14 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55369/tests/kraken/driver.html?testName=audio-dft) 10:27:14 INFO - PROCESS | 5341 | RSS: Main: 191844352 10:27:14 INFO - PROCESS | 5341 | 10:27:18 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55369/tests/kraken/driver.html?testName=audio-fft) 10:27:18 INFO - PROCESS | 5341 | RSS: Main: 271630336 10:27:18 INFO - PROCESS | 5341 | 10:27:20 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55369/tests/kraken/driver.html?testName=audio-oscillator) 10:27:21 INFO - PROCESS | 5341 | RSS: Main: 180862976 10:27:21 INFO - PROCESS | 5341 | 10:27:23 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:24 INFO - PROCESS | 5341 | RSS: Main: 185171968 10:27:24 INFO - PROCESS | 5341 | 10:27:27 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55369/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:28 INFO - PROCESS | 5341 | RSS: Main: 221069312 10:27:28 INFO - PROCESS | 5341 | 10:27:31 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55369/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:32 INFO - PROCESS | 5341 | RSS: Main: 220364800 10:27:32 INFO - PROCESS | 5341 | 10:27:35 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55369/tests/kraken/driver.html?testName=json-parse-financial) 10:27:35 INFO - PROCESS | 5341 | RSS: Main: 220028928 10:27:35 INFO - PROCESS | 5341 | 10:27:37 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:38 INFO - PROCESS | 5341 | RSS: Main: 184401920 10:27:38 INFO - PROCESS | 5341 | 10:27:39 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:40 INFO - PROCESS | 5341 | RSS: Main: 190267392 10:27:40 INFO - PROCESS | 5341 | 10:27:42 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:43 INFO - PROCESS | 5341 | RSS: Main: 194973696 10:27:43 INFO - PROCESS | 5341 | 10:27:46 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:46 INFO - PROCESS | 5341 | RSS: Main: 188616704 10:27:46 INFO - PROCESS | 5341 | 10:27:49 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:50 INFO - PROCESS | 5341 | RSS: Main: 192892928 10:27:50 INFO - PROCESS | 5341 | 10:27:51 INFO - PROCESS | 5341 | Cycle 1(1): loaded http://localhost:55369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55369/tests/kraken/driver.html?testName=ai-astar) 10:27:52 INFO - PROCESS | 5341 | RSS: Main: 243580928 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | __start_tp_report 10:27:52 INFO - PROCESS | 5341 | _x_x_mozilla_page_load 10:27:52 INFO - PROCESS | 5341 | _x_x_mozilla_page_load_details 10:27:52 INFO - PROCESS | 5341 | |i|pagename|runs| 10:27:52 INFO - PROCESS | 5341 | |0;ai-astar;105;114;113;113;113;113;113;114;112;114 10:27:52 INFO - PROCESS | 5341 | |1;audio-beat-detection;150;123;124;181;121;123;146;123;163;126 10:27:52 INFO - PROCESS | 5341 | |2;audio-dft;160;161;160;161;161;161;162;161;161;161 10:27:52 INFO - PROCESS | 5341 | |3;audio-fft;76;75;76;119;76;76;74;74;100;77 10:27:52 INFO - PROCESS | 5341 | |4;audio-oscillator;84;88;128;84;85;84;125;85;90;135 10:27:52 INFO - PROCESS | 5341 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 10:27:52 INFO - PROCESS | 5341 | |6;imaging-darkroom;147;148;147;146;148;148;147;147;148;146 10:27:52 INFO - PROCESS | 5341 | |7;imaging-desaturate;95;95;95;95;96;95;95;96;96;96 10:27:52 INFO - PROCESS | 5341 | |8;json-parse-financial;64;62;61;62;62;63;63;62;64;63 10:27:52 INFO - PROCESS | 5341 | |9;json-stringify-tinderbox;65;65;65;65;65;65;64;64;71;65 10:27:52 INFO - PROCESS | 5341 | |10;stanford-crypto-aes;82;84;79;79;78;78;78;84;78;80 10:27:52 INFO - PROCESS | 5341 | |11;stanford-crypto-ccm;128;126;128;131;130;132;124;124;212;134 10:27:52 INFO - PROCESS | 5341 | |12;stanford-crypto-pbkdf2;165;169;162;167;166;164;166;163;165;162 10:27:52 INFO - PROCESS | 5341 | |13;stanford-crypto-sha256-iterative;67;67;67;65;68;71;67;73;66;65 10:27:52 INFO - PROCESS | 5341 | __end_tp_report 10:27:52 INFO - PROCESS | 5341 | __start_cc_report 10:27:52 INFO - PROCESS | 5341 | _x_x_mozilla_cycle_collect,1893 10:27:52 INFO - PROCESS | 5341 | __end_cc_report 10:27:52 INFO - PROCESS | 5341 | __startTimestamp1469986072206__endTimestamp 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | ------- Summary: start ------- 10:27:52 INFO - PROCESS | 5341 | Number of tests: 14 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 10:27:52 INFO - PROCESS | 5341 | Values: 105.0 114.0 113.0 113.0 113.0 113.0 113.0 114.0 112.0 114.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:136.00 stddev:21.04 (15.5%) stddev-sans-first:21.87 10:27:52 INFO - PROCESS | 5341 | Values: 150.0 123.0 124.0 181.0 121.0 123.0 146.0 123.0 163.0 126.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 10:27:52 INFO - PROCESS | 5341 | Values: 160.0 161.0 160.0 161.0 161.0 161.0 162.0 161.0 161.0 161.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:15.05 (19.8%) stddev-sans-first:15.79 10:27:52 INFO - PROCESS | 5341 | Values: 76.0 75.0 76.0 119.0 76.0 76.0 74.0 74.0 100.0 77.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:84.50 stddev:21.30 (25.2%) stddev-sans-first:21.90 10:27:52 INFO - PROCESS | 5341 | Values: 84.0 88.0 128.0 84.0 85.0 84.0 125.0 85.0 90.0 135.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:27:52 INFO - PROCESS | 5341 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:27:52 INFO - PROCESS | 5341 | Values: 147.0 148.0 147.0 146.0 148.0 148.0 147.0 147.0 148.0 146.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:27:52 INFO - PROCESS | 5341 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 10:27:52 INFO - PROCESS | 5341 | Values: 64.0 62.0 61.0 62.0 62.0 63.0 63.0 62.0 64.0 63.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 10:27:52 INFO - PROCESS | 5341 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 71.0 65.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.45 (3.1%) stddev-sans-first:2.49 10:27:52 INFO - PROCESS | 5341 | Values: 82.0 84.0 79.0 79.0 78.0 78.0 78.0 84.0 78.0 80.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:130.50 stddev:26.59 (20.4%) stddev-sans-first:28.01 10:27:52 INFO - PROCESS | 5341 | Values: 128.0 126.0 128.0 131.0 130.0 132.0 124.0 124.0 212.0 134.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:2.23 (1.3%) stddev-sans-first:2.37 10:27:52 INFO - PROCESS | 5341 | Values: 165.0 169.0 162.0 167.0 166.0 164.0 166.0 163.0 165.0 162.0 10:27:52 INFO - PROCESS | 5341 | 10:27:52 INFO - PROCESS | 5341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.55 (3.8%) stddev-sans-first:2.69 10:27:52 INFO - PROCESS | 5341 | Values: 67.0 67.0 67.0 65.0 68.0 71.0 67.0 73.0 66.0 65.0 10:27:52 INFO - PROCESS | 5341 | -------- Summary: end -------- 10:27:52 INFO - PROCESS | 5341 | 10:27:53 INFO - TEST-INFO | 5341: exit 0 10:27:53 INFO - TEST-OK | kraken | took 63455ms 10:27:53 INFO - SUITE-END | took 1183s 10:27:53 INFO - Completed test suite (00:19:43) 10:27:53 INFO - javascript benchmark 10:27:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.3785710358065, 2654.230273220766, 2687.234138270592, 2697.298702337393, 2699.3656490724675, 4638.698484598499, 4698.90602187956, 4753.239481682931, 4799.232122860343, 4810.278458231267, 4763.0950119477275, 4774.73738944358, 4775.11660342836, 4792.976035119828, 4859.246816743402, 4343.86968390948, 4362.585554372329, 4445.711028783135, 4501.144782491333, 4546.954530454686, 4451.755153466542, 4488.730676159425, 4503.144402563519, 4512.029913568582, 4520.29935360018, 4303.440552728125, 4336.089421221515, 4340.934885976713, 4344.152890186415, 4356.825726970949, 4382.2331092059085, 4389.275769498029, 4393.6704747144095, 4490.259107247301, 4491.101779644085, 4412.4043254160915, 4432.091421258634, 4433.512313645497, 4472.993576445274, 4477.283634618446, 4628.467726211495, 4822.975885120587, 4882.170031094723, 4886.706797592155, 4891.853244402673, 5120.923186152173, 5164.741762911839, 5178.6116041297055, 5204.947950520522, 5263.26314315996, 5221.634485586011, 5254.52709256165, 5261.263423120766, 5272.367315922075, 5289.074411977888, 4688.203005489075, 4734.786934587952, 4898.093852637237, 4903.362562866804, 4909.214525675875, 5215.452377500308, 5268.683878967197, 5302.3637163540625, 5306.204069389545, 5321.3348331458565, 5035.0, 5092.898142037138, 5093.567046800989, 5095.210242412432, 5098.872528186825, 4995.125852975715, 5116.258142569307, 5123.2827404163445, 5182.067227898939, 5186.6369354144845, 5085.821996230115, 5149.073166830007, 5152.6650767699975, 5185.377754669464, 5201.583873290203, 5110.310108135429, 5111.897762044739, 5120.846374608767, 5121.3854337479, 5176.922346164811, 4173.061061261253, 4219.51475580306, 4287.206866729665, 4296.312589985588, 4333.826646934087, 3725.0501122213664, 3755.9061023474087, 3765.566959799658, 3773.6981041516615, 3840.231953609289, 4450.287953927356, 4451.465824101128, 4453.4433195850515, 4489.124620698998, 4506.526814684476, 4996.525330093636, 5158.948410515922, 5164.8967020659375, 5165.328507294028, 5207.973960130175, 4354.346847972829, 4378.387025816388, 4431.091626216617, 4435.512093669694, 4492.618127459203, 4597.839075632337, 4625.259958406638, 4627.421572303462, 4632.559906808848, 4671.159191345522, 4837.637177211794, 4864.464908860023, 4874.8781280467565, 4882.121218180761, 4927.60579153674, 4990.0, 5100.030994111107, 5151.639385242997, 5158.484151584811, 5221.347331583552, 4882.92675609859, 4885.096257192431, 4896.338994235733, 4899.216125419915, 4929.457759646364, 5098.855878666124, 5101.260317254051, 5104.310918026167, 5108.56577190943, 5116.181410974226, 4992.176290911959, 5065.417476990193, 5077.39071311445, 5111.565516930954, 5144.0997825381155, 4985.152524070989, 4988.0, 4992.750362481789, 4999.400071991385, 5057.064443078042, 4983.953369792239, 4999.875003124951, 5004.599632029356, 5017.774200161075, 5036.899262014813, 4755.5719985201495, 4844.878878028077, 4879.194932836042, 4882.755862206946, 4947.406311242674, 5030.170021946338, 5045.293658887832, 5047.066292735855, 5053.595712343077, 5095.26118712792, 4934.9753251233515, 4952.554270115563, 4953.603711703127, 4953.7523123844385, 4997.300377947163], "value": 4721.1712683257165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5252535344957, 571.991420128698, 575.8646718021267, 577.197695203667, 582.2459914410838, 28069.298267543323, 30706.692933070663, 30843.22891927703, 39655.80172099135, 41138.7943060285, 41542.0, 42054.57945420545, 42086.0, 42177.0, 42234.15531689372, 7706.306432421081, 7857.607119644023, 7862.803429914241, 7863.174366691501, 7864.370850331959, 7438.442116841232, 7619.352355049828, 7632.694692212305, 7792.883106753403, 7863.410244231677, 10003.59985600575, 10261.692149235534, 10279.794404111914, 10638.893611063868, 10664.520096595672, 10143.847842282372, 10189.337693050002, 10200.081992620626, 10208.336458130272, 10215.795684086352, 9953.651622193189, 9998.600055997751, 10021.148202402732, 10023.298369114165, 10023.899761002369, 39974.80012599948, 40465.0, 40480.59519404827, 40519.0, 40569.797151014354, 3012.487877060905, 3086.35186610812, 3474.617792042873, 3487.808170550619, 3548.077499850032, 29709.70290297091, 29939.401211975855, 30034.69965300341, 30416.8479157605, 31494.842525787226, 3254.9186270343193, 3270.8364581770816, 3308.586426696663, 3359.8488068036995, 3456.1359660084977, 263594.0, 264499.0, 264519.6774016137, 264964.0, 265093.0, 32063.0, 50229.24656130161, 50373.24440133401, 50437.0, 50459.74770126126, 32561.348773024405, 34905.12737181591, 35024.0, 35061.29877402489, 35073.12317192039, 12922.741545169043, 13042.54351097726, 13062.738745225042, 13063.34683265833, 13065.346732663329, 10455.424951627734, 10499.842502362471, 10508.369497830156, 10510.054095131474, 10510.159187265, 6593.142891424084, 7823.217678232131, 8053.758387248392, 8091.271785539329, 8111.716089936824, 3105.627324721048, 3130.906072817819, 3138.356636889432, 3163.4938409854312, 3167.889123880653, 838.7777239031661, 863.447393668053, 892.3396686451979, 948.0188005414363, 966.792139689956, 25434.0, 25989.870050649624, 26011.479770404487, 26496.60255096175, 26720.465590688076, 844.5861527851308, 873.3275377958936, 943.3490891284991, 972.5137431284357, 977.5796407544682, 14187.361568729226, 14429.85570144306, 14511.927440362731, 14813.33339999681, 15112.546623601309, 430787.0, 433651.0, 433966.0, 434203.0, 434756.0, 33110.50334244988, 33257.3348533028, 33257.66742332594, 33363.499547506806, 33366.16584585405, 1147.300146910384, 1156.4911438966828, 1184.0705046538426, 1184.7867383870641, 1185.6739396665987, 27036.0, 28230.576541352308, 28438.573421398283, 28714.282142945758, 31426.565976871916, 49962.0, 50593.24110138424, 50807.49192508028, 50863.74568127136, 50921.74539127281, 361787.0, 367946.0, 368509.0, 369783.0, 371251.0, 32872.34255314928, 34507.341508896985, 39888.40167397433, 40359.39460908147, 40623.39064914088, 39176.80411597924, 42988.0, 43229.56770432255, 43660.345094822966, 43668.344974824766, 36886.26227475489, 37213.44179837359, 37654.435183472815, 37660.62339376681, 38012.80993595014, 36059.27881442409, 36583.26833463369, 36699.0, 36975.630243698295, 37456.81271593625, 36001.27997439984, 36479.0, 36798.44802327914, 36845.44731828971, 37486.812565937, 31691.52462713107, 34029.731816031075, 34060.659393405746, 34452.310953781285, 34697.306053879285, 25541.3614659635, 25929.0, 26094.76219685471, 26111.0, 26208.344791379604], "value": 17018.85104218569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.13462253625886, 358.56792564959244, 365.4408754605454, 373.2739821048062, 389.72719096632363, 12706.809397859028, 16563.50309490716, 16863.662726745457, 17996.190171442282, 18188.545286367847, 17118.572035699082, 17136.05751683657, 17246.223919923603, 17337.393191238276, 17383.82616173838, 5135.794568217267, 5362.383325917511, 5559.082751346023, 5594.300712410949, 5690.231818704484, 3479.7042251408534, 5320.6275560710765, 5529.640573362719, 5570.025245582027, 5578.3584887737825, 5586.162075688659, 5632.042552766019, 5654.886902261952, 5655.1517272409055, 5656.632318899258, 5440.238366628675, 5564.33228012637, 5593.804216852391, 5659.377468478485, 5661.377248502682, 5447.210154527611, 5449.809256675997, 5451.236826844245, 5452.563794896399, 5456.945430545723, 11815.704607384798, 16266.593335166597, 20127.698084528743, 20206.09072591737, 20297.49256268605, 1865.291189348039, 1877.6901811201135, 1916.3867562380044, 2171.413718296067, 2191.2111639809655, 8894.377393582452, 9069.591868365873, 9116.954415227881, 9404.482753448558, 9582.712518624383, 1669.6076422040933, 1737.4961261234353, 1738.8782785205042, 1757.5254681236122, 1772.452472143983, 67004.6649766753, 70653.0, 72259.0, 72875.63562182155, 73432.26567734308, 10150.187984961185, 10312.381257124596, 10437.0, 10443.216758743125, 10592.205584581186, 14050.718985620231, 14069.0, 14076.0, 14091.929540352232, 14102.71794564103, 7203.675834587351, 7217.170025447036, 7358.5584864907205, 7391.0, 7432.442566807511, 6788.287229840895, 6795.626240556718, 6858.862822743617, 7046.084009078787, 7050.717971281194, 4338.436003319548, 4405.977970110129, 4415.757133357632, 4427.468703755506, 4526.592606665416, 1798.1009495252374, 1821.6447792680565, 1837.6875931091479, 1844.3913508542148, 1844.4546525794317, 820.4584973917187, 869.8695195720693, 870.5473153959905, 904.9592968086621, 910.5128756115447, 16514.339426422808, 17196.828031719524, 17440.0, 17805.46583602494, 18108.456746297634, 813.5403497024281, 831.5135645647364, 838.7861095420628, 849.3332733804058, 872.3021582733787, 9301.116393942564, 9864.704058878246, 9960.850587241197, 9967.601295948225, 9972.750681233027, 396507.0, 403798.0, 404132.0, 408123.0, 408321.0, 49598.50401496011, 58467.41532584705, 79628.20371796323, 80198.5990070046, 83377.0, 905.0361365146098, 911.6809116809063, 913.2420091324185, 914.346242436661, 918.5453200665713, 15211.0, 15283.159426231665, 15441.768373474182, 15681.294341754421, 15759.921200393925, 37710.24579508449, 37922.62077379191, 38263.42604860985, 38326.61673383231, 38797.0, 49558.752206238736, 51075.74462127814, 52627.0, 52904.47095528995, 54088.0, 7368.115826100902, 7780.3386712130105, 7868.960655196687, 7979.241972012649, 8041.67833286662, 10339.431331276852, 12135.271883687006, 12319.322437266037, 12654.291670624349, 12661.240325580495, 9434.198093162158, 9800.166985806287, 10326.638567650096, 10336.844947325646, 10469.671702715605, 10494.326786999844, 10502.842457362993, 10705.036546710833, 11023.0, 11095.389753563308, 9954.900450995687, 10105.24210684187, 10169.491525423551, 10221.233407494616, 10548.525316360628, 7611.0, 7889.447738658238, 7938.920610793818, 7941.642626081955, 8082.393820463371, 8073.555954422563, 9523.523823808644, 10232.744181395525, 10370.325928814604, 10371.481425928523], "value": 8246.362363723114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.1007189571872, 1353.0461024977392, 1389.3886689856463, 1427.7430062588737, 1616.5554472520064, 6344.80965571033, 7199.892001619974, 7389.482736208468, 7470.850582988337, 7633.541987480741, 7360.337569618733, 7403.703851845919, 7404.851902961937, 7424.703011879518, 7428.220036896116, 2188.518525924298, 2214.0, 2215.180383258197, 2216.279709094543, 2217.9667304990357, 2122.246602456129, 2133.605283022638, 2197.8571392859494, 2198.9010494527706, 2205.547862688153, 2120.204923153817, 2125.2242931330106, 2128.30829980257, 2128.723265975421, 2197.604431202383, 2129.116416687073, 2142.5500644864596, 2147.2162660628915, 2154.9461263468384, 2155.3426205007468, 2003.8797672139717, 2101.5166511702396, 2102.180149741602, 2104.200403846544, 2104.5580428110115, 7327.7435289765135, 7504.061992250969, 7538.660760265801, 7562.735304264324, 7563.848723025564, 4241.257779888538, 4436.0, 4438.334249862546, 4443.066955939256, 4448.555144485558, 2767.4326763013737, 2906.7819913506573, 2949.8230106193696, 2951.5277555591, 2954.556816477524, 880.6565439478609, 888.626776753765, 896.4307664633005, 929.3076657889848, 934.9158575728217, 10096.646617368431, 10151.64469243573, 10158.949205254, 10215.89784102157, 10242.53908574116, 3777.131259810204, 3921.7254792164276, 4004.819783109767, 4057.594240575978, 4060.7360521566, 8148.470349427268, 8150.38872084596, 8150.959245203855, 8151.714689985822, 8157.469764465291, 4379.0366119453665, 4381.518033016429, 4386.846460373871, 4388.71473354231, 4392.626626736699, 3512.2624248908014, 3883.805809709503, 4027.4764280643913, 4039.8586049488126, 4052.4731784867777, 3271.2312606537444, 3325.0, 3388.6272510023878, 3407.2844702612233, 3434.4504879219203, 1005.1707341443339, 1094.2504384496644, 1102.3330884814573, 1106.286445242814, 1111.727626731456, 790.1150711203373, 811.3752410643772, 826.3430572694722, 826.4504104770381, 831.8294749576322, 4865.513448655177, 4987.675801072919, 4997.90004199914, 5029.321041659329, 5123.410807757155, 414.29569731456644, 427.23524890445753, 431.8985038515946, 431.9654427645781, 433.59675501783016, 3505.1762835733584, 3600.8739694111105, 3602.243528858969, 3641.253543023674, 3661.3409586274724, 8917.955410223038, 9239.891213054341, 9264.212541934012, 9359.812803743887, 9381.29640276982, 9103.135202155785, 9300.72097837066, 9311.208547273422, 9312.580933857993, 9334.579943902541, 6922.619255940972, 7021.684024218923, 7022.4382049436945, 7028.824279393056, 7033.7538186164265, 4950.158473059517, 4959.652824302264, 5031.094403007493, 5146.176611742103, 5238.449962754008, 8580.613872375634, 8628.094050124646, 8696.608652610774, 8745.387822852339, 8754.69358572447, 8062.7581172564915, 8428.45215061019, 8436.029856566329, 8782.516961567175, 8816.603252853765, 5875.676837773964, 6658.3674550917585, 6800.863982720417, 6803.693833777591, 6804.183497980274, 6525.738970441319, 6585.242697089704, 6585.374389432996, 6592.406683398517, 6941.236463989058, 6391.58454700443, 6484.610923344614, 6555.4427873631275, 6597.109390232257, 6621.9337806621315, 6525.608463492205, 6533.379328963741, 6538.8365290868105, 6561.3438656134, 6568.573042752206, 5978.133170690313, 6076.51387888959, 6081.604695694766, 6082.300535438481, 6084.39156084388, 4480.574345437179, 4489.753063581404, 4503.639708823352, 4577.862664120082, 4673.3457315976475, 4567.040921406542, 4594.770261486846, 4596.862094137181, 4631.374764406762, 4778.354922085613], "value": 3909.2786404522294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.2497930442935, 286.1729601451806, 286.75052704147396, 287.1257022366893, 292.81698938163646, 4828.855134345971, 4891.8043278268915, 4891.853244402665, 4907.681000734954, 4910.361652985116, 4805.855824325267, 4858.295547145671, 4867.123917694814, 4876.829310974116, 4879.682820616657, 3612.8554857805657, 3731.347014272505, 3738.5887552369218, 3779.9433008504757, 3817.675497582695, 3795.2978698940647, 3815.702661095227, 3825.617438256166, 3837.4052021936645, 3844.5770965193806, 3759.8684046058393, 3777.3956167013284, 3781.2626537825136, 3783.6405541473655, 3806.5067380865576, 3588.067102553342, 3643.362411577963, 3773.1699026214187, 3774.2074164425503, 3798.753081049737, 3326.434506133963, 3331.6168640606397, 3334.7665663403573, 3338.3657105150187, 3355.3457075870215, 4700.388949436551, 4700.623950083985, 4705.435347758256, 4709.646776491777, 4711.929321060187, 4146.067134894654, 4306.590873866978, 4323.11376167888, 4336.761478118702, 4343.239933011742, 4984.700917944935, 5007.699538027694, 5010.569873611295, 5013.849584512471, 5035.219540971156, 3641.18073433478, 3646.197836475971, 3651.1784848408897, 3654.835532401048, 3678.3746763050076, 5128.538431541179, 5312.574994000471, 5329.934013197376, 5341.225522299244, 5344.759485823147, 3681.668649821529, 3703.0742314421395, 3707.610700876423, 3712.461693054492, 3712.4988126603103, 3743.831527581265, 3751.174741556853, 3752.2870654575545, 3754.2866855297407, 3761.8495260189834, 4269.420314483661, 4277.807498662568, 4279.636230920407, 4294.334378171388, 4308.547602501755, 4851.454641234896, 5035.823746168867, 5060.139776238048, 5072.721000345016, 5074.3657042869645, 1288.4524077267124, 1296.500847173845, 1312.8512551517422, 1316.5128902306208, 1319.5579480873823, 826.6941231744294, 849.2993280543576, 869.8782170496136, 870.4429165334191, 876.82901834143, 4384.145091707086, 4454.933176002362, 4488.798004089824, 4501.954980450219, 4508.120916421332, 5152.819651312186, 5174.353205849269, 5186.351706036746, 5189.247559103909, 5204.34945631796, 4520.412346395014, 4533.886652833706, 4538.773061346919, 4541.9545804542195, 4556.658250631216, 2640.9471810564064, 2757.7038791767836, 2768.792340574465, 2793.6368272124496, 2798.6781520125446, 4908.594788553654, 4929.285253638274, 4932.26016097581, 4961.131801934647, 4969.4782047884455, 5114.616403769732, 5370.838874833761, 5397.595180361489, 5402.432744561765, 5414.269073675004, 4934.506549345037, 4949.430815456197, 4971.801127954841, 4989.3264409305, 5014.52362025607, 5246.3704355477585, 5249.632525723316, 5262.500062494057, 5276.788928442819, 5277.393099793419, 4997.725125118153, 5110.565601923878, 5151.974240128776, 5155.123628983007, 5174.586033117266, 4894.479343138358, 4913.336699545515, 4913.385826771653, 4933.925991110208, 4954.299906550867, 3750.118722100359, 3761.5110035695184, 3770.510648293963, 3777.905552361213, 3780.2061567071223, 5123.6157288202785, 5194.766235519335, 5224.634275600672, 5236.581073514034, 5242.501962313574, 5006.724630145377, 5034.28834196375, 5043.394792624908, 5062.594992400525, 5068.366454193226, 5043.899122017612, 5061.13960626687, 5073.492650734897, 5083.364579427572, 5089.694618322913, 4773.809047638195, 4928.334674818853, 4940.975295123501, 4967.155583550732, 4998.925016124688, 4907.33750943618, 5053.620978426559, 5084.466131056186, 5088.084144853962, 5103.132467480463, 4832.299316599003, 4876.0, 4905.1416002200185, 4917.926231106465, 4948.0], "value": 3822.694172403647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.3958343739074, 625.262190615074, 685.5886468119126, 702.231056992593, 723.7901008707472, 12257.0, 12562.685932851684, 12918.354082295882, 12978.351082445864, 13020.739585208303, 12883.484660613587, 12973.351332433387, 13040.673983150426, 13057.804132938014, 13067.607971760839, 620.7330847735471, 637.3912913167914, 638.9297177310492, 731.6597782031367, 746.4998451037791, 638.7285403703431, 735.6836560279078, 763.0461922596754, 765.9195784442637, 769.9653515591784, 793.5437123653893, 794.7417089445925, 795.3756301303478, 796.3509739562268, 796.8446153000167, 790.5335851847437, 794.1066300412036, 794.233564610154, 794.2772077409587, 794.7575989323254, 478.52386875059193, 570.0394834703537, 588.7085892483205, 589.4989259129749, 591.6391001489088, 13077.411516481781, 13106.14810037354, 13107.410166542528, 13112.672183195402, 13123.934380328037, 11594.942025289904, 11703.473343699468, 11742.58900938463, 12038.939805300917, 12258.75482490354, 9811.166050885684, 9946.701598952042, 10079.748006299827, 11476.598319058876, 11671.824922626167, 4046.271671099201, 4101.507819061701, 4124.1133156371525, 4135.1316223592785, 4148.357004664282, 58990.70504647492, 59737.068190445505, 60263.0, 60372.698136509476, 61904.0, 9503.28725345602, 9843.212542996544, 10048.69853904384, 10160.288779785493, 10220.751434684358, 17470.126493675267, 17540.5614859627, 17587.56031099233, 17611.0, 17636.118194090242, 6433.549651524442, 6614.173228346457, 6719.0, 6747.595144291358, 6815.965920170367, 3562.412201986695, 3576.6065732769375, 3591.856325746941, 3611.963880361215, 3629.6914762245506, 2686.8925242990063, 2772.223777342347, 2776.1810265971585, 2777.180731684158, 2777.9722202778116, 483.5164835164835, 493.0853267189384, 494.84659755475917, 495.34119620904113, 502.7787773379701, 492.21246006390203, 495.60104116186096, 503.6575128912375, 526.210683974039, 550.3450893436798, 6508.9023664645065, 6751.311563703031, 6797.52417330792, 6931.0, 7110.5022648414115, 475.6218806049199, 478.8228355508484, 488.6066716293347, 495.15081634996153, 533.2561077297149, 3341.4987751836934, 3358.378699940519, 3394.6435624259593, 3417.1457135716073, 3557.7153827693724, 90378.54810726036, 94122.0, 96681.51659241659, 97040.51479742557, 98165.50917245368, 66112.6694366525, 68223.0, 82370.0, 82854.17145828585, 84976.0, 59856.401435985084, 69170.9624355635, 70782.2921770786, 72288.63855680688, 72725.0, 7871.724489642835, 8257.38069644767, 8325.125861784425, 8460.873086903579, 8499.627866551318, 43417.0, 43544.12911741811, 43881.56118438902, 44095.11809763851, 44272.55727442684, 39631.0, 47749.76125119352, 62103.0, 62935.0, 64904.0, 10932.398718070583, 11224.55101795919, 11563.88436115628, 11722.765544688888, 11866.406679666155, 12497.25016499013, 12787.232766034067, 12906.483740650645, 13148.671283217613, 13152.0, 10772.622958196425, 10899.78200435971, 11158.553657853596, 11556.364399957747, 11603.303801771921, 10652.360858348524, 11258.21192516516, 12293.508259669514, 12321.876781232073, 12327.630171094881, 11449.59926402572, 11513.597024104116, 12678.366081696062, 12702.047346448868, 12734.745305094031, 10006.29955903109, 10135.7466063349, 10255.7436064099, 10371.533281002525, 10371.844422333521, 9402.712378009812, 9545.379550329206, 10121.431435544278, 10195.184385249015, 10198.272136082875], "value": 6318.062640365241, "unit": "score"}], "name": "dromaeo_css", "value": 6300.723544806063, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 124.0, 181.0, 121.0, 123.0, 146.0, 123.0, 163.0, 126.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 119.0, 76.0, 76.0, 74.0, 74.0, 100.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 128.0, 84.0, 85.0, 84.0, 125.0, 85.0, 90.0, 135.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 62.0, 62.0, 63.0, 63.0, 62.0, 64.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 71.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 79.0, 79.0, 78.0, 78.0, 78.0, 84.0, 78.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 128.0, 131.0, 130.0, 132.0, 124.0, 124.0, 212.0, 134.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 162.0, 167.0, 166.0, 164.0, 166.0, 163.0, 165.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 68.0, 71.0, 67.0, 73.0, 66.0, 65.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1529.3000000000002, "alertThreshold": 2.0}]} 10:27:53 INFO - Return code: 0 10:27:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:27:53 INFO - # TBPL SUCCESS # 10:27:53 INFO - Running post-action listener: _resource_record_post_action 10:27:53 INFO - [mozharness: 2016-07-31 17:27:53.518694Z] Finished run-tests step (success) 10:27:53 INFO - Running post-run listener: _resource_record_post_run 10:27:53 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 196608; Write bytes: 296697856; Read time: 428; Write time: 313260 10:27:53 INFO - TinderboxPrint: CPU usage
13.0% 10:27:53 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 428 10:27:53 INFO - TinderboxPrint: I/O write bytes / time
296,697,856 / 313,260 10:27:53 INFO - TinderboxPrint: CPU idle
8,334.9 (87.0%) 10:27:53 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 10:27:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:27:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13893632; Read time: 0; Write time: 3240 10:27:53 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 196608; Write bytes: 282804224; Read time: 428; Write time: 310020 10:27:54 INFO - Running post-run listener: _upload_blobber_files 10:27:54 INFO - Blob upload gear active. 10:27:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:04 INFO - (blobuploader) - INFO - Done attempting. 10:28:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:28:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:28:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:05 INFO - (blobuploader) - INFO - Done attempting. 10:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:06 INFO - (blobuploader) - INFO - Done attempting. 10:28:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:06 INFO - Return code: 0 10:28:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/820161446f474626a872efc9e3b952e6da13e16b9431abeb653f07673802fd6e10ea19ab50f6ecfbd39e04068a2791618b337cbe698298acabf58d74121e87e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b92e5959e308ad7d4dd981902f677852c333330521460eb06b200698327dacc9824b41222aa1ebc879bc5bdfeb5ea062e84f4bafc35078297939d5c301ecb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc31362504c16d5d0f41c8f2f11cd53939dfbe337a30d9ec0ec2cc542d191e4fe1be6cfce44e1cd668b8f4090479050853bb7811782c56ec42620fab16a7c901"} 10:28:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:06 INFO - Contents: 10:28:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/820161446f474626a872efc9e3b952e6da13e16b9431abeb653f07673802fd6e10ea19ab50f6ecfbd39e04068a2791618b337cbe698298acabf58d74121e87e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b92e5959e308ad7d4dd981902f677852c333330521460eb06b200698327dacc9824b41222aa1ebc879bc5bdfeb5ea062e84f4bafc35078297939d5c301ecb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc31362504c16d5d0f41c8f2f11cd53939dfbe337a30d9ec0ec2cc542d191e4fe1be6cfce44e1cd668b8f4090479050853bb7811782c56ec42620fab16a7c901"} 10:28:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:06 INFO - Copying logs to upload dir... 10:28:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.013288 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-31 10:28:05.708555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 10:28:05.716432) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334 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/820161446f474626a872efc9e3b952e6da13e16b9431abeb653f07673802fd6e10ea19ab50f6ecfbd39e04068a2791618b337cbe698298acabf58d74121e87e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b92e5959e308ad7d4dd981902f677852c333330521460eb06b200698327dacc9824b41222aa1ebc879bc5bdfeb5ea062e84f4bafc35078297939d5c301ecb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc31362504c16d5d0f41c8f2f11cd53939dfbe337a30d9ec0ec2cc542d191e4fe1be6cfce44e1cd668b8f4090479050853bb7811782c56ec42620fab16a7c901"} build_url:https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/YVIvOkv_RteK33d4Cf5PoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/820161446f474626a872efc9e3b952e6da13e16b9431abeb653f07673802fd6e10ea19ab50f6ecfbd39e04068a2791618b337cbe698298acabf58d74121e87e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b92e5959e308ad7d4dd981902f677852c333330521460eb06b200698327dacc9824b41222aa1ebc879bc5bdfeb5ea062e84f4bafc35078297939d5c301ecb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc31362504c16d5d0f41c8f2f11cd53939dfbe337a30d9ec0ec2cc542d191e4fe1be6cfce44e1cd668b8f4090479050853bb7811782c56ec42620fab16a7c901"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 10:28:05.745056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:28:05.745488) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469970593.432027-1070673334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 10:28:05.830555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 10:28:05.831123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 10:28:05.831561) ========= ========= Total master_lag: 0.19 =========