builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1469715483.35 results: success (0) buildid: 20160728043102 builduid: 8b8d311818844b79812b0a04384876c5 revision: db2c7f11d17142b488396e5e3c39a31520b36139 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.347517) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.347991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.348279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.363978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.364366) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 07:18:03-- 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% 220M=0s 2016-07-28 07:18:03 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073860 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.454139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.454458) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015224 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.504108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:03.504468) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev db2c7f11d17142b488396e5e3c39a31520b36139 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev db2c7f11d17142b488396e5e3c39a31520b36139 --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=9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 07:18:03,958 truncating revision to first 12 chars 2016-07-28 07:18:03,958 Setting DEBUG logging. 2016-07-28 07:18:03,958 attempt 1/10 2016-07-28 07:18:03,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/db2c7f11d171?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 07:18:04,299 unpacking tar archive at: mozilla-inbound-db2c7f11d171/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:04.194643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:04.194971) ========= script_repo_revision: db2c7f11d17142b488396e5e3c39a31520b36139 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:04.195376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:04.195732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 07:18:04.205194) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-28 07:18:04.205605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:04 INFO - MultiFileLogger online at 20160728 07:18:04 in /builds/slave/test 07:18:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:18:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:04 INFO - {'append_to_log': False, 07:18:04 INFO - 'base_work_dir': '/builds/slave/test', 07:18:04 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:18:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:04 INFO - 'branch': 'Mozilla-Inbound', 07:18:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:04 INFO - 'config_files': ('talos/linux_config.py',), 07:18:04 INFO - 'default_actions': ('clobber', 07:18:04 INFO - 'read-buildbot-config', 07:18:04 INFO - 'download-and-extract', 07:18:04 INFO - 'populate-webroot', 07:18:04 INFO - 'create-virtualenv', 07:18:04 INFO - 'install', 07:18:04 INFO - 'run-tests'), 07:18:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:04 INFO - 'download_minidump_stackwalk': True, 07:18:04 INFO - 'download_symbols': 'ondemand', 07:18:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:04 INFO - 'installer_path': 'installer.exe', 07:18:04 INFO - 'log_level': 'info', 07:18:04 INFO - 'log_name': 'talos', 07:18:04 INFO - 'log_to_console': True, 07:18:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:04 INFO - 'opt_config_files': (), 07:18:04 INFO - 'pip_index': False, 07:18:04 INFO - 'sps_profile': False, 07:18:04 INFO - 'sps_profile_interval': 0, 07:18:04 INFO - 'suite': 'dromaeojs', 07:18:04 INFO - 'system_bits': '32', 07:18:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:04 INFO - 'title': 'talos-linux64-ix-013', 07:18:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:04 INFO - 'use_talos_json': True, 07:18:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:04 INFO - 'work_dir': 'build'} 07:18:04 INFO - [mozharness: 2016-07-28 14:18:04.760829Z] Running clobber step. 07:18:04 INFO - Running pre-action listener: _resource_record_pre_action 07:18:04 INFO - Running main action method: clobber 07:18:04 INFO - rmtree: /builds/slave/test/build 07:18:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:05 INFO - Running post-action listener: _resource_record_post_action 07:18:05 INFO - [mozharness: 2016-07-28 14:18:05.230567Z] Finished clobber step (success) 07:18:05 INFO - [mozharness: 2016-07-28 14:18:05.230668Z] Running read-buildbot-config step. 07:18:05 INFO - Running pre-action listener: _resource_record_pre_action 07:18:05 INFO - Running main action method: read_buildbot_config 07:18:05 INFO - Using buildbot properties: 07:18:05 INFO - { 07:18:05 INFO - "project": "", 07:18:05 INFO - "product": "firefox", 07:18:05 INFO - "script_repo_revision": "production", 07:18:05 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:18:05 INFO - "repository": "", 07:18:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:18:05 INFO - "buildid": "20160728043102", 07:18:05 INFO - "pgo_build": "True", 07:18:05 INFO - "basedir": "/builds/slave/test", 07:18:05 INFO - "buildnumber": 1313, 07:18:05 INFO - "slavename": "talos-linux64-ix-013", 07:18:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:18:05 INFO - "platform": "ubuntu64_hw", 07:18:05 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:18:05 INFO - "branch": "mozilla-inbound", 07:18:05 INFO - "repo_path": "integration/mozilla-inbound", 07:18:05 INFO - "revision": "db2c7f11d17142b488396e5e3c39a31520b36139", 07:18:05 INFO - "stage_platform": "linux64-pgo", 07:18:05 INFO - "builduid": "8b8d311818844b79812b0a04384876c5", 07:18:05 INFO - "slavebuilddir": "test" 07:18:05 INFO - } 07:18:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:18:05 INFO - Running post-action listener: _resource_record_post_action 07:18:05 INFO - [mozharness: 2016-07-28 14:18:05.233417Z] Finished read-buildbot-config step (success) 07:18:05 INFO - [mozharness: 2016-07-28 14:18:05.233510Z] Running download-and-extract step. 07:18:05 INFO - Running pre-action listener: _resource_record_pre_action 07:18:05 INFO - Running main action method: download_and_extract 07:18:05 INFO - mkdir: /builds/slave/test/build/tests 07:18:05 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')]} 07:18:05 INFO - https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:05 INFO - Downloaded 1361 bytes. 07:18:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:18:05 INFO - Using the following test package requirements: 07:18:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:18:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'jsshell-linux-x86_64.zip'], 07:18:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:18:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:18:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18:05 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')]} 07:18:05 INFO - https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:06 INFO - Downloaded 24321386 bytes. 07:18:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:18:08 INFO - Return code: 0 07:18:08 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 07:18:08 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')]} 07:18:08 INFO - https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:11 INFO - Downloaded 24321386 bytes. 07:18:11 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'] 07:18:11 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 07:18:12 INFO - Return code: 0 07:18:12 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')]} 07:18:12 INFO - https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:13 INFO - Downloaded 14413725 bytes. 07:18:13 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'] 07:18:13 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 07:18:13 INFO - Return code: 0 07:18:13 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')]} 07:18:13 INFO - https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HLW9wObUTxWhtkZAecAYMA/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 07:18:14 INFO - Downloaded 60979417 bytes. 07:18:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:14 INFO - mkdir: /builds/slave/test/properties 07:18:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:14 INFO - Contents: 07:18:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:18:15 INFO - Running post-action listener: _resource_record_post_action 07:18:15 INFO - Running post-action listener: set_extra_try_arguments 07:18:15 INFO - [mozharness: 2016-07-28 14:18:15.517576Z] Finished download-and-extract step (success) 07:18:15 INFO - [mozharness: 2016-07-28 14:18:15.517808Z] Running populate-webroot step. 07:18:15 INFO - Running pre-action listener: _resource_record_pre_action 07:18:15 INFO - Running main action method: populate_webroot 07:18:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:15 INFO - '--tppagecycles', 07:18:15 INFO - '7'], 07:18:15 INFO - 'tests': ['tsvgm']}}, 07:18:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['damp', 'tps']}, 07:18:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'tests': ['damp', 'tps']}, 07:18:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['dromaeo_dom']}, 07:18:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['basic_compositor_video']}, 07:18:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:18:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['a11yr', 07:18:15 INFO - 'ts_paint', 07:18:15 INFO - 'tpaint', 07:18:15 INFO - 'sessionrestore', 07:18:15 INFO - 'sessionrestore_no_auto_restore', 07:18:15 INFO - 'tabpaint']}, 07:18:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:15 INFO - 'ts_paint', 07:18:15 INFO - 'tpaint', 07:18:15 INFO - 'sessionrestore', 07:18:15 INFO - 'sessionrestore_no_auto_restore', 07:18:15 INFO - 'tabpaint']}, 07:18:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:15 INFO - 'ts_paint', 07:18:15 INFO - 'tpaint', 07:18:15 INFO - 'sessionrestore', 07:18:15 INFO - 'sessionrestore_no_auto_restore', 07:18:15 INFO - 'tabpaint']}, 07:18:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:15 INFO - 'ts_paint', 07:18:15 INFO - 'tpaint', 07:18:15 INFO - 'sessionrestore', 07:18:15 INFO - 'sessionrestore_no_auto_restore', 07:18:15 INFO - 'tabpaint']}, 07:18:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['a11yr', 07:18:15 INFO - 'ts_paint', 07:18:15 INFO - 'tpaint', 07:18:15 INFO - 'sessionrestore', 07:18:15 INFO - 'sessionrestore_no_auto_restore', 07:18:15 INFO - 'tabpaint']}, 07:18:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['a11yr', 07:18:15 INFO - 'ts_paint', 07:18:15 INFO - 'tpaint', 07:18:15 INFO - 'sessionrestore', 07:18:15 INFO - 'sessionrestore_no_auto_restore', 07:18:15 INFO - 'tabpaint']}, 07:18:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['tsvgx', 07:18:15 INFO - 'tsvgr_opacity', 07:18:15 INFO - 'tart', 07:18:15 INFO - 'tscrollx', 07:18:15 INFO - 'cart']}, 07:18:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:15 INFO - 'tsvgr_opacity', 07:18:15 INFO - 'tart', 07:18:15 INFO - 'tscrollx', 07:18:15 INFO - 'cart']}, 07:18:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'talos_options': ['--disable-e10s'], 07:18:15 INFO - 'tests': ['tp5o']}, 07:18:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'tests': ['tp5o']}, 07:18:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'talos_options': ['--disable-e10s', 07:18:15 INFO - '--xperf_path', 07:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:15 INFO - 'tests': ['tp5n']}, 07:18:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:15 INFO - 'talos_options': ['--xperf_path', 07:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:15 INFO - 'tests': ['tp5n']}}, 07:18:15 INFO - 'talos.zip': {'path': '', 07:18:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:15 INFO - Running post-action listener: _resource_record_post_action 07:18:15 INFO - [mozharness: 2016-07-28 14:18:15.535708Z] Finished populate-webroot step (success) 07:18:15 INFO - [mozharness: 2016-07-28 14:18:15.535795Z] Running create-virtualenv step. 07:18:15 INFO - Running pre-action listener: _resource_record_pre_action 07:18:15 INFO - Running main action method: create_virtualenv 07:18:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:15 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 07:18:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:15 INFO - Using real prefix '/usr' 07:18:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:18 INFO - Installing pip.................done. 07:18:18 INFO - Return code: 0 07:18:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:18 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')]} 07:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:18 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')]} 07:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:18 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:18 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 07:18:18 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 07:18:18 INFO - Using env: {'DISPLAY': ':0', 07:18:18 INFO - 'HOME': '/home/cltbld', 07:18:18 INFO - 'LANG': 'en_US.UTF-8', 07:18:18 INFO - 'LANGUAGE': 'en_US:en', 07:18:18 INFO - 'LOGNAME': 'cltbld', 07:18:18 INFO - 'MAIL': '/var/mail/cltbld', 07:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:18 INFO - 'MOZ_NO_REMOTE': '1', 07:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:18 INFO - 'NO_EM_RESTART': '1', 07:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:18 INFO - 'PWD': '/builds/slave/test', 07:18:18 INFO - 'SHELL': '/bin/bash', 07:18:18 INFO - 'SHLVL': '1', 07:18:18 INFO - 'TERM': 'linux', 07:18:18 INFO - 'TMOUT': '86400', 07:18:18 INFO - 'USER': 'cltbld', 07:18:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:18 INFO - '_': '/tools/buildbot/bin/python'} 07:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:18 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 07:18:18 INFO - Cleaning up... 07:18:18 INFO - Return code: 0 07:18:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:18 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')]} 07:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:18 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')]} 07:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:18 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:18 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 07:18:18 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 07:18:18 INFO - Using env: {'DISPLAY': ':0', 07:18:18 INFO - 'HOME': '/home/cltbld', 07:18:18 INFO - 'LANG': 'en_US.UTF-8', 07:18:18 INFO - 'LANGUAGE': 'en_US:en', 07:18:18 INFO - 'LOGNAME': 'cltbld', 07:18:18 INFO - 'MAIL': '/var/mail/cltbld', 07:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:18 INFO - 'MOZ_NO_REMOTE': '1', 07:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:18 INFO - 'NO_EM_RESTART': '1', 07:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:18 INFO - 'PWD': '/builds/slave/test', 07:18:18 INFO - 'SHELL': '/bin/bash', 07:18:18 INFO - 'SHLVL': '1', 07:18:18 INFO - 'TERM': 'linux', 07:18:18 INFO - 'TMOUT': '86400', 07:18:18 INFO - 'USER': 'cltbld', 07:18:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:18 INFO - '_': '/tools/buildbot/bin/python'} 07:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:18 INFO - Downloading/unpacking psutil>=3.1.1 07:18:18 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 07:18:18 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 07:18:18 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 07:18:18 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 07:18:18 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 07:18:18 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 07:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:20 INFO - Installing collected packages: psutil 07:18:20 INFO - Running setup.py install for psutil 07:18:20 INFO - building 'psutil._psutil_linux' extension 07:18:20 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 07:18:20 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 07:18:20 INFO - building 'psutil._psutil_posix' extension 07:18:20 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 07:18:21 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 07:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:21 INFO - Successfully installed psutil 07:18:21 INFO - Cleaning up... 07:18:21 INFO - Return code: 0 07:18:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18:21 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')]} 07:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:21 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')]} 07:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:21 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:21 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 07:18:21 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 07:18:21 INFO - Using env: {'DISPLAY': ':0', 07:18:21 INFO - 'HOME': '/home/cltbld', 07:18:21 INFO - 'LANG': 'en_US.UTF-8', 07:18:21 INFO - 'LANGUAGE': 'en_US:en', 07:18:21 INFO - 'LOGNAME': 'cltbld', 07:18:21 INFO - 'MAIL': '/var/mail/cltbld', 07:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:21 INFO - 'MOZ_NO_REMOTE': '1', 07:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:21 INFO - 'NO_EM_RESTART': '1', 07:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:21 INFO - 'PWD': '/builds/slave/test', 07:18:21 INFO - 'SHELL': '/bin/bash', 07:18:21 INFO - 'SHLVL': '1', 07:18:21 INFO - 'TERM': 'linux', 07:18:21 INFO - 'TMOUT': '86400', 07:18:21 INFO - 'USER': 'cltbld', 07:18:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:21 INFO - '_': '/tools/buildbot/bin/python'} 07:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18:21 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 07:18:21 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 07:18:21 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 07:18:21 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 07:18:21 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 07:18:21 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 07:18:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:18:23 INFO - Installing collected packages: mozsystemmonitor 07:18:23 INFO - Running setup.py install for mozsystemmonitor 07:18:23 INFO - Successfully installed mozsystemmonitor 07:18:23 INFO - Cleaning up... 07:18:23 INFO - Return code: 0 07:18:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:23 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:23 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 07:18:23 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 07:18:23 INFO - Using env: {'DISPLAY': ':0', 07:18:23 INFO - 'HOME': '/home/cltbld', 07:18:23 INFO - 'LANG': 'en_US.UTF-8', 07:18:23 INFO - 'LANGUAGE': 'en_US:en', 07:18:23 INFO - 'LOGNAME': 'cltbld', 07:18:23 INFO - 'MAIL': '/var/mail/cltbld', 07:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:23 INFO - 'MOZ_NO_REMOTE': '1', 07:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:23 INFO - 'NO_EM_RESTART': '1', 07:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:23 INFO - 'PWD': '/builds/slave/test', 07:18:23 INFO - 'SHELL': '/bin/bash', 07:18:23 INFO - 'SHLVL': '1', 07:18:23 INFO - 'TERM': 'linux', 07:18:23 INFO - 'TMOUT': '86400', 07:18:23 INFO - 'USER': 'cltbld', 07:18:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:23 INFO - '_': '/tools/buildbot/bin/python'} 07:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:18:23 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 07:18:23 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 07:18:23 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 07:18:23 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 07:18:23 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 07:18:23 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 07:18:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:25 INFO - warning: no files found matching '*.txt' 07:18:25 INFO - no previously-included directories found matching 'build' 07:18:25 INFO - no previously-included directories found matching 'dist' 07:18:25 INFO - no previously-included directories found matching '.git*' 07:18:25 INFO - Installing collected packages: jsonschema, functools32 07:18:26 INFO - Running setup.py install for functools32 07:18:26 INFO - warning: no files found matching '*.txt' 07:18:26 INFO - no previously-included directories found matching 'build' 07:18:26 INFO - no previously-included directories found matching 'dist' 07:18:26 INFO - no previously-included directories found matching '.git*' 07:18:26 INFO - Successfully installed jsonschema functools32 07:18:26 INFO - Cleaning up... 07:18:26 INFO - Return code: 0 07:18:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:26 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:26 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 07:18:26 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 07:18:26 INFO - Using env: {'DISPLAY': ':0', 07:18:26 INFO - 'HOME': '/home/cltbld', 07:18:26 INFO - 'LANG': 'en_US.UTF-8', 07:18:26 INFO - 'LANGUAGE': 'en_US:en', 07:18:26 INFO - 'LOGNAME': 'cltbld', 07:18:26 INFO - 'MAIL': '/var/mail/cltbld', 07:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:26 INFO - 'MOZ_NO_REMOTE': '1', 07:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:26 INFO - 'NO_EM_RESTART': '1', 07:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:26 INFO - 'PWD': '/builds/slave/test', 07:18:26 INFO - 'SHELL': '/bin/bash', 07:18:26 INFO - 'SHLVL': '1', 07:18:26 INFO - 'TERM': 'linux', 07:18:26 INFO - 'TMOUT': '86400', 07:18:26 INFO - 'USER': 'cltbld', 07:18:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:26 INFO - '_': '/tools/buildbot/bin/python'} 07:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:18:26 INFO - Cleaning up... 07:18:26 INFO - Return code: 0 07:18:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:26 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:26 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 07:18:26 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 07:18:26 INFO - Using env: {'DISPLAY': ':0', 07:18:26 INFO - 'HOME': '/home/cltbld', 07:18:26 INFO - 'LANG': 'en_US.UTF-8', 07:18:26 INFO - 'LANGUAGE': 'en_US:en', 07:18:26 INFO - 'LOGNAME': 'cltbld', 07:18:26 INFO - 'MAIL': '/var/mail/cltbld', 07:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:26 INFO - 'MOZ_NO_REMOTE': '1', 07:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:26 INFO - 'NO_EM_RESTART': '1', 07:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:26 INFO - 'PWD': '/builds/slave/test', 07:18:26 INFO - 'SHELL': '/bin/bash', 07:18:26 INFO - 'SHLVL': '1', 07:18:26 INFO - 'TERM': 'linux', 07:18:26 INFO - 'TMOUT': '86400', 07:18:26 INFO - 'USER': 'cltbld', 07:18:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:26 INFO - '_': '/tools/buildbot/bin/python'} 07:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:26 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 07:18:26 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 07:18:26 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 07:18:26 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 07:18:26 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 07:18:26 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 07:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:18:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:29 INFO - Downloading docopt-0.6.1.tar.gz 07:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:18:29 INFO - Running setup.py install for blobuploader 07:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:18:29 INFO - Running setup.py install for requests 07:18:29 INFO - Running setup.py install for docopt 07:18:29 INFO - Successfully installed blobuploader requests docopt 07:18:29 INFO - Cleaning up... 07:18:29 INFO - Return code: 0 07:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:29 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:29 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 07:18:29 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 07:18:29 INFO - Using env: {'DISPLAY': ':0', 07:18:29 INFO - 'HOME': '/home/cltbld', 07:18:29 INFO - 'LANG': 'en_US.UTF-8', 07:18:29 INFO - 'LANGUAGE': 'en_US:en', 07:18:29 INFO - 'LOGNAME': 'cltbld', 07:18:29 INFO - 'MAIL': '/var/mail/cltbld', 07:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:29 INFO - 'MOZ_NO_REMOTE': '1', 07:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:29 INFO - 'NO_EM_RESTART': '1', 07:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:29 INFO - 'PWD': '/builds/slave/test', 07:18:29 INFO - 'SHELL': '/bin/bash', 07:18:29 INFO - 'SHLVL': '1', 07:18:29 INFO - 'TERM': 'linux', 07:18:29 INFO - 'TMOUT': '86400', 07:18:29 INFO - 'USER': 'cltbld', 07:18:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:29 INFO - '_': '/tools/buildbot/bin/python'} 07:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:30 INFO - Running setup.py (path:/tmp/pip-ZFeSQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:30 INFO - Running setup.py (path:/tmp/pip-UoE6ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:30 INFO - Running setup.py (path:/tmp/pip-bdOyJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:30 INFO - Running setup.py (path:/tmp/pip-tVqkuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:30 INFO - Running setup.py (path:/tmp/pip-HfZp9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:30 INFO - Running setup.py (path:/tmp/pip-F3uZ55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:30 INFO - Running setup.py (path:/tmp/pip-9XEEx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:30 INFO - Running setup.py (path:/tmp/pip-TFW9ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:30 INFO - Running setup.py (path:/tmp/pip-1Fd0BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:30 INFO - Running setup.py (path:/tmp/pip-QhDc2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:30 INFO - Running setup.py (path:/tmp/pip-_4dDRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:30 INFO - Running setup.py (path:/tmp/pip-_DouRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:30 INFO - Running setup.py (path:/tmp/pip-KeVd8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:31 INFO - Running setup.py (path:/tmp/pip-CC7OMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:31 INFO - Running setup.py (path:/tmp/pip-t7l6Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:31 INFO - Running setup.py (path:/tmp/pip-kH5fY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:31 INFO - Running setup.py (path:/tmp/pip-wyK2Uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:31 INFO - Running setup.py install for manifestparser 07:18:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:18:31 INFO - Running setup.py install for mozcrash 07:18:31 INFO - Running setup.py install for mozdebug 07:18:31 INFO - Running setup.py install for mozdevice 07:18:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:18:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:18:31 INFO - Running setup.py install for mozfile 07:18:31 INFO - Running setup.py install for mozhttpd 07:18:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:31 INFO - Running setup.py install for mozinfo 07:18:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Running setup.py install for mozInstall 07:18:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Running setup.py install for mozleak 07:18:32 INFO - Running setup.py install for mozlog 07:18:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Running setup.py install for moznetwork 07:18:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Running setup.py install for mozprocess 07:18:32 INFO - Running setup.py install for mozprofile 07:18:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Running setup.py install for mozrunner 07:18:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:32 INFO - Running setup.py install for mozscreenshot 07:18:32 INFO - Running setup.py install for moztest 07:18:32 INFO - Running setup.py install for mozversion 07:18:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:33 INFO - Cleaning up... 07:18:33 INFO - Return code: 0 07:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:33 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:33 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 07:18:33 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 07:18:33 INFO - Using env: {'DISPLAY': ':0', 07:18:33 INFO - 'HOME': '/home/cltbld', 07:18:33 INFO - 'LANG': 'en_US.UTF-8', 07:18:33 INFO - 'LANGUAGE': 'en_US:en', 07:18:33 INFO - 'LOGNAME': 'cltbld', 07:18:33 INFO - 'MAIL': '/var/mail/cltbld', 07:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:33 INFO - 'MOZ_NO_REMOTE': '1', 07:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:33 INFO - 'NO_EM_RESTART': '1', 07:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:33 INFO - 'PWD': '/builds/slave/test', 07:18:33 INFO - 'SHELL': '/bin/bash', 07:18:33 INFO - 'SHLVL': '1', 07:18:33 INFO - 'TERM': 'linux', 07:18:33 INFO - 'TMOUT': '86400', 07:18:33 INFO - 'USER': 'cltbld', 07:18:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:33 INFO - '_': '/tools/buildbot/bin/python'} 07:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:33 INFO - Running setup.py (path:/tmp/pip-WCvk8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:33 INFO - Running setup.py (path:/tmp/pip-lunl0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:33 INFO - Running setup.py (path:/tmp/pip-SrNUpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:33 INFO - Running setup.py (path:/tmp/pip-WlK0XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:33 INFO - Running setup.py (path:/tmp/pip-Wat0U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:33 INFO - Running setup.py (path:/tmp/pip-wvkJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:33 INFO - Running setup.py (path:/tmp/pip-wXe0XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:33 INFO - Running setup.py (path:/tmp/pip-2kD3TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:33 INFO - Running setup.py (path:/tmp/pip-gcSb_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:33 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)) 07:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:33 INFO - Running setup.py (path:/tmp/pip-LKvLy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:34 INFO - Running setup.py (path:/tmp/pip-urrjgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:34 INFO - Running setup.py (path:/tmp/pip-885wrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:34 INFO - Running setup.py (path:/tmp/pip-JXzsF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:34 INFO - Running setup.py (path:/tmp/pip-EpOkbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:34 INFO - Running setup.py (path:/tmp/pip-Q50XDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:34 INFO - Running setup.py (path:/tmp/pip-w1QP4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:34 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)) 07:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:34 INFO - Running setup.py (path:/tmp/pip-Onhdlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:34 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)) 07:18:34 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)) 07:18:34 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)) 07:18:34 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)) 07:18:34 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)) 07:18:34 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)) 07:18:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:36 INFO - Downloading blessings-1.6.tar.gz 07:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:36 INFO - Installing collected packages: blessings 07:18:36 INFO - Running setup.py install for blessings 07:18:36 INFO - Successfully installed blessings 07:18:36 INFO - Cleaning up... 07:18:36 INFO - Return code: 0 07:18:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:36 INFO - Reading from file tmpfile_stdout 07:18:36 INFO - Current package versions: 07:18:36 INFO - argparse == 1.2.1 07:18:36 INFO - blessings == 1.6 07:18:36 INFO - blobuploader == 1.2.4 07:18:36 INFO - docopt == 0.6.1 07:18:36 INFO - functools32 == 3.2.3-2 07:18:36 INFO - jsonschema == 2.5.1 07:18:36 INFO - manifestparser == 1.1 07:18:36 INFO - mozInstall == 1.12 07:18:36 INFO - mozcrash == 0.17 07:18:36 INFO - mozdebug == 0.1 07:18:36 INFO - mozdevice == 0.48 07:18:36 INFO - mozfile == 1.2 07:18:36 INFO - mozhttpd == 0.7 07:18:36 INFO - mozinfo == 0.9 07:18:36 INFO - mozleak == 0.1 07:18:36 INFO - mozlog == 3.3 07:18:36 INFO - moznetwork == 0.27 07:18:36 INFO - mozprocess == 0.23 07:18:36 INFO - mozprofile == 0.28 07:18:36 INFO - mozrunner == 6.12 07:18:36 INFO - mozscreenshot == 0.1 07:18:36 INFO - mozsystemmonitor == 0.3 07:18:36 INFO - moztest == 0.7 07:18:36 INFO - mozversion == 1.4 07:18:36 INFO - psutil == 3.1.1 07:18:36 INFO - requests == 1.2.3 07:18:36 INFO - wsgiref == 0.1.2 07:18:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:36 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 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18:36 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 07:18:36 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 07:18:36 INFO - Using env: {'DISPLAY': ':0', 07:18:36 INFO - 'HOME': '/home/cltbld', 07:18:36 INFO - 'LANG': 'en_US.UTF-8', 07:18:36 INFO - 'LANGUAGE': 'en_US:en', 07:18:36 INFO - 'LOGNAME': 'cltbld', 07:18:36 INFO - 'MAIL': '/var/mail/cltbld', 07:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:36 INFO - 'MOZ_NO_REMOTE': '1', 07:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:36 INFO - 'NO_EM_RESTART': '1', 07:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:36 INFO - 'PWD': '/builds/slave/test', 07:18:36 INFO - 'SHELL': '/bin/bash', 07:18:36 INFO - 'SHLVL': '1', 07:18:36 INFO - 'TERM': 'linux', 07:18:36 INFO - 'TMOUT': '86400', 07:18:36 INFO - 'USER': 'cltbld', 07:18:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:36 INFO - '_': '/tools/buildbot/bin/python'} 07:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 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)) 07:18:37 INFO - Cleaning up... 07:18:37 INFO - Return code: 0 07:18:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', '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 07:18: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', 'jsonschema'] in /builds/slave/test/build 07:18: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 jsonschema 07:18:37 INFO - Using env: {'DISPLAY': ':0', 07:18:37 INFO - 'HOME': '/home/cltbld', 07:18:37 INFO - 'LANG': 'en_US.UTF-8', 07:18:37 INFO - 'LANGUAGE': 'en_US:en', 07:18:37 INFO - 'LOGNAME': 'cltbld', 07:18:37 INFO - 'MAIL': '/var/mail/cltbld', 07:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:37 INFO - 'MOZ_NO_REMOTE': '1', 07:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:37 INFO - 'NO_EM_RESTART': '1', 07:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:37 INFO - 'PWD': '/builds/slave/test', 07:18:37 INFO - 'SHELL': '/bin/bash', 07:18:37 INFO - 'SHLVL': '1', 07:18:37 INFO - 'TERM': 'linux', 07:18:37 INFO - 'TMOUT': '86400', 07:18:37 INFO - 'USER': 'cltbld', 07:18:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:37 INFO - '_': '/tools/buildbot/bin/python'} 07:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:18:37 INFO - Cleaning up... 07:18:37 INFO - Return code: 0 07:18:37 INFO - Running post-action listener: _resource_record_post_action 07:18:37 INFO - Running post-action listener: _start_resource_monitoring 07:18:37 INFO - Starting resource monitoring. 07:18:37 INFO - [mozharness: 2016-07-28 14:18:37.381340Z] Finished create-virtualenv step (success) 07:18:37 INFO - [mozharness: 2016-07-28 14:18:37.381812Z] Running install step. 07:18:37 INFO - Running pre-action listener: _resource_record_pre_action 07:18:37 INFO - Running main action method: install 07:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:37 INFO - Reading from file tmpfile_stdout 07:18:37 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:18:37 INFO - Reading from file tmpfile_stdout 07:18:37 INFO - Output received: 07:18:37 INFO - Usage: mozinstall [options] installer 07:18:37 INFO - Options: 07:18:37 INFO - -h, --help show this help message and exit 07:18:37 INFO - -d DEST, --destination=DEST 07:18:37 INFO - Directory to install application into. [default: 07:18:37 INFO - "/builds/slave/test"] 07:18:37 INFO - --app=APP Application being installed. [default: firefox] 07:18:37 INFO - mkdir: /builds/slave/test/build/application 07:18:37 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'] 07:18:37 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 07:18:54 INFO - Reading from file tmpfile_stdout 07:18:54 INFO - Output received: 07:18:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:54 INFO - Running post-action listener: _resource_record_post_action 07:18:54 INFO - [mozharness: 2016-07-28 14:18:54.927616Z] Finished install step (success) 07:18:54 INFO - [mozharness: 2016-07-28 14:18:54.927895Z] Running run-tests step. 07:18:54 INFO - Running pre-action listener: _resource_record_pre_action 07:18:54 INFO - Running main action method: run_tests 07:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:54 INFO - Python 2.7.3 07:18:54 INFO - Return code: 0 07:18:54 INFO - grabbing minidump binary from tooltool 07:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:54 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 0x22cb3b0>, '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 0x22cc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:54 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 07:18:54 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 07:18:54 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 07:18:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:55 INFO - Return code: 0 07:18:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:18:55 INFO - mozversion application_buildid: 20160728043102 07:18:55 INFO - mozversion application_changeset: db2c7f11d17142b488396e5e3c39a31520b36139 07:18:55 INFO - mozversion application_display_name: Nightly 07:18:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:55 INFO - mozversion application_name: Firefox 07:18:55 INFO - mozversion application_remotingname: firefox 07:18:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:18:55 INFO - mozversion application_vendor: Mozilla 07:18:55 INFO - mozversion application_version: 50.0a1 07:18:55 INFO - mozversion platform_buildid: 20160728043102 07:18:55 INFO - mozversion platform_changeset: db2c7f11d17142b488396e5e3c39a31520b36139 07:18:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:18:55 INFO - mozversion platform_version: 50.0a1 07:18:55 INFO - using testdate: 1469715535 07:18:55 INFO - actual date: 1469715535 07:18:55 INFO - starting webserver on 'localhost:45593' 07:18:55 INFO - SUITE-START | Running 2 tests 07:18:55 INFO - TEST-START | dromaeo_css 07:18:55 INFO - operating with platform_type : linux_ 07:18:55 INFO - Initialising browser for dromaeo_css test... 07:18:55 INFO - TEST-INFO | started process 16168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqVbTqV/profile http://localhost:45593/getInfo.html) 07:18:58 INFO - PROCESS | 16168 | JavaScript error: , line 0: uncaught exception: undefined 07:18:59 INFO - PROCESS | 16168 | __metrics Screen width/height:1600/1200 07:18:59 INFO - PROCESS | 16168 | colorDepth:24 07:18:59 INFO - PROCESS | 16168 | Browser inner width/height: 1024/697 07:18:59 INFO - PROCESS | 16168 | __metrics 07:19:00 INFO - PROCESS | 16168 | 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" 07:19:00 INFO - PROCESS | 16168 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:00 INFO - PROCESS | 16168 | console.error: PushService: 07:19:00 INFO - PROCESS | 16168 | stateChangeProcessEnqueue: Error transitioning state 07:19:00 INFO - PROCESS | 16168 | UnknownError 07:19:01 INFO - TEST-INFO | 16168: exit 0 07:19:01 INFO - Browser initialized. 07:19:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:01 INFO - TEST-INFO | started process 16246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqVbTqV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:13 INFO - PROCESS | 16246 | RSS: Main: 158355456 07:19:13 INFO - PROCESS | 16246 | 07:20:05 INFO - PROCESS | 16246 | 1469715605156 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] 07:22:13 INFO - PROCESS | 16246 | Cycle 1(1): loaded http://localhost:45593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45593/tests/dromaeo/cssquery-ext.html) 07:22:14 INFO - PROCESS | 16246 | RSS: Main: 260984832 07:22:14 INFO - PROCESS | 16246 | 07:25:16 INFO - PROCESS | 16246 | Cycle 1(1): loaded http://localhost:45593/tests/dromaeo/cssquery-ext.html (next: http://localhost:45593/tests/dromaeo/cssquery-jquery.html) 07:25:17 INFO - PROCESS | 16246 | RSS: Main: 251846656 07:25:17 INFO - PROCESS | 16246 | 07:28:19 INFO - PROCESS | 16246 | Cycle 1(1): loaded http://localhost:45593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45593/tests/dromaeo/cssquery-mootools.html) 07:28:19 INFO - PROCESS | 16246 | RSS: Main: 221401088 07:28:19 INFO - PROCESS | 16246 | 07:31:21 INFO - PROCESS | 16246 | Cycle 1(1): loaded http://localhost:45593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45593/tests/dromaeo/cssquery-prototype.html) 07:31:22 INFO - PROCESS | 16246 | RSS: Main: 221196288 07:31:22 INFO - PROCESS | 16246 | 07:34:25 INFO - PROCESS | 16246 | Cycle 1(1): loaded http://localhost:45593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45593/tests/dromaeo/cssquery-yui.html) 07:34:25 INFO - PROCESS | 16246 | RSS: Main: 187203584 07:34:25 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | Cycle 1(1): loaded http://localhost:45593/tests/dromaeo/cssquery-yui.html (next: http://localhost:45593/tests/dromaeo/cssquery-dojo.html) 07:37:28 INFO - PROCESS | 16246 | RSS: Main: 277970944 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | __start_tp_report 07:37:28 INFO - PROCESS | 16246 | _x_x_mozilla_page_load 07:37:28 INFO - PROCESS | 16246 | _x_x_mozilla_page_load_details 07:37:28 INFO - PROCESS | 16246 | |i|pagename|runs| 07:37:28 INFO - PROCESS | 16246 | |0;dojo.html;3028.8939887103943;3033.16587938317;3055.3278278778666;3059.8011129276583;3090.6291245050597;5198.896022079556;5271.314729085214;5339.492748188921;5409.432009638986;5411.215373770801;5294.179402192657;5325.707086110262;5364.409914909366;5379.488948549892;5414.43148469411;4838.516148385151;4861.027794441117;4885.828995985141;4902.460729319772;5019.824306149286;4966.404031516223;4979.626528010395;4984.825531106412;4990.600751939836;4990.700557966516;4768.73771942543;4798.376211092571;4806.327114204014;4867.586255168298;4910.533499317559;4734.289856521549;4763.023580166057;4778.04439112179;4829.565339119461;4894.486078961693;4682.204025315705;4739.786709598076;4740.194166991585;4740.217864052427;4752.619790416758;5233.293505376763;5235.764390602394;5262.552683021948;5287.788488460457;5294.523492885659;5542.806001789918;5689.800856969986;5734.827955161351;5742.626729262584;5823.563232757518;5781.739821708034;5798.478136967693;5844.824655260349;5848.473637372657;5852.4147585241135;5227;5404.243405923135;5416.187571864252;5416.268803711488;5420.07858664032;5859.355470898197;5891.617044892068;5898.64608123514;5962.522998160137;5986.73059712314;5648.6893220872425;5653.717314134359;5695.088785794253;5697.6296540724725;5731.914021289684;5538.224648549206;5809.099589563624;5818.709064546841;5819.621724587888;5821.243238379068;5566.832995010156;5589.860253493695;5605.859853503695;5644.238027866268;5666.121751128581;5582.804601838916;5597.720113994284;5606.6916319602;5610.438956104357;5611.2144299798065;4212.052288235122;4370.104128653618;4370.475542934804;4374.737515749001;4415.116976604628;3846.0961674006585;3905.511811023622;3946.151577410813;3957.604239576077;3992.5807790182193;5429.484199001167;5440.319960004999;5442;5451.318585176853;5491.093969495068;5570.693611851387;5808.07070868659;5809.796657116981;5812.709364531841;5861.238039054895;5285.365756109291;5385.111456609694;5434.782608695607;5453.263809385682;5485.780568777284;5021.799128034838;5025.522575355335;5026.748662566857;5029.1450453423;5069.771860266297;5869.794557190563;6019.2175017248355;6033.064874944391;6036.0644100164545;6041.486473649701;5663.178839068394;5663.85840353978;5678.914816277676;5732.971335143297;5779.855503612275;5936.525077993664;5939.2575928009;5941.881162376815;5941.9405805943115;5945.524358051259;5530;5584.525315348241;5632.211490391266;5640.153976903497;5645.830625081254;5678.290213723285;5697.857553561194;5706.885862282648;5739.741711623071;5768.653880767168;5542.196381524737;5594.9720251398485;5598.692071936082;5606.383297837317;5606.607537472501;5498.395176530498;5572.832815015556;5590.273264475592;5606.831795046155;5618.606697531133;5420.13277875538;5440.972795135999;5475.151351540518;5488.56091512686;5534.280543529316;5581.246531718329;5590.217369568182;5641.097424412074;5648.237487939075;5649.604527683023;5466.972665136808;5473.67157970523;5478.479544443271;5484.670919744828;5486.670799751868 07:37:28 INFO - PROCESS | 16246 | |1;ext.html;600.0159738029631;607.0348146447149;635.9745610175592;638.1990601794747;641.7240586547782;30529.847350763244;30867;32574.185645358877;32654.510182347254;41810.372844407284;40943.38584921221;44301.55698443014;44344.55655443444;44378.55621443785;44462;8975.640974361018;9117.179453849152;9120.224780893599;9122.042185570519;9124.041975592567;8983.775405614846;9024.819503609924;9027.95486022569;9033.638654453847;9046.909530904673;8814.559272036404;8822;8825.02924678285;8828.602712877935;8844.07137250589;9046.502442365667;9067.138621830916;9072.8639070414;9079.182873541413;9091.590878410454;8832.205101540829;8892.110788921122;8898.822023559493;8900;8903.287736981027;41615.583844161476;42055.579444205476;42084.368734469004;42094.36858447126;42160;3296.967030329714;3365.2764655598917;3416.453367461219;3432.1934345428804;3460.567429071366;31835.681643183736;32070;32097.51853722196;32172.356552869045;32775.18062048468;4328.891777705551;4340.826366945318;4341.826326946918;4350.390945267665;4442.3336499525;331292;331456;331920.34039829887;333067;333159.99999999756;56419;56588.15117773237;56600.716996414754;56669.43330566724;56907.43092569021;35961.280774384366;36812;36877.63122368795;38278.61721382806;59471.70264148738;14007.08953917992;14043.227622480657;14071.648208794657;14087.788683169761;14162.64593385153;11081.335119892832;11152.776944461228;11157.776844463227;11172;11186.776264474827;19214.726600814367;19346;19431.22275109008;19450.111437066633;19568.119434625474;6883.586984780929;7165.820854478679;7261.7095316187815;7277.3086556777025;7371.594562299125;996.785691076422;1043.3270540501335;1111.6220485034964;1183.7395772929942;1183.9052875769917;32501.18747031343;33132.503012454836;33145.50281745776;33151.171220719676;33706.49440258398;1069.6470164845582;1129.1249281806502;1131.2872890079361;1173.7945859474728;1175.0305997552055;17034.74447883283;17090.914545427193;17124.315027398763;17166.485005449857;17229.483115506555;526480;532669.0498212572;533650;534486;534813;57785;58309.12536311959;58314.70842645845;58327.125093123635;58375;1193.5643490126042;1260.3131293445094;1273.331500961984;1287.291989405823;1335.3523541082761;26166.73833261643;33215.66784332126;33680.32639347248;35208.11979700528;35232;54603.453965459834;55055;55058;55143.72428137834;55197.44802551923;443313;451324;454511;455562;455585;24787.62818557687;24870.626940596267;25411.110611128523;27835.721642783312;28285.151445456668;46673.766631166625;47154;47187.292190616485;47244.29133562931;47961;39938.800305999444;40173.59826401698;40792.3881141789;41375.37936930888;42350;38085.4287185698;40064;40485.1902961945;42112.57887421209;42266.36600450934;32150;35835.82082089573;35842.64157358497;37270.254594907405;40559;34601.82699086489;36571;37120.6287937128;37599.43600845935;37640.43539346857;27906.302342441602;28166.577501337088;28376.290592735346;28432.57351139776;28487.715122848505 07:37:28 INFO - PROCESS | 16246 | |2;jquery.html;359.7985128328138;384.6653411531966;393.0743099999501;393.1566789237086;418.2012356399278;14594.854051459495;16723.66552668946;19348.90325548374;19371.612567748638;19532.609347813035;18345.541361465937;18687.439376818682;18721.812781872177;18975.62048759024;18986.810131898677;4208.305629571132;5515.806946756864;5715.0855863061915;5722.37053924068;5723.284589426322;5180.870478238036;6327.209098862642;6462.676866156697;6531.281559028527;6531.836704082389;6243.125962365272;6273.0590411438425;6362.650054247015;6496.772612958547;6507.251666058417;6362.618242905417;6389.297177310492;6395.360463953591;6398.648074355909;6398.9360106399035;5199.194124910645;5465.535429488498;5496.422875598085;5552.639078459887;5562.527185189264;13898.096623719426;13909.165450073027;13959.930200349036;14005.929970350186;14117.505887293999;2138.903749331284;2184.311941738363;2241.5965126277265;2429.161939130997;2583.6124581312765;9346.766330841716;9878.802423951482;10677.83983240252;12266.632001039983;13943.233122178277;1892.0823400650672;1904.8476121910214;1953.4725624081561;1977.5253939054523;2019.5556977464935;83533;84746;86303;86520;87226.69159962669;10496.895031049744;10623.734406639742;10740.409277489813;10864.402457864893;11086.556537738561;15235.3905843765;15255.847441525664;15261.160636165117;15274.770878436831;15285.617859553378;7554.546727196386;7704.8844267336035;7714.4599878008;7751.570697424156;7858.921410785819;7245.456590755714;7318.817029574197;7335.669894854745;7504.212057733859;7511.661975211128;4715.882102947385;4719.646026548023;4720.433547974265;4771.9522804772205;4834.734089625034;1954.7361106250758;1997.650411178038;2023.8279746221442;2024.5444774925525;2046.0588129460318;967.8112768010311;972.644984580623;978.9510524473748;1008.5259927833906;1052.3580615824342;18304.17631206599;19447.222111115396;19448.222071116998;19488.70766938497;19619.705704414446;961.5432669481941;979.4123525884412;995.124290624246;1003.7791685829106;1035.0374152038526;10105.242106842017;10601.522931468102;10625.840612390666;10670.89329106699;10696.41169735672;367291;369923;373017;459592;471352;60687.39312606817;75202.6239868808;97743;101961;105159.47420263002;977.9070988256104;995.621663767778;1027.6454623155;1043.4261156363968;1043.9791204175874;16717.582060448585;16824.915875420545;17565;17679.558011049827;18033.909830450764;40658;43396;43731.78134109309;44872;46055.76972115118;59215;61477.38522614717;62210.37789622046;62514;64064.3593564077;7652.923470765221;8090.433669643068;8153.55155466455;8298.128696486781;8612.095729948516;9499.715008549754;11785.823212651989;11932.70168245766;12776.233425994471;13345.266010369523;5898.675572843535;7659.88510172359;11435.428228588704;11648.184627076023;11844.526218951145;6560.737570497126;8212.958935205286;10767.946160269148;11340.376279304717;11505.137114716263;11071.335719856834;11544.19190656646;11571.305721656727;11860.110491712983;11860.881391185978;8557.48655080697;8563.443376180529;8574.684835094366;8614.569271536273;8777.91222087771;9587.904120958701;11084.224104312621;11109.611163609236;11959;12116.091293152873 07:37:28 INFO - PROCESS | 16246 | |3;mootools.html;1459.5256541623976;1506.9397224111035;1626.138146782205;1732.0993083596538;1741.1816446270248;8263.752087437379;8808.075152109033;8810.163034511712;8810.38327317088;8813.559322033889;7376.373008294301;7600.429967752427;7628.656710448029;7876.763697089083;8654.437461564994;2160.5786871560013;2236.7315922089374;2256.4810093678466;2263.7396699379533;2268.5689718953345;2353.1646265575732;2369.4431808524982;2382.523495300938;2384.3562238195677;2395.5328710901294;2337.1703045418885;2343.5898717724417;2343.6367363058753;2346.3547524430746;2346.9647955280684;2245.4498647831224;2275.3515248154363;2281.8744969026698;2283.600369935263;2285.0973865323103;2302.735185453661;2314.1437668062927;2342.7657234276608;2343.27358518858;2344.2264052862515;8711.128887111237;8855.512946787923;8858.557072146432;8865.645374185026;8869.37914345996;5000;5149.562287205592;5155.381354237478;5156.510131537498;5162.612804039674;3217.147455924182;3332.6500717424565;3388.593368795736;3393.355262500117;3415.2998635279955;1025.9025392587691;1072.2708558180434;1095.370162156755;1096.4024606589348;1104.679642903557;12021.557413110395;12060.336681482515;12061.87938120625;12081.15431919766;12083.637490875288;4138.937915931264;4461;4550.271956486946;4590.127875703605;4590.816367345269;10262;10265.024822641837;10265.640702575374;10266.589336426608;10274.434906080238;5150.793968241303;5157.303763991888;5181.274621552986;5190.455002224712;5194.844154675366;4684.531546845288;4719.3628860103445;4799.448063472745;4801;4802.711837289774;3925.509311336083;3960.821763020671;4009.839606415769;4050.5544390117066;4056.350983842571;1240.34881687115;1260.332024027267;1275.7384736129072;1276.1513593460431;1294.3786982248384;973.5424350555228;1005.6832097889142;1006.6577363696379;1007.4761124215366;1011.9139873110868;5867;5935.1987481690285;6041.335453100155;6061.54538409621;6359.745610175633;958.1616085924816;980.0542476510202;991.7570195302053;1016.5577973581516;1062.6387028410377;4183.4979802423295;4203.348480985452;4226.725262857904;4244.3633454982;4291.6566674665955;10594;10881.564737410416;10994.670159895217;11052.889471105347;11063.336199827874;10787.514561844735;10846.837297440545;10851.945740271405;10874.945625271823;10877.021068103908;8012.599370031475;8194.05768336637;8203.097659257477;8220.424570280142;8228.753137405887;5679.318481782213;5765.740541675551;5770.538356931352;5843.883122337445;6023.247094113236;9775.120239178508;9847.950760246153;9927.255455840696;9930.354526955725;10060.446675432922;10142.645007424704;10457.26799124054;10490.370577765358;10499.160067194758;10501;6963.651817409008;7478.5138965967035;7620.466567340233;7722.884156737766;7956.045274567089;8643.265322447662;8717.346199035224;8754.34342424308;8755.693550725695;8763.298936085226;7677.462577619513;7749.535027898344;7796.961015194887;7825.100113487022;7834.569098699626;7599.8600209968945;7679.3856491481665;7698.2686644768655;7797.298243158143;7886.72396466121;6861.794146175623;6915.309994946399;6915.377616014583;6975.267596902455;6983.860322793617;5110.744462776772;5129.435762066244;5212.270282160424;5245.921311180412;5343.465653434625;5021.146405111067;5022;5172.9741351293005;5228.58171346299;5521.1442226454965 07:37:28 INFO - PROCESS | 16246 | |4;prototype.html;330.3278648939715;337.93072420153874;343.74906318387576;346.72262190247795;347.72703427809176;5328.653637513559;5370.422197345277;5376.596755243358;5378.354597448307;5408.188771684249;5069.645124841262;5172.896542069166;5190.429052804188;5197.636165468419;5359.356877174735;4020.276350256945;4138.813753381105;4154.356074808409;4158.8336466541305;4163.271427500191;4128.587141285878;4136.751794892301;4144.150449157931;4145.79271036447;4145.917081658365;4051.5745846686114;4099.795010249476;4112.779099286382;4145.875623731278;4150.232207041707;4124.566920473367;4130.132672138854;4131.132462182945;4139.627433530966;4153.376993450976;3661.359262129117;3684.705223582107;3701.204241088179;3704.203596226824;3715.2012317351628;5096.286519887219;5219.869503262411;5237.3453318335205;5253.290805741214;5260.842174734764;4708.599769019604;4712.575868171881;4729.196036673774;4734.621230301567;4775.5701986821;5436.700981446019;5443.265159203536;5444.713220447422;5447.237386765856;5537.501624853782;3947.5591409135745;4032.737872038308;4035.3139966205817;4040.979795101035;4041.191761647682;5685.232493613351;5701.230333904911;5707.714614269312;5718.71406429681;5766.192733017381;4101.52832424269;4138.703019824026;4150.688698347636;4166.229247589205;4176.83292668296;4067.9593204067583;4151.232022075926;4224.1129362834145;4232.91534169321;4233.745975241495;4703.294505824086;4704.694194877322;4707.317438971399;4755.169259834919;4777.495089046939;5497.532709719639;5501.394846566875;5511.862203444946;5536.944630553723;5576.525995290446;1353.5330311042674;1426.415169780385;1450.2096357485195;1452.2666053643054;1460.9561713148623;907.9546022698838;921.6221349246777;927.6289484206371;928.6703220356811;943.4197968249614;4704;4714.622830173578;4757.500462451462;4814.20565606671;4818.036392721469;4777.617790576745;5033.245013247969;5066.264217322679;5100.362454693163;5104.770285337168;4785.736784476818;4800.759962001886;4807.230843065093;4807.711537307773;4809.975950120297;2676.7686864042757;2680.4103097318557;2682.7257052899718;2702.2703869955003;2704.296882810444;5217.58259339252;5237.869053273698;5565.387807341189;5966.880662386728;5974.40255974399;5815.534757219412;5818.679972601548;5832.212651292021;5835.854103647443;5849.444302791228;5770.221020162308;5923.667174885616;6001.699915004319;6003.609765365237;6012.759489620366;5711.771529138788;5718.857028574319;5731;5764.798232061858;5797.391273916178;5643.435656434488;5657.886842263214;5676.347220069745;5678.574106942078;5730.770769169187;5634.943650563606;5832.94167058324;5887.234659494238;6011.355003798315;6012.819615411545;4041.1814683392004;4078.2659121358442;4104.4664193654635;4146.813393397244;4147.688923330702;5517.558595312285;5643.294588176478;5654.293213348332;5666.9716651416475;5792.160136780059;5062.265971434048;5488.655279456559;5499.862503437446;5547.833564993057;5556.555475562026;5409.459054094559;5495.807646732345;5547.805826796042;5557.472040156179;5566.944330556643;5286.947130528645;5447.5097241246895;5451.4276001019325;5562.860928476821;5582.33012038558;5567.47109024642;5576.749046292845;5590.944090559043;5600.131979543177;5611.4568493664565;5435.592330575302;5458.5087342139395;5462.754176062007;5465.234867118686;5544 07:37:28 INFO - PROCESS | 16246 | |5;yui.html;751.9323260906517;763.9388848892089;794.7139029949217;804.1636697834252;855.8630619100945;15086.47197348093;15549.766753498707;15644.999999999985;15646.061236325828;15665.921670391632;15342.923285383558;15479;15509.767353489678;15510.069395836257;15525.767113493279;646.6314200905485;780.3718007004359;793.714262865368;800.6837299266787;803.0724513187278;812.2283830361151;815.3599424451806;815.4577206157927;816.8407160603684;820.0159808230147;870.7387783664907;871.9346049046316;872.16708043818;872.467794645269;873.681106396164;669.3875104279579;802.8434455281223;859.1236938322907;860.518109858475;860.7374750701034;625.1622825413922;628.5945565110524;630.0108829138255;630.4483576870239;631.6273398694792;13320.933395333059;13324.267165306;13348.199108053548;13353.599392018255;13359.799603005962;14546.92726536371;14676.559703208814;14760.188189649565;14831.925840370837;14843.544112455415;12125;12299.385030748426;12370.257784532956;12547.372631368395;12997.285149316878;4527.4567051953645;4632.0967411354795;4633.096546173498;4800.783964721596;4817.108834865526;79189;79235.96065247167;79610.20389796086;79844.60077699632;82044.58977705133;11532.361115945007;11552.882245447616;11615.535378584762;11738.70653233659;11915.761684766256;22249.55500889973;22449.32652020442;22499.66250506244;22529.662055069188;22721.772782272295;8369.49783013021;8397.874031889405;8440.831183376298;8474.27968622674;8809.955950220336;4532.093581283756;4575.966436919362;4591.058832939239;4645.628349732014;4751.762411879392;3442.277121804449;3540.566070741354;3542.220711443478;3558.288342331544;3571.928561428757;609.7164818359485;610.4109534299422;622.9377062293735;626.8683576448997;627.7143899525705;690.5925503952692;697.7313734212365;742.6954948471209;749.628933677833;786.9881951770728;9615.807683846424;9745.366551174151;9811.649600919049;10002.799384135478;10054.798904022025;612.6967151260154;696.6830092307988;725.5247812682701;749.568997826252;757.1255200243727;4671.27595222741;4732.408448943882;4740.905181896343;4793.298379075378;4889.877753056131;97176.02823971811;113967;117058.41470792762;117625;118809;56199.71900140555;80628;95714.52142739242;96327;96459;84116.15883841206;84241;84793.57603211944;84850.5757471221;88609;8868.334874884538;8959.148880856308;9245;9329.86005209936;9343.205827504466;51679.48320516747;52955.96918292756;53211.73394133159;53602.463975359744;54068.45931540792;57584;61834.38165618466;63036.684816575624;66289.33710662831;73020.63489682517;13120.737585248433;13437.462501499831;13462.86537134616;13501.324933753076;14296.213708246147;15907.204639768197;15979.041257524586;16065;16531.256093475582;16676.24956876919;12632.936835315764;12764.872351276368;13172.143810652276;15316.617084572976;15805.52583422499;14725.705485890436;14876.702465950837;15385.769213461583;15494.922525387301;15759.68480630404;13425.127366721132;13546.86453135456;13708.52020179289;13968.231747253592;14379.928100359431;10709.839352409565;11216.551337946717;11325.546978120783;11332.036776874058;11428.371439570903;11814.881851181723;12614.306213158365;12709.745805084032;12814.365907771362;12872.292023938398 07:37:28 INFO - PROCESS | 16246 | __end_tp_report 07:37:28 INFO - PROCESS | 16246 | __start_cc_report 07:37:28 INFO - PROCESS | 16246 | _x_x_mozilla_cycle_collect,941 07:37:28 INFO - PROCESS | 16246 | __end_cc_report 07:37:28 INFO - PROCESS | 16246 | __startTimestamp1469716648637__endTimestamp 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | ------- Summary: start ------- 07:37:28 INFO - PROCESS | 16246 | Number of tests: 6 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | [#0] dojo.html Cycles:165 Average:5314.80 Median:5488.56 stddev:613.41 (11.2%) stddev-sans-first:588.50 07:37:28 INFO - PROCESS | 16246 | Values: 3028.9 3033.2 3055.3 3059.8 3090.6 5198.9 5271.3 5339.5 5409.4 5411.2 5294.2 5325.7 5364.4 5379.5 5414.4 4838.5 4861.0 4885.8 4902.5 5019.8 4966.4 4979.6 4984.8 4990.6 4990.7 4768.7 4798.4 4806.3 4867.6 4910.5 4734.3 4763.0 4778.0 4829.6 4894.5 4682.2 4739.8 4740.2 4740.2 4752.6 5233.3 5235.8 5262.6 5287.8 5294.5 5542.8 5689.8 5734.8 5742.6 5823.6 5781.7 5798.5 5844.8 5848.5 5852.4 5227.0 5404.2 5416.2 5416.3 5420.1 5859.4 5891.6 5898.6 5962.5 5986.7 5648.7 5653.7 5695.1 5697.6 5731.9 5538.2 5809.1 5818.7 5819.6 5821.2 5566.8 5589.9 5605.9 5644.2 5666.1 5582.8 5597.7 5606.7 5610.4 5611.2 4212.1 4370.1 4370.5 4374.7 4415.1 3846.1 3905.5 3946.2 3957.6 3992.6 5429.5 5440.3 5442.0 5451.3 5491.1 5570.7 5808.1 5809.8 5812.7 5861.2 5285.4 5385.1 5434.8 5453.3 5485.8 5021.8 5025.5 5026.7 5029.1 5069.8 5869.8 6019.2 6033.1 6036.1 6041.5 5663.2 5663.9 5678.9 5733.0 5779.9 5936.5 5939.3 5941.9 5941.9 5945.5 5530.0 5584.5 5632.2 5640.2 5645.8 5678.3 5697.9 5706.9 5739.7 5768.7 5542.2 5595.0 5598.7 5606.4 5606.6 5498.4 5572.8 5590.3 5606.8 5618.6 5420.1 5441.0 5475.2 5488.6 5534.3 5581.2 5590.2 5641.1 5648.2 5649.6 5467.0 5473.7 5478.5 5484.7 5486.7 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | [#1] ext.html Cycles:180 Average:59096.13 Median:40522.10 stddev:118551.81 (292.6%) stddev-sans-first:118803.02 07:37:28 INFO - PROCESS | 16246 | Values: 600.0 607.0 636.0 638.2 641.7 30529.8 30867.0 32574.2 32654.5 41810.4 40943.4 44301.6 44344.6 44378.6 44462.0 8975.6 9117.2 9120.2 9122.0 9124.0 8983.8 9024.8 9028.0 9033.6 9046.9 8814.6 8822.0 8825.0 8828.6 8844.1 9046.5 9067.1 9072.9 9079.2 9091.6 8832.2 8892.1 8898.8 8900.0 8903.3 41615.6 42055.6 42084.4 42094.4 42160.0 3297.0 3365.3 3416.5 3432.2 3460.6 31835.7 32070.0 32097.5 32172.4 32775.2 4328.9 4340.8 4341.8 4350.4 4442.3 331292.0 331456.0 331920.3 333067.0 333160.0 56419.0 56588.2 56600.7 56669.4 56907.4 35961.3 36812.0 36877.6 38278.6 59471.7 14007.1 14043.2 14071.6 14087.8 14162.6 11081.3 11152.8 11157.8 11172.0 11186.8 19214.7 19346.0 19431.2 19450.1 19568.1 6883.6 7165.8 7261.7 7277.3 7371.6 996.8 1043.3 1111.6 1183.7 1183.9 32501.2 33132.5 33145.5 33151.2 33706.5 1069.6 1129.1 1131.3 1173.8 1175.0 17034.7 17090.9 17124.3 17166.5 17229.5 526480.0 532669.0 533650.0 534486.0 534813.0 57785.0 58309.1 58314.7 58327.1 58375.0 1193.6 1260.3 1273.3 1287.3 1335.4 26166.7 33215.7 33680.3 35208.1 35232.0 54603.5 55055.0 55058.0 55143.7 55197.4 443313.0 451324.0 454511.0 455562.0 455585.0 24787.6 24870.6 25411.1 27835.7 28285.2 46673.8 47154.0 47187.3 47244.3 47961.0 39938.8 40173.6 40792.4 41375.4 42350.0 38085.4 40064.0 40485.2 42112.6 42266.4 32150.0 35835.8 35842.6 37270.3 40559.0 34601.8 36571.0 37120.6 37599.4 37640.4 27906.3 28166.6 28376.3 28432.6 28487.7 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | [#2] jquery.html Cycles:180 Average:26467.90 Median:388.87 stddev:68504.34 (17616.3%) stddev-sans-first:68668.46 07:37:28 INFO - PROCESS | 16246 | Values: 359.8 384.7 393.1 393.2 418.2 14594.9 16723.7 19348.9 19371.6 19532.6 18345.5 18687.4 18721.8 18975.6 18986.8 4208.3 5515.8 5715.1 5722.4 5723.3 5180.9 6327.2 6462.7 6531.3 6531.8 6243.1 6273.1 6362.7 6496.8 6507.3 6362.6 6389.3 6395.4 6398.6 6398.9 5199.2 5465.5 5496.4 5552.6 5562.5 13898.1 13909.2 13959.9 14005.9 14117.5 2138.9 2184.3 2241.6 2429.2 2583.6 9346.8 9878.8 10677.8 12266.6 13943.2 1892.1 1904.8 1953.5 1977.5 2019.6 83533.0 84746.0 86303.0 86520.0 87226.7 10496.9 10623.7 10740.4 10864.4 11086.6 15235.4 15255.8 15261.2 15274.8 15285.6 7554.5 7704.9 7714.5 7751.6 7858.9 7245.5 7318.8 7335.7 7504.2 7511.7 4715.9 4719.6 4720.4 4772.0 4834.7 1954.7 1997.7 2023.8 2024.5 2046.1 967.8 972.6 979.0 1008.5 1052.4 18304.2 19447.2 19448.2 19488.7 19619.7 961.5 979.4 995.1 1003.8 1035.0 10105.2 10601.5 10625.8 10670.9 10696.4 367291.0 369923.0 373017.0 459592.0 471352.0 60687.4 75202.6 97743.0 101961.0 105159.5 977.9 995.6 1027.6 1043.4 1044.0 16717.6 16824.9 17565.0 17679.6 18033.9 40658.0 43396.0 43731.8 44872.0 46055.8 59215.0 61477.4 62210.4 62514.0 64064.4 7652.9 8090.4 8153.6 8298.1 8612.1 9499.7 11785.8 11932.7 12776.2 13345.3 5898.7 7659.9 11435.4 11648.2 11844.5 6560.7 8213.0 10767.9 11340.4 11505.1 11071.3 11544.2 11571.3 11860.1 11860.9 8557.5 8563.4 8574.7 8614.6 8777.9 9587.9 11084.2 11109.6 11959.0 12116.1 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | [#3] mootools.html Cycles:180 Average:5765.85 Median:4590.47 stddev:3261.80 (71.1%) stddev-sans-first:3254.89 07:37:28 INFO - PROCESS | 16246 | Values: 1459.5 1506.9 1626.1 1732.1 1741.2 8263.8 8808.1 8810.2 8810.4 8813.6 7376.4 7600.4 7628.7 7876.8 8654.4 2160.6 2236.7 2256.5 2263.7 2268.6 2353.2 2369.4 2382.5 2384.4 2395.5 2337.2 2343.6 2343.6 2346.4 2347.0 2245.4 2275.4 2281.9 2283.6 2285.1 2302.7 2314.1 2342.8 2343.3 2344.2 8711.1 8855.5 8858.6 8865.6 8869.4 5000.0 5149.6 5155.4 5156.5 5162.6 3217.1 3332.7 3388.6 3393.4 3415.3 1025.9 1072.3 1095.4 1096.4 1104.7 12021.6 12060.3 12061.9 12081.2 12083.6 4138.9 4461.0 4550.3 4590.1 4590.8 10262.0 10265.0 10265.6 10266.6 10274.4 5150.8 5157.3 5181.3 5190.5 5194.8 4684.5 4719.4 4799.4 4801.0 4802.7 3925.5 3960.8 4009.8 4050.6 4056.4 1240.3 1260.3 1275.7 1276.2 1294.4 973.5 1005.7 1006.7 1007.5 1011.9 5867.0 5935.2 6041.3 6061.5 6359.7 958.2 980.1 991.8 1016.6 1062.6 4183.5 4203.3 4226.7 4244.4 4291.7 10594.0 10881.6 10994.7 11052.9 11063.3 10787.5 10846.8 10851.9 10874.9 10877.0 8012.6 8194.1 8203.1 8220.4 8228.8 5679.3 5765.7 5770.5 5843.9 6023.2 9775.1 9848.0 9927.3 9930.4 10060.4 10142.6 10457.3 10490.4 10499.2 10501.0 6963.7 7478.5 7620.5 7722.9 7956.0 8643.3 8717.3 8754.3 8755.7 8763.3 7677.5 7749.5 7797.0 7825.1 7834.6 7599.9 7679.4 7698.3 7797.3 7886.7 6861.8 6915.3 6915.4 6975.3 6983.9 5110.7 5129.4 5212.3 5245.9 5343.5 5021.1 5022.0 5173.0 5228.6 5521.1 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | [#4] prototype.html Cycles:180 Average:4621.32 Median:5207.61 stddev:1360.16 (26.1%) stddev-sans-first:1325.30 07:37:28 INFO - PROCESS | 16246 | Values: 330.3 337.9 343.7 346.7 347.7 5328.7 5370.4 5376.6 5378.4 5408.2 5069.6 5172.9 5190.4 5197.6 5359.4 4020.3 4138.8 4154.4 4158.8 4163.3 4128.6 4136.8 4144.2 4145.8 4145.9 4051.6 4099.8 4112.8 4145.9 4150.2 4124.6 4130.1 4131.1 4139.6 4153.4 3661.4 3684.7 3701.2 3704.2 3715.2 5096.3 5219.9 5237.3 5253.3 5260.8 4708.6 4712.6 4729.2 4734.6 4775.6 5436.7 5443.3 5444.7 5447.2 5537.5 3947.6 4032.7 4035.3 4041.0 4041.2 5685.2 5701.2 5707.7 5718.7 5766.2 4101.5 4138.7 4150.7 4166.2 4176.8 4068.0 4151.2 4224.1 4232.9 4233.7 4703.3 4704.7 4707.3 4755.2 4777.5 5497.5 5501.4 5511.9 5536.9 5576.5 1353.5 1426.4 1450.2 1452.3 1461.0 908.0 921.6 927.6 928.7 943.4 4704.0 4714.6 4757.5 4814.2 4818.0 4777.6 5033.2 5066.3 5100.4 5104.8 4785.7 4800.8 4807.2 4807.7 4810.0 2676.8 2680.4 2682.7 2702.3 2704.3 5217.6 5237.9 5565.4 5966.9 5974.4 5815.5 5818.7 5832.2 5835.9 5849.4 5770.2 5923.7 6001.7 6003.6 6012.8 5711.8 5718.9 5731.0 5764.8 5797.4 5643.4 5657.9 5676.3 5678.6 5730.8 5634.9 5832.9 5887.2 6011.4 6012.8 4041.2 4078.3 4104.5 4146.8 4147.7 5517.6 5643.3 5654.3 5667.0 5792.2 5062.3 5488.7 5499.9 5547.8 5556.6 5409.5 5495.8 5547.8 5557.5 5566.9 5286.9 5447.5 5451.4 5562.9 5582.3 5567.5 5576.7 5590.9 5600.1 5611.5 5435.6 5458.5 5462.8 5465.2 5544.0 07:37:28 INFO - PROCESS | 16246 | 07:37:28 INFO - PROCESS | 16246 | [#5] yui.html Cycles:180 Average:20412.40 Median:4746.33 stddev:28621.98 (603.0%) stddev-sans-first:28664.20 07:37:28 INFO - PROCESS | 16246 | Values: 751.9 763.9 794.7 804.2 855.9 15086.5 15549.8 15645.0 15646.1 15665.9 15342.9 15479.0 15509.8 15510.1 15525.8 646.6 780.4 793.7 800.7 803.1 812.2 815.4 815.5 816.8 820.0 870.7 871.9 872.2 872.5 873.7 669.4 802.8 859.1 860.5 860.7 625.2 628.6 630.0 630.4 631.6 13320.9 13324.3 13348.2 13353.6 13359.8 14546.9 14676.6 14760.2 14831.9 14843.5 12125.0 12299.4 12370.3 12547.4 12997.3 4527.5 4632.1 4633.1 4800.8 4817.1 79189.0 79236.0 79610.2 79844.6 82044.6 11532.4 11552.9 11615.5 11738.7 11915.8 22249.6 22449.3 22499.7 22529.7 22721.8 8369.5 8397.9 8440.8 8474.3 8810.0 4532.1 4576.0 4591.1 4645.6 4751.8 3442.3 3540.6 3542.2 3558.3 3571.9 609.7 610.4 622.9 626.9 627.7 690.6 697.7 742.7 749.6 787.0 9615.8 9745.4 9811.6 10002.8 10054.8 612.7 696.7 725.5 749.6 757.1 4671.3 4732.4 4740.9 4793.3 4889.9 97176.0 113967.0 117058.4 117625.0 118809.0 56199.7 80628.0 95714.5 96327.0 96459.0 84116.2 84241.0 84793.6 84850.6 88609.0 8868.3 8959.1 9245.0 9329.9 9343.2 51679.5 52956.0 53211.7 53602.5 54068.5 57584.0 61834.4 63036.7 66289.3 73020.6 13120.7 13437.5 13462.9 13501.3 14296.2 15907.2 15979.0 16065.0 16531.3 16676.2 12632.9 12764.9 13172.1 15316.6 15805.5 14725.7 14876.7 15385.8 15494.9 15759.7 13425.1 13546.9 13708.5 13968.2 14379.9 10709.8 11216.6 11325.5 11332.0 11428.4 11814.9 12614.3 12709.7 12814.4 12872.3 07:37:28 INFO - PROCESS | 16246 | -------- Summary: end -------- 07:37:28 INFO - PROCESS | 16246 | 07:37:29 INFO - TEST-INFO | 16246: exit 0 07:37:29 INFO - TEST-OK | dromaeo_css | took 1114254ms 07:37:29 INFO - TEST-START | kraken 07:37:29 INFO - operating with platform_type : linux_ 07:37:29 INFO - Initialising browser for kraken test... 07:37:29 INFO - TEST-INFO | started process 16470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTyiEjB/profile http://localhost:45593/getInfo.html) 07:37:32 INFO - PROCESS | 16470 | JavaScript error: , line 0: uncaught exception: undefined 07:37:33 INFO - PROCESS | 16470 | __metrics Screen width/height:1600/1200 07:37:33 INFO - PROCESS | 16470 | colorDepth:24 07:37:33 INFO - PROCESS | 16470 | Browser inner width/height: 1024/697 07:37:33 INFO - PROCESS | 16470 | __metrics 07:37:34 INFO - PROCESS | 16470 | 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" 07:37:34 INFO - PROCESS | 16470 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:35 INFO - PROCESS | 16470 | console.error: PushService: 07:37:35 INFO - PROCESS | 16470 | stateChangeProcessEnqueue: Error transitioning state 07:37:35 INFO - PROCESS | 16470 | UnknownError 07:37:35 INFO - TEST-INFO | 16470: exit 0 07:37:35 INFO - Browser initialized. 07:37:35 INFO - Running cycle 1/1 for kraken test... 07:37:35 INFO - TEST-INFO | started process 16553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTyiEjB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:47 INFO - PROCESS | 16553 | RSS: Main: 157863936 07:37:47 INFO - PROCESS | 16553 | 07:37:49 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45593/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:50 INFO - PROCESS | 16553 | RSS: Main: 214388736 07:37:50 INFO - PROCESS | 16553 | 07:37:53 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45593/tests/kraken/driver.html?testName=audio-dft) 07:37:53 INFO - PROCESS | 16553 | RSS: Main: 192909312 07:37:53 INFO - PROCESS | 16553 | 07:37:57 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45593/tests/kraken/driver.html?testName=audio-fft) 07:37:57 INFO - PROCESS | 16553 | RSS: Main: 271945728 07:37:57 INFO - PROCESS | 16553 | 07:37:59 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45593/tests/kraken/driver.html?testName=audio-oscillator) 07:38:00 INFO - PROCESS | 16553 | RSS: Main: 181022720 07:38:00 INFO - PROCESS | 16553 | 07:38:02 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:03 INFO - PROCESS | 16553 | RSS: Main: 185253888 07:38:03 INFO - PROCESS | 16553 | 07:38:06 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45593/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:06 INFO - PROCESS | 16553 | RSS: Main: 220459008 07:38:06 INFO - PROCESS | 16553 | 07:38:10 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45593/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:10 INFO - PROCESS | 16553 | RSS: Main: 221331456 07:38:10 INFO - PROCESS | 16553 | 07:38:13 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45593/tests/kraken/driver.html?testName=json-parse-financial) 07:38:14 INFO - PROCESS | 16553 | RSS: Main: 220233728 07:38:14 INFO - PROCESS | 16553 | 07:38:15 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:16 INFO - PROCESS | 16553 | RSS: Main: 185585664 07:38:16 INFO - PROCESS | 16553 | 07:38:17 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:18 INFO - PROCESS | 16553 | RSS: Main: 191156224 07:38:18 INFO - PROCESS | 16553 | 07:38:20 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:21 INFO - PROCESS | 16553 | RSS: Main: 195112960 07:38:21 INFO - PROCESS | 16553 | 07:38:23 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:38:24 INFO - PROCESS | 16553 | RSS: Main: 188821504 07:38:24 INFO - PROCESS | 16553 | 07:38:27 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:38:27 INFO - PROCESS | 16553 | RSS: Main: 193339392 07:38:27 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | Cycle 1(1): loaded http://localhost:45593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45593/tests/kraken/driver.html?testName=ai-astar) 07:38:29 INFO - PROCESS | 16553 | RSS: Main: 245280768 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | __start_tp_report 07:38:29 INFO - PROCESS | 16553 | _x_x_mozilla_page_load 07:38:29 INFO - PROCESS | 16553 | _x_x_mozilla_page_load_details 07:38:29 INFO - PROCESS | 16553 | |i|pagename|runs| 07:38:29 INFO - PROCESS | 16553 | |0;ai-astar;105;114;112;111;111;112;111;111;110;111 07:38:29 INFO - PROCESS | 16553 | |1;audio-beat-detection;146;115;118;170;119;121;142;118;159;121 07:38:29 INFO - PROCESS | 16553 | |2;audio-dft;161;159;160;162;161;159;161;161;160;160 07:38:29 INFO - PROCESS | 16553 | |3;audio-fft;75;74;74;106;75;75;74;74;104;75 07:38:29 INFO - PROCESS | 16553 | |4;audio-oscillator;85;83;123;85;85;84;119;84;84;128 07:38:29 INFO - PROCESS | 16553 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;117;117;116 07:38:29 INFO - PROCESS | 16553 | |6;imaging-darkroom;145;146;146;145;145;146;145;146;145;145 07:38:29 INFO - PROCESS | 16553 | |7;imaging-desaturate;94;95;94;94;95;94;96;95;95;94 07:38:29 INFO - PROCESS | 16553 | |8;json-parse-financial;54;54;54;53;54;53;54;54;53;54 07:38:29 INFO - PROCESS | 16553 | |9;json-stringify-tinderbox;62;63;62;63;63;63;63;64;62;62 07:38:29 INFO - PROCESS | 16553 | |10;stanford-crypto-aes;82;76;78;81;75;81;76;75;76;79 07:38:29 INFO - PROCESS | 16553 | |11;stanford-crypto-ccm;126;120;127;129;124;120;119;119;201;128 07:38:29 INFO - PROCESS | 16553 | |12;stanford-crypto-pbkdf2;158;161;155;157;157;157;157;158;162;158 07:38:29 INFO - PROCESS | 16553 | |13;stanford-crypto-sha256-iterative;62;65;64;63;63;64;62;62;63;62 07:38:29 INFO - PROCESS | 16553 | __end_tp_report 07:38:29 INFO - PROCESS | 16553 | __start_cc_report 07:38:29 INFO - PROCESS | 16553 | _x_x_mozilla_cycle_collect,1652 07:38:29 INFO - PROCESS | 16553 | __end_cc_report 07:38:29 INFO - PROCESS | 16553 | __startTimestamp1469716709569__endTimestamp 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | ------- Summary: start ------- 07:38:29 INFO - PROCESS | 16553 | Number of tests: 14 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.30 (2.1%) stddev-sans-first:1.13 07:38:29 INFO - PROCESS | 16553 | Values: 105.0 114.0 112.0 111.0 111.0 112.0 111.0 111.0 110.0 111.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:131.50 stddev:19.87 (15.1%) stddev-sans-first:20.50 07:38:29 INFO - PROCESS | 16553 | Values: 146.0 115.0 118.0 170.0 119.0 121.0 142.0 118.0 159.0 121.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 07:38:29 INFO - PROCESS | 16553 | Values: 161.0 159.0 160.0 162.0 161.0 159.0 161.0 161.0 160.0 160.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.50 stddev:12.88 (17.3%) stddev-sans-first:13.50 07:38:29 INFO - PROCESS | 16553 | Values: 75.0 74.0 74.0 106.0 75.0 75.0 74.0 74.0 104.0 75.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:84.00 stddev:18.99 (22.6%) stddev-sans-first:19.72 07:38:29 INFO - PROCESS | 16553 | Values: 85.0 83.0 123.0 85.0 85.0 84.0 119.0 84.0 84.0 128.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:38:29 INFO - PROCESS | 16553 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:38:29 INFO - PROCESS | 16553 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:38:29 INFO - PROCESS | 16553 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 96.0 95.0 95.0 94.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:38:29 INFO - PROCESS | 16553 | Values: 54.0 54.0 54.0 53.0 54.0 53.0 54.0 54.0 53.0 54.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 07:38:29 INFO - PROCESS | 16553 | Values: 62.0 63.0 62.0 63.0 63.0 63.0 63.0 64.0 62.0 62.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:2.69 (3.4%) stddev-sans-first:2.40 07:38:29 INFO - PROCESS | 16553 | Values: 82.0 76.0 78.0 81.0 75.0 81.0 76.0 75.0 76.0 79.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:126.50 stddev:24.79 (19.6%) stddev-sans-first:26.22 07:38:29 INFO - PROCESS | 16553 | Values: 126.0 120.0 127.0 129.0 124.0 120.0 119.0 119.0 201.0 128.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:2.05 (1.3%) stddev-sans-first:2.18 07:38:29 INFO - PROCESS | 16553 | Values: 158.0 161.0 155.0 157.0 157.0 157.0 157.0 158.0 162.0 158.0 07:38:29 INFO - PROCESS | 16553 | 07:38:29 INFO - PROCESS | 16553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:1.05 07:38:29 INFO - PROCESS | 16553 | Values: 62.0 65.0 64.0 63.0 63.0 64.0 62.0 62.0 63.0 62.0 07:38:29 INFO - PROCESS | 16553 | -------- Summary: end -------- 07:38:29 INFO - PROCESS | 16553 | 07:38:30 INFO - TEST-INFO | 16553: exit 0 07:38:30 INFO - TEST-OK | kraken | took 61150ms 07:38:30 INFO - SUITE-END | took 1175s 07:38:30 INFO - Completed test suite (00:19:35) 07:38:30 INFO - javascript benchmark 07:38:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.8939887103943, 3033.16587938317, 3055.3278278778666, 3059.8011129276583, 3090.6291245050597, 5198.896022079556, 5271.314729085214, 5339.492748188921, 5409.432009638986, 5411.215373770801, 5294.179402192657, 5325.707086110262, 5364.409914909366, 5379.488948549892, 5414.43148469411, 4838.516148385151, 4861.027794441117, 4885.828995985141, 4902.460729319772, 5019.824306149286, 4966.404031516223, 4979.626528010395, 4984.825531106412, 4990.600751939836, 4990.700557966516, 4768.73771942543, 4798.376211092571, 4806.327114204014, 4867.586255168298, 4910.533499317559, 4734.289856521549, 4763.023580166057, 4778.04439112179, 4829.565339119461, 4894.486078961693, 4682.204025315705, 4739.786709598076, 4740.194166991585, 4740.217864052427, 4752.619790416758, 5233.293505376763, 5235.764390602394, 5262.552683021948, 5287.788488460457, 5294.523492885659, 5542.806001789918, 5689.800856969986, 5734.827955161351, 5742.626729262584, 5823.563232757518, 5781.739821708034, 5798.478136967693, 5844.824655260349, 5848.473637372657, 5852.4147585241135, 5227.0, 5404.243405923135, 5416.187571864252, 5416.268803711488, 5420.07858664032, 5859.355470898197, 5891.617044892068, 5898.64608123514, 5962.522998160137, 5986.73059712314, 5648.6893220872425, 5653.717314134359, 5695.088785794253, 5697.6296540724725, 5731.914021289684, 5538.224648549206, 5809.099589563624, 5818.709064546841, 5819.621724587888, 5821.243238379068, 5566.832995010156, 5589.860253493695, 5605.859853503695, 5644.238027866268, 5666.121751128581, 5582.804601838916, 5597.720113994284, 5606.6916319602, 5610.438956104357, 5611.2144299798065, 4212.052288235122, 4370.104128653618, 4370.475542934804, 4374.737515749001, 4415.116976604628, 3846.0961674006585, 3905.511811023622, 3946.151577410813, 3957.604239576077, 3992.5807790182193, 5429.484199001167, 5440.319960004999, 5442.0, 5451.318585176853, 5491.093969495068, 5570.693611851387, 5808.07070868659, 5809.796657116981, 5812.709364531841, 5861.238039054895, 5285.365756109291, 5385.111456609694, 5434.782608695607, 5453.263809385682, 5485.780568777284, 5021.799128034838, 5025.522575355335, 5026.748662566857, 5029.1450453423, 5069.771860266297, 5869.794557190563, 6019.2175017248355, 6033.064874944391, 6036.0644100164545, 6041.486473649701, 5663.178839068394, 5663.85840353978, 5678.914816277676, 5732.971335143297, 5779.855503612275, 5936.525077993664, 5939.2575928009, 5941.881162376815, 5941.9405805943115, 5945.524358051259, 5530.0, 5584.525315348241, 5632.211490391266, 5640.153976903497, 5645.830625081254, 5678.290213723285, 5697.857553561194, 5706.885862282648, 5739.741711623071, 5768.653880767168, 5542.196381524737, 5594.9720251398485, 5598.692071936082, 5606.383297837317, 5606.607537472501, 5498.395176530498, 5572.832815015556, 5590.273264475592, 5606.831795046155, 5618.606697531133, 5420.13277875538, 5440.972795135999, 5475.151351540518, 5488.56091512686, 5534.280543529316, 5581.246531718329, 5590.217369568182, 5641.097424412074, 5648.237487939075, 5649.604527683023, 5466.972665136808, 5473.67157970523, 5478.479544443271, 5484.670919744828, 5486.670799751868], "value": 5272.611595898243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.0159738029631, 607.0348146447149, 635.9745610175592, 638.1990601794747, 641.7240586547782, 30529.847350763244, 30867.0, 32574.185645358877, 32654.510182347254, 41810.372844407284, 40943.38584921221, 44301.55698443014, 44344.55655443444, 44378.55621443785, 44462.0, 8975.640974361018, 9117.179453849152, 9120.224780893599, 9122.042185570519, 9124.041975592567, 8983.775405614846, 9024.819503609924, 9027.95486022569, 9033.638654453847, 9046.909530904673, 8814.559272036404, 8822.0, 8825.02924678285, 8828.602712877935, 8844.07137250589, 9046.502442365667, 9067.138621830916, 9072.8639070414, 9079.182873541413, 9091.590878410454, 8832.205101540829, 8892.110788921122, 8898.822023559493, 8900.0, 8903.287736981027, 41615.583844161476, 42055.579444205476, 42084.368734469004, 42094.36858447126, 42160.0, 3296.967030329714, 3365.2764655598917, 3416.453367461219, 3432.1934345428804, 3460.567429071366, 31835.681643183736, 32070.0, 32097.51853722196, 32172.356552869045, 32775.18062048468, 4328.891777705551, 4340.826366945318, 4341.826326946918, 4350.390945267665, 4442.3336499525, 331292.0, 331456.0, 331920.34039829887, 333067.0, 333159.99999999756, 56419.0, 56588.15117773237, 56600.716996414754, 56669.43330566724, 56907.43092569021, 35961.280774384366, 36812.0, 36877.63122368795, 38278.61721382806, 59471.70264148738, 14007.08953917992, 14043.227622480657, 14071.648208794657, 14087.788683169761, 14162.64593385153, 11081.335119892832, 11152.776944461228, 11157.776844463227, 11172.0, 11186.776264474827, 19214.726600814367, 19346.0, 19431.22275109008, 19450.111437066633, 19568.119434625474, 6883.586984780929, 7165.820854478679, 7261.7095316187815, 7277.3086556777025, 7371.594562299125, 996.785691076422, 1043.3270540501335, 1111.6220485034964, 1183.7395772929942, 1183.9052875769917, 32501.18747031343, 33132.503012454836, 33145.50281745776, 33151.171220719676, 33706.49440258398, 1069.6470164845582, 1129.1249281806502, 1131.2872890079361, 1173.7945859474728, 1175.0305997552055, 17034.74447883283, 17090.914545427193, 17124.315027398763, 17166.485005449857, 17229.483115506555, 526480.0, 532669.0498212572, 533650.0, 534486.0, 534813.0, 57785.0, 58309.12536311959, 58314.70842645845, 58327.125093123635, 58375.0, 1193.5643490126042, 1260.3131293445094, 1273.331500961984, 1287.291989405823, 1335.3523541082761, 26166.73833261643, 33215.66784332126, 33680.32639347248, 35208.11979700528, 35232.0, 54603.453965459834, 55055.0, 55058.0, 55143.72428137834, 55197.44802551923, 443313.0, 451324.0, 454511.0, 455562.0, 455585.0, 24787.62818557687, 24870.626940596267, 25411.110611128523, 27835.721642783312, 28285.151445456668, 46673.766631166625, 47154.0, 47187.292190616485, 47244.29133562931, 47961.0, 39938.800305999444, 40173.59826401698, 40792.3881141789, 41375.37936930888, 42350.0, 38085.4287185698, 40064.0, 40485.1902961945, 42112.57887421209, 42266.36600450934, 32150.0, 35835.82082089573, 35842.64157358497, 37270.254594907405, 40559.0, 34601.82699086489, 36571.0, 37120.6287937128, 37599.43600845935, 37640.43539346857, 27906.302342441602, 28166.577501337088, 28376.290592735346, 28432.57351139776, 28487.715122848505], "value": 19589.946902496198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.7985128328138, 384.6653411531966, 393.0743099999501, 393.1566789237086, 418.2012356399278, 14594.854051459495, 16723.66552668946, 19348.90325548374, 19371.612567748638, 19532.609347813035, 18345.541361465937, 18687.439376818682, 18721.812781872177, 18975.62048759024, 18986.810131898677, 4208.305629571132, 5515.806946756864, 5715.0855863061915, 5722.37053924068, 5723.284589426322, 5180.870478238036, 6327.209098862642, 6462.676866156697, 6531.281559028527, 6531.836704082389, 6243.125962365272, 6273.0590411438425, 6362.650054247015, 6496.772612958547, 6507.251666058417, 6362.618242905417, 6389.297177310492, 6395.360463953591, 6398.648074355909, 6398.9360106399035, 5199.194124910645, 5465.535429488498, 5496.422875598085, 5552.639078459887, 5562.527185189264, 13898.096623719426, 13909.165450073027, 13959.930200349036, 14005.929970350186, 14117.505887293999, 2138.903749331284, 2184.311941738363, 2241.5965126277265, 2429.161939130997, 2583.6124581312765, 9346.766330841716, 9878.802423951482, 10677.83983240252, 12266.632001039983, 13943.233122178277, 1892.0823400650672, 1904.8476121910214, 1953.4725624081561, 1977.5253939054523, 2019.5556977464935, 83533.0, 84746.0, 86303.0, 86520.0, 87226.69159962669, 10496.895031049744, 10623.734406639742, 10740.409277489813, 10864.402457864893, 11086.556537738561, 15235.3905843765, 15255.847441525664, 15261.160636165117, 15274.770878436831, 15285.617859553378, 7554.546727196386, 7704.8844267336035, 7714.4599878008, 7751.570697424156, 7858.921410785819, 7245.456590755714, 7318.817029574197, 7335.669894854745, 7504.212057733859, 7511.661975211128, 4715.882102947385, 4719.646026548023, 4720.433547974265, 4771.9522804772205, 4834.734089625034, 1954.7361106250758, 1997.650411178038, 2023.8279746221442, 2024.5444774925525, 2046.0588129460318, 967.8112768010311, 972.644984580623, 978.9510524473748, 1008.5259927833906, 1052.3580615824342, 18304.17631206599, 19447.222111115396, 19448.222071116998, 19488.70766938497, 19619.705704414446, 961.5432669481941, 979.4123525884412, 995.124290624246, 1003.7791685829106, 1035.0374152038526, 10105.242106842017, 10601.522931468102, 10625.840612390666, 10670.89329106699, 10696.41169735672, 367291.0, 369923.0, 373017.0, 459592.0, 471352.0, 60687.39312606817, 75202.6239868808, 97743.0, 101961.0, 105159.47420263002, 977.9070988256104, 995.621663767778, 1027.6454623155, 1043.4261156363968, 1043.9791204175874, 16717.582060448585, 16824.915875420545, 17565.0, 17679.558011049827, 18033.909830450764, 40658.0, 43396.0, 43731.78134109309, 44872.0, 46055.76972115118, 59215.0, 61477.38522614717, 62210.37789622046, 62514.0, 64064.3593564077, 7652.923470765221, 8090.433669643068, 8153.55155466455, 8298.128696486781, 8612.095729948516, 9499.715008549754, 11785.823212651989, 11932.70168245766, 12776.233425994471, 13345.266010369523, 5898.675572843535, 7659.88510172359, 11435.428228588704, 11648.184627076023, 11844.526218951145, 6560.737570497126, 8212.958935205286, 10767.946160269148, 11340.376279304717, 11505.137114716263, 11071.335719856834, 11544.19190656646, 11571.305721656727, 11860.110491712983, 11860.881391185978, 8557.48655080697, 8563.443376180529, 8574.684835094366, 8614.569271536273, 8777.91222087771, 9587.904120958701, 11084.224104312621, 11109.611163609236, 11959.0, 12116.091293152873], "value": 8952.009324866065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.5256541623976, 1506.9397224111035, 1626.138146782205, 1732.0993083596538, 1741.1816446270248, 8263.752087437379, 8808.075152109033, 8810.163034511712, 8810.38327317088, 8813.559322033889, 7376.373008294301, 7600.429967752427, 7628.656710448029, 7876.763697089083, 8654.437461564994, 2160.5786871560013, 2236.7315922089374, 2256.4810093678466, 2263.7396699379533, 2268.5689718953345, 2353.1646265575732, 2369.4431808524982, 2382.523495300938, 2384.3562238195677, 2395.5328710901294, 2337.1703045418885, 2343.5898717724417, 2343.6367363058753, 2346.3547524430746, 2346.9647955280684, 2245.4498647831224, 2275.3515248154363, 2281.8744969026698, 2283.600369935263, 2285.0973865323103, 2302.735185453661, 2314.1437668062927, 2342.7657234276608, 2343.27358518858, 2344.2264052862515, 8711.128887111237, 8855.512946787923, 8858.557072146432, 8865.645374185026, 8869.37914345996, 5000.0, 5149.562287205592, 5155.381354237478, 5156.510131537498, 5162.612804039674, 3217.147455924182, 3332.6500717424565, 3388.593368795736, 3393.355262500117, 3415.2998635279955, 1025.9025392587691, 1072.2708558180434, 1095.370162156755, 1096.4024606589348, 1104.679642903557, 12021.557413110395, 12060.336681482515, 12061.87938120625, 12081.15431919766, 12083.637490875288, 4138.937915931264, 4461.0, 4550.271956486946, 4590.127875703605, 4590.816367345269, 10262.0, 10265.024822641837, 10265.640702575374, 10266.589336426608, 10274.434906080238, 5150.793968241303, 5157.303763991888, 5181.274621552986, 5190.455002224712, 5194.844154675366, 4684.531546845288, 4719.3628860103445, 4799.448063472745, 4801.0, 4802.711837289774, 3925.509311336083, 3960.821763020671, 4009.839606415769, 4050.5544390117066, 4056.350983842571, 1240.34881687115, 1260.332024027267, 1275.7384736129072, 1276.1513593460431, 1294.3786982248384, 973.5424350555228, 1005.6832097889142, 1006.6577363696379, 1007.4761124215366, 1011.9139873110868, 5867.0, 5935.1987481690285, 6041.335453100155, 6061.54538409621, 6359.745610175633, 958.1616085924816, 980.0542476510202, 991.7570195302053, 1016.5577973581516, 1062.6387028410377, 4183.4979802423295, 4203.348480985452, 4226.725262857904, 4244.3633454982, 4291.6566674665955, 10594.0, 10881.564737410416, 10994.670159895217, 11052.889471105347, 11063.336199827874, 10787.514561844735, 10846.837297440545, 10851.945740271405, 10874.945625271823, 10877.021068103908, 8012.599370031475, 8194.05768336637, 8203.097659257477, 8220.424570280142, 8228.753137405887, 5679.318481782213, 5765.740541675551, 5770.538356931352, 5843.883122337445, 6023.247094113236, 9775.120239178508, 9847.950760246153, 9927.255455840696, 9930.354526955725, 10060.446675432922, 10142.645007424704, 10457.26799124054, 10490.370577765358, 10499.160067194758, 10501.0, 6963.651817409008, 7478.5138965967035, 7620.466567340233, 7722.884156737766, 7956.045274567089, 8643.265322447662, 8717.346199035224, 8754.34342424308, 8755.693550725695, 8763.298936085226, 7677.462577619513, 7749.535027898344, 7796.961015194887, 7825.100113487022, 7834.569098699626, 7599.8600209968945, 7679.3856491481665, 7698.2686644768655, 7797.298243158143, 7886.72396466121, 6861.794146175623, 6915.309994946399, 6915.377616014583, 6975.267596902455, 6983.860322793617, 5110.744462776772, 5129.435762066244, 5212.270282160424, 5245.921311180412, 5343.465653434625, 5021.146405111067, 5022.0, 5172.9741351293005, 5228.58171346299, 5521.1442226454965], "value": 4629.751913408062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.3278648939715, 337.93072420153874, 343.74906318387576, 346.72262190247795, 347.72703427809176, 5328.653637513559, 5370.422197345277, 5376.596755243358, 5378.354597448307, 5408.188771684249, 5069.645124841262, 5172.896542069166, 5190.429052804188, 5197.636165468419, 5359.356877174735, 4020.276350256945, 4138.813753381105, 4154.356074808409, 4158.8336466541305, 4163.271427500191, 4128.587141285878, 4136.751794892301, 4144.150449157931, 4145.79271036447, 4145.917081658365, 4051.5745846686114, 4099.795010249476, 4112.779099286382, 4145.875623731278, 4150.232207041707, 4124.566920473367, 4130.132672138854, 4131.132462182945, 4139.627433530966, 4153.376993450976, 3661.359262129117, 3684.705223582107, 3701.204241088179, 3704.203596226824, 3715.2012317351628, 5096.286519887219, 5219.869503262411, 5237.3453318335205, 5253.290805741214, 5260.842174734764, 4708.599769019604, 4712.575868171881, 4729.196036673774, 4734.621230301567, 4775.5701986821, 5436.700981446019, 5443.265159203536, 5444.713220447422, 5447.237386765856, 5537.501624853782, 3947.5591409135745, 4032.737872038308, 4035.3139966205817, 4040.979795101035, 4041.191761647682, 5685.232493613351, 5701.230333904911, 5707.714614269312, 5718.71406429681, 5766.192733017381, 4101.52832424269, 4138.703019824026, 4150.688698347636, 4166.229247589205, 4176.83292668296, 4067.9593204067583, 4151.232022075926, 4224.1129362834145, 4232.91534169321, 4233.745975241495, 4703.294505824086, 4704.694194877322, 4707.317438971399, 4755.169259834919, 4777.495089046939, 5497.532709719639, 5501.394846566875, 5511.862203444946, 5536.944630553723, 5576.525995290446, 1353.5330311042674, 1426.415169780385, 1450.2096357485195, 1452.2666053643054, 1460.9561713148623, 907.9546022698838, 921.6221349246777, 927.6289484206371, 928.6703220356811, 943.4197968249614, 4704.0, 4714.622830173578, 4757.500462451462, 4814.20565606671, 4818.036392721469, 4777.617790576745, 5033.245013247969, 5066.264217322679, 5100.362454693163, 5104.770285337168, 4785.736784476818, 4800.759962001886, 4807.230843065093, 4807.711537307773, 4809.975950120297, 2676.7686864042757, 2680.4103097318557, 2682.7257052899718, 2702.2703869955003, 2704.296882810444, 5217.58259339252, 5237.869053273698, 5565.387807341189, 5966.880662386728, 5974.40255974399, 5815.534757219412, 5818.679972601548, 5832.212651292021, 5835.854103647443, 5849.444302791228, 5770.221020162308, 5923.667174885616, 6001.699915004319, 6003.609765365237, 6012.759489620366, 5711.771529138788, 5718.857028574319, 5731.0, 5764.798232061858, 5797.391273916178, 5643.435656434488, 5657.886842263214, 5676.347220069745, 5678.574106942078, 5730.770769169187, 5634.943650563606, 5832.94167058324, 5887.234659494238, 6011.355003798315, 6012.819615411545, 4041.1814683392004, 4078.2659121358442, 4104.4664193654635, 4146.813393397244, 4147.688923330702, 5517.558595312285, 5643.294588176478, 5654.293213348332, 5666.9716651416475, 5792.160136780059, 5062.265971434048, 5488.655279456559, 5499.862503437446, 5547.833564993057, 5556.555475562026, 5409.459054094559, 5495.807646732345, 5547.805826796042, 5557.472040156179, 5566.944330556643, 5286.947130528645, 5447.5097241246895, 5451.4276001019325, 5562.860928476821, 5582.33012038558, 5567.47109024642, 5576.749046292845, 5590.944090559043, 5600.131979543177, 5611.4568493664565, 5435.592330575302, 5458.5087342139395, 5462.754176062007, 5465.234867118686, 5544.0], "value": 4191.145752641918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.9323260906517, 763.9388848892089, 794.7139029949217, 804.1636697834252, 855.8630619100945, 15086.47197348093, 15549.766753498707, 15644.999999999985, 15646.061236325828, 15665.921670391632, 15342.923285383558, 15479.0, 15509.767353489678, 15510.069395836257, 15525.767113493279, 646.6314200905485, 780.3718007004359, 793.714262865368, 800.6837299266787, 803.0724513187278, 812.2283830361151, 815.3599424451806, 815.4577206157927, 816.8407160603684, 820.0159808230147, 870.7387783664907, 871.9346049046316, 872.16708043818, 872.467794645269, 873.681106396164, 669.3875104279579, 802.8434455281223, 859.1236938322907, 860.518109858475, 860.7374750701034, 625.1622825413922, 628.5945565110524, 630.0108829138255, 630.4483576870239, 631.6273398694792, 13320.933395333059, 13324.267165306, 13348.199108053548, 13353.599392018255, 13359.799603005962, 14546.92726536371, 14676.559703208814, 14760.188189649565, 14831.925840370837, 14843.544112455415, 12125.0, 12299.385030748426, 12370.257784532956, 12547.372631368395, 12997.285149316878, 4527.4567051953645, 4632.0967411354795, 4633.096546173498, 4800.783964721596, 4817.108834865526, 79189.0, 79235.96065247167, 79610.20389796086, 79844.60077699632, 82044.58977705133, 11532.361115945007, 11552.882245447616, 11615.535378584762, 11738.70653233659, 11915.761684766256, 22249.55500889973, 22449.32652020442, 22499.66250506244, 22529.662055069188, 22721.772782272295, 8369.49783013021, 8397.874031889405, 8440.831183376298, 8474.27968622674, 8809.955950220336, 4532.093581283756, 4575.966436919362, 4591.058832939239, 4645.628349732014, 4751.762411879392, 3442.277121804449, 3540.566070741354, 3542.220711443478, 3558.288342331544, 3571.928561428757, 609.7164818359485, 610.4109534299422, 622.9377062293735, 626.8683576448997, 627.7143899525705, 690.5925503952692, 697.7313734212365, 742.6954948471209, 749.628933677833, 786.9881951770728, 9615.807683846424, 9745.366551174151, 9811.649600919049, 10002.799384135478, 10054.798904022025, 612.6967151260154, 696.6830092307988, 725.5247812682701, 749.568997826252, 757.1255200243727, 4671.27595222741, 4732.408448943882, 4740.905181896343, 4793.298379075378, 4889.877753056131, 97176.02823971811, 113967.0, 117058.41470792762, 117625.0, 118809.0, 56199.71900140555, 80628.0, 95714.52142739242, 96327.0, 96459.0, 84116.15883841206, 84241.0, 84793.57603211944, 84850.5757471221, 88609.0, 8868.334874884538, 8959.148880856308, 9245.0, 9329.86005209936, 9343.205827504466, 51679.48320516747, 52955.96918292756, 53211.73394133159, 53602.463975359744, 54068.45931540792, 57584.0, 61834.38165618466, 63036.684816575624, 66289.33710662831, 73020.63489682517, 13120.737585248433, 13437.462501499831, 13462.86537134616, 13501.324933753076, 14296.213708246147, 15907.204639768197, 15979.041257524586, 16065.0, 16531.256093475582, 16676.24956876919, 12632.936835315764, 12764.872351276368, 13172.143810652276, 15316.617084572976, 15805.52583422499, 14725.705485890436, 14876.702465950837, 15385.769213461583, 15494.922525387301, 15759.68480630404, 13425.127366721132, 13546.86453135456, 13708.52020179289, 13968.231747253592, 14379.928100359431, 10709.839352409565, 11216.551337946717, 11325.546978120783, 11332.036776874058, 11428.371439570903, 11814.881851181723, 12614.306213158365, 12709.745805084032, 12814.365907771362, 12872.292023938398], "value": 7643.300373563179, "unit": "score"}], "name": "dromaeo_css", "value": 7181.236575535701, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 118.0, 170.0, 119.0, 121.0, 142.0, 118.0, 159.0, 121.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 162.0, 161.0, 159.0, 161.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 106.0, 75.0, 75.0, 74.0, 74.0, 104.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 123.0, 85.0, 85.0, 84.0, 119.0, 84.0, 84.0, 128.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 78.0, 81.0, 75.0, 81.0, 76.0, 75.0, 76.0, 79.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 127.0, 129.0, 124.0, 120.0, 119.0, 119.0, 201.0, 128.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 155.0, 157.0, 157.0, 157.0, 157.0, 158.0, 162.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1483.9, "alertThreshold": 2.0}]} 07:38:30 INFO - Return code: 0 07:38:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:38:30 INFO - # TBPL SUCCESS # 07:38:30 INFO - Running post-action listener: _resource_record_post_action 07:38:30 INFO - [mozharness: 2016-07-28 14:38:30.902778Z] Finished run-tests step (success) 07:38:30 INFO - Running post-run listener: _resource_record_post_run 07:38:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 2760704; Write bytes: 567427072; Read time: 1480; Write time: 511000 07:38:30 INFO - TinderboxPrint: CPU usage
13.0% 07:38:30 INFO - TinderboxPrint: I/O read bytes / time
2,760,704 / 1,480 07:38:30 INFO - TinderboxPrint: I/O write bytes / time
567,427,072 / 511,000 07:38:30 INFO - TinderboxPrint: CPU idle
8,281.9 (87.0%) 07:38:30 INFO - TinderboxPrint: CPU user
1,193.2 (12.5%) 07:38:30 INFO - TinderboxPrint: Swap in / out
0 / 0 07:38:30 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270921728; Read time: 0; Write time: 282952 07:38:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 2756608; Write bytes: 296505344; Read time: 1476; Write time: 228048 07:38:31 INFO - Running post-run listener: _upload_blobber_files 07:38:31 INFO - Blob upload gear active. 07:38:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:38:31 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 07:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:38:31 INFO - (blobuploader) - INFO - Open directory for files ... 07:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:32 INFO - (blobuploader) - INFO - Done attempting. 07:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:42 INFO - (blobuploader) - INFO - Done attempting. 07:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:43 INFO - (blobuploader) - INFO - Done attempting. 07:38:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:43 INFO - Return code: 0 07:38:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:38:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d6fa0058731dc48f553ae4d24eb5fe956f02732dfc4d038097ffc80e16f5a41f7e8e1955e8c34f90f46f6a0ec8ac7d92578cddf9a7ff2f961984931d4f8847a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5370af9df213f3771e1e44ebcfd8445b31a75723803274ae63ca049a0c73a087db1692e66b6d897c2ee70304daa6802fa10c732db6872efc40b4be73d3de2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e33d1f4088438ff631b57f78ca33d61a083888671db746bc2bca923808f7a634030d5bb4d5534e01720fab956f56809fc7bbc8588a05607c072693c806e6560"} 07:38:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:38:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:38:43 INFO - Contents: 07:38:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d6fa0058731dc48f553ae4d24eb5fe956f02732dfc4d038097ffc80e16f5a41f7e8e1955e8c34f90f46f6a0ec8ac7d92578cddf9a7ff2f961984931d4f8847a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5370af9df213f3771e1e44ebcfd8445b31a75723803274ae63ca049a0c73a087db1692e66b6d897c2ee70304daa6802fa10c732db6872efc40b4be73d3de2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e33d1f4088438ff631b57f78ca33d61a083888671db746bc2bca923808f7a634030d5bb4d5534e01720fab956f56809fc7bbc8588a05607c072693c806e6560"} 07:38:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:38:43 INFO - Copying logs to upload dir... 07:38:43 INFO - mkdir: /builds/slave/test/build/upload/logs 07:38:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.650111 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-28 07:38:42.874473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 07:38:42.877914) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d6fa0058731dc48f553ae4d24eb5fe956f02732dfc4d038097ffc80e16f5a41f7e8e1955e8c34f90f46f6a0ec8ac7d92578cddf9a7ff2f961984931d4f8847a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5370af9df213f3771e1e44ebcfd8445b31a75723803274ae63ca049a0c73a087db1692e66b6d897c2ee70304daa6802fa10c732db6872efc40b4be73d3de2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e33d1f4088438ff631b57f78ca33d61a083888671db746bc2bca923808f7a634030d5bb4d5534e01720fab956f56809fc7bbc8588a05607c072693c806e6560"} build_url:https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/HLW9wObUTxWhtkZAecAYMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d6fa0058731dc48f553ae4d24eb5fe956f02732dfc4d038097ffc80e16f5a41f7e8e1955e8c34f90f46f6a0ec8ac7d92578cddf9a7ff2f961984931d4f8847a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b5370af9df213f3771e1e44ebcfd8445b31a75723803274ae63ca049a0c73a087db1692e66b6d897c2ee70304daa6802fa10c732db6872efc40b4be73d3de2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e33d1f4088438ff631b57f78ca33d61a083888671db746bc2bca923808f7a634030d5bb4d5534e01720fab956f56809fc7bbc8588a05607c072693c806e6560"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 07:38:42.904813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:38:42.905197) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1469713140.452916-1522289018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 07:38:42.988679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 07:38:42.989010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 07:38:42.989469) ========= ========= Total master_lag: 0.18 =========