builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1463651045.34 results: success (0) buildid: 20160518225441 builduid: 509c8a1abc9e4e5797ea52ec72e20ca1 revision: 64c305e296c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.339146) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.339817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.340238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.356573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.356936) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 02:44:05-- 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% 45.9M=0s 2016-05-19 02:44:05 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.513941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.514435) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013608 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:05.565311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 02:44:05.565778) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 64c305e296c8 --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 64c305e296c8 --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=78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 02:44:05,804 Setting DEBUG logging. 2016-05-19 02:44:05,804 attempt 1/10 2016-05-19 02:44:05,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/64c305e296c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 02:44:06,898 unpacking tar archive at: mozilla-inbound-64c305e296c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.388566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 02:44:06.967876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:06.968214) ========= script_repo_revision: 64c305e296c8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:06.968676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:06.968954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:44:06.977687) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-19 02:44:06.977972) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:44:07 INFO - MultiFileLogger online at 20160519 02:44:07 in /builds/slave/test 02:44:07 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 02:44:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:07 INFO - {'append_to_log': False, 02:44:07 INFO - 'base_work_dir': '/builds/slave/test', 02:44:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:44:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:07 INFO - 'branch': 'Mozilla-Inbound', 02:44:07 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:07 INFO - 'config_files': ('talos/linux_config.py',), 02:44:07 INFO - 'default_actions': ('clobber', 02:44:07 INFO - 'read-buildbot-config', 02:44:07 INFO - 'download-and-extract', 02:44:07 INFO - 'populate-webroot', 02:44:07 INFO - 'create-virtualenv', 02:44:07 INFO - 'install', 02:44:07 INFO - 'run-tests'), 02:44:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:07 INFO - 'download_minidump_stackwalk': True, 02:44:07 INFO - 'download_symbols': 'ondemand', 02:44:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:44:07 INFO - 'tooltool.py': '/tools/tooltool.py', 02:44:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:44:07 INFO - '/tools/misc-python/virtualenv.py')}, 02:44:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:07 INFO - 'installer_path': 'installer.exe', 02:44:07 INFO - 'log_level': 'info', 02:44:07 INFO - 'log_name': 'talos', 02:44:07 INFO - 'log_to_console': True, 02:44:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:44:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:44:07 INFO - 'opt_config_files': (), 02:44:07 INFO - 'pip_index': False, 02:44:07 INFO - 'sps_profile': False, 02:44:07 INFO - 'sps_profile_interval': 0, 02:44:07 INFO - 'suite': 'dromaeojs', 02:44:07 INFO - 'system_bits': '32', 02:44:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:07 INFO - 'title': 'talos-linux64-ix-019', 02:44:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:07 INFO - 'use_talos_json': True, 02:44:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:07 INFO - 'work_dir': 'build'} 02:44:07 INFO - ##### 02:44:07 INFO - ##### Running clobber step. 02:44:07 INFO - ##### 02:44:07 INFO - Running pre-action listener: _resource_record_pre_action 02:44:07 INFO - Running main action method: clobber 02:44:07 INFO - rmtree: /builds/slave/test/build 02:44:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:08 INFO - Running post-action listener: _resource_record_post_action 02:44:08 INFO - ##### 02:44:08 INFO - ##### Finished clobber step (success) 02:44:08 INFO - ##### 02:44:08 INFO - ##### 02:44:08 INFO - ##### Running read-buildbot-config step. 02:44:08 INFO - ##### 02:44:08 INFO - Running pre-action listener: _resource_record_pre_action 02:44:08 INFO - Running main action method: read_buildbot_config 02:44:08 INFO - Using buildbot properties: 02:44:08 INFO - { 02:44:08 INFO - "project": "", 02:44:08 INFO - "product": "firefox", 02:44:08 INFO - "script_repo_revision": "production", 02:44:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:44:08 INFO - "repository": "", 02:44:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:44:08 INFO - "buildid": "20160518225441", 02:44:08 INFO - "pgo_build": "True", 02:44:08 INFO - "basedir": "/builds/slave/test", 02:44:08 INFO - "buildnumber": 1023, 02:44:08 INFO - "slavename": "talos-linux64-ix-019", 02:44:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:44:08 INFO - "platform": "ubuntu64_hw", 02:44:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:44:08 INFO - "branch": "mozilla-inbound", 02:44:08 INFO - "repo_path": "integration/mozilla-inbound", 02:44:08 INFO - "revision": "64c305e296c8", 02:44:08 INFO - "stage_platform": "linux64-pgo", 02:44:08 INFO - "builduid": "509c8a1abc9e4e5797ea52ec72e20ca1", 02:44:08 INFO - "slavebuilddir": "test" 02:44:08 INFO - } 02:44:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:44:08 INFO - Running post-action listener: _resource_record_post_action 02:44:08 INFO - ##### 02:44:08 INFO - ##### Finished read-buildbot-config step (success) 02:44:08 INFO - ##### 02:44:08 INFO - ##### 02:44:08 INFO - ##### Running download-and-extract step. 02:44:08 INFO - ##### 02:44:08 INFO - Running pre-action listener: _resource_record_pre_action 02:44:08 INFO - Running main action method: download_and_extract 02:44:08 INFO - mkdir: /builds/slave/test/build/tests 02:44: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')]} 02:44:08 INFO - https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:44:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:44:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:44:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:44:09 INFO - Downloaded 1361 bytes. 02:44:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:44:09 INFO - Using the following test package requirements: 02:44:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:44:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:44:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:44:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'jsshell-linux-x86_64.zip'], 02:44:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:44:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:44:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:44:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:44:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:44:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:44:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:09 INFO - https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:44:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:44:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:44:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:44:10 INFO - Downloaded 24387154 bytes. 02:44:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:44:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:44:11 INFO - Return code: 0 02:44:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:11 INFO - https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:44:12 INFO - Downloaded 24387154 bytes. 02:44:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:44:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:44:14 INFO - Return code: 0 02:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:14 INFO - https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:44:15 INFO - Downloaded 10840359 bytes. 02:44:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:44:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:44:15 INFO - Return code: 0 02:44:15 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')]} 02:44:15 INFO - https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:44:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:44:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:44:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:44:16 INFO - Downloaded 58601446 bytes. 02:44:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:44:16 INFO - mkdir: /builds/slave/test/properties 02:44:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:16 INFO - Contents: 02:44:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:44:17 INFO - Running post-action listener: _resource_record_post_action 02:44:17 INFO - Running post-action listener: set_extra_try_arguments 02:44:17 INFO - ##### 02:44:17 INFO - ##### Finished download-and-extract step (success) 02:44:17 INFO - ##### 02:44:17 INFO - ##### 02:44:17 INFO - ##### Running populate-webroot step. 02:44:17 INFO - ##### 02:44:17 INFO - Running pre-action listener: _resource_record_pre_action 02:44:17 INFO - Running main action method: populate_webroot 02:44:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:17 INFO - '--tppagecycles', 02:44:17 INFO - '7'], 02:44:17 INFO - 'tests': ['tsvgm']}}, 02:44:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['damp', 'tps']}, 02:44:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'tests': ['damp', 'tps']}, 02:44:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['dromaeo_dom']}, 02:44:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['a11yr', 02:44:17 INFO - 'ts_paint', 02:44:17 INFO - 'tpaint', 02:44:17 INFO - 'sessionrestore', 02:44:17 INFO - 'sessionrestore_no_auto_restore', 02:44:17 INFO - 'tabpaint']}, 02:44:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:17 INFO - 'ts_paint', 02:44:17 INFO - 'tpaint', 02:44:17 INFO - 'sessionrestore', 02:44:17 INFO - 'sessionrestore_no_auto_restore', 02:44:17 INFO - 'tabpaint']}, 02:44:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:44:17 INFO - 'ts_paint', 02:44:17 INFO - 'tpaint', 02:44:17 INFO - 'sessionrestore', 02:44:17 INFO - 'sessionrestore_no_auto_restore', 02:44:17 INFO - 'tabpaint']}, 02:44:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:44:17 INFO - 'ts_paint', 02:44:17 INFO - 'tpaint', 02:44:17 INFO - 'sessionrestore', 02:44:17 INFO - 'sessionrestore_no_auto_restore', 02:44:17 INFO - 'tabpaint']}, 02:44:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['a11yr', 02:44:17 INFO - 'ts_paint', 02:44:17 INFO - 'tpaint', 02:44:17 INFO - 'sessionrestore', 02:44:17 INFO - 'sessionrestore_no_auto_restore', 02:44:17 INFO - 'tabpaint']}, 02:44:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['a11yr', 02:44:17 INFO - 'ts_paint', 02:44:17 INFO - 'tpaint', 02:44:17 INFO - 'sessionrestore', 02:44:17 INFO - 'sessionrestore_no_auto_restore', 02:44:17 INFO - 'tabpaint']}, 02:44:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['tsvgx', 02:44:17 INFO - 'tsvgr_opacity', 02:44:17 INFO - 'tart', 02:44:17 INFO - 'tscrollx', 02:44:17 INFO - 'cart']}, 02:44:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:17 INFO - 'tsvgr_opacity', 02:44:17 INFO - 'tart', 02:44:17 INFO - 'tscrollx', 02:44:17 INFO - 'cart']}, 02:44:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'talos_options': ['--disable-e10s'], 02:44:17 INFO - 'tests': ['tp5o']}, 02:44:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'tests': ['tp5o']}, 02:44:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'talos_options': ['--disable-e10s', 02:44:17 INFO - '--xperf_path', 02:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:17 INFO - 'tests': ['tp5n']}, 02:44:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:17 INFO - 'talos_options': ['--xperf_path', 02:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:17 INFO - 'tests': ['tp5n']}}, 02:44:17 INFO - 'talos.zip': {'path': '', 02:44:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:17 INFO - Running post-action listener: _resource_record_post_action 02:44:17 INFO - ##### 02:44:17 INFO - ##### Finished populate-webroot step (success) 02:44:17 INFO - ##### 02:44:17 INFO - ##### 02:44:17 INFO - ##### Running create-virtualenv step. 02:44:17 INFO - ##### 02:44:17 INFO - Running pre-action listener: _resource_record_pre_action 02:44:17 INFO - Running main action method: create_virtualenv 02:44:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:17 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 02:44:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:17 INFO - Using real prefix '/usr' 02:44:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:20 INFO - Installing pip.................done. 02:44:20 INFO - Return code: 0 02:44:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:20 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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44:20 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 02:44:20 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 02:44:20 INFO - Using env: {'DISPLAY': ':0', 02:44:20 INFO - 'HOME': '/home/cltbld', 02:44:20 INFO - 'LANG': 'en_US.UTF-8', 02:44:20 INFO - 'LANGUAGE': 'en_US:en', 02:44:20 INFO - 'LOGNAME': 'cltbld', 02:44:20 INFO - 'MAIL': '/var/mail/cltbld', 02:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:20 INFO - 'MOZ_NO_REMOTE': '1', 02:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:20 INFO - 'NO_EM_RESTART': '1', 02:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:20 INFO - 'PWD': '/builds/slave/test', 02:44:20 INFO - 'SHELL': '/bin/bash', 02:44:20 INFO - 'SHLVL': '1', 02:44:20 INFO - 'TERM': 'linux', 02:44:20 INFO - 'TMOUT': '86400', 02:44:20 INFO - 'USER': 'cltbld', 02:44:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:20 INFO - '_': '/tools/buildbot/bin/python'} 02:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:20 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 02:44:20 INFO - Cleaning up... 02:44:20 INFO - Return code: 0 02:44:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:20 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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44:20 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 02:44:20 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 02:44:20 INFO - Using env: {'DISPLAY': ':0', 02:44:20 INFO - 'HOME': '/home/cltbld', 02:44:20 INFO - 'LANG': 'en_US.UTF-8', 02:44:20 INFO - 'LANGUAGE': 'en_US:en', 02:44:20 INFO - 'LOGNAME': 'cltbld', 02:44:20 INFO - 'MAIL': '/var/mail/cltbld', 02:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:20 INFO - 'MOZ_NO_REMOTE': '1', 02:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:20 INFO - 'NO_EM_RESTART': '1', 02:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:20 INFO - 'PWD': '/builds/slave/test', 02:44:20 INFO - 'SHELL': '/bin/bash', 02:44:20 INFO - 'SHLVL': '1', 02:44:20 INFO - 'TERM': 'linux', 02:44:20 INFO - 'TMOUT': '86400', 02:44:20 INFO - 'USER': 'cltbld', 02:44:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:20 INFO - '_': '/tools/buildbot/bin/python'} 02:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:20 INFO - Downloading/unpacking psutil>=3.1.1 02:44:20 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 02:44:20 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 02:44:20 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 02:44:20 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 02:44:20 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 02:44:20 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 02:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:22 INFO - Installing collected packages: psutil 02:44:22 INFO - Running setup.py install for psutil 02:44:22 INFO - building 'psutil._psutil_linux' extension 02:44:22 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 02:44:22 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 02:44:22 INFO - building 'psutil._psutil_posix' extension 02:44:22 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 02:44:23 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 02:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:23 INFO - Successfully installed psutil 02:44:23 INFO - Cleaning up... 02:44:23 INFO - Return code: 0 02:44:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:44: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 mozsystemmonitor==0.3 02:44:23 INFO - Using env: {'DISPLAY': ':0', 02:44:23 INFO - 'HOME': '/home/cltbld', 02:44:23 INFO - 'LANG': 'en_US.UTF-8', 02:44:23 INFO - 'LANGUAGE': 'en_US:en', 02:44:23 INFO - 'LOGNAME': 'cltbld', 02:44:23 INFO - 'MAIL': '/var/mail/cltbld', 02:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:23 INFO - 'MOZ_NO_REMOTE': '1', 02:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:23 INFO - 'NO_EM_RESTART': '1', 02:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:23 INFO - 'PWD': '/builds/slave/test', 02:44:23 INFO - 'SHELL': '/bin/bash', 02:44:23 INFO - 'SHLVL': '1', 02:44:23 INFO - 'TERM': 'linux', 02:44:23 INFO - 'TMOUT': '86400', 02:44:23 INFO - 'USER': 'cltbld', 02:44:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:23 INFO - '_': '/tools/buildbot/bin/python'} 02:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:44:25 INFO - Installing collected packages: mozsystemmonitor 02:44:25 INFO - Running setup.py install for mozsystemmonitor 02:44:25 INFO - Successfully installed mozsystemmonitor 02:44:25 INFO - Cleaning up... 02:44:25 INFO - Return code: 0 02:44:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:44:25 INFO - Using env: {'DISPLAY': ':0', 02:44:25 INFO - 'HOME': '/home/cltbld', 02:44:25 INFO - 'LANG': 'en_US.UTF-8', 02:44:25 INFO - 'LANGUAGE': 'en_US:en', 02:44:25 INFO - 'LOGNAME': 'cltbld', 02:44:25 INFO - 'MAIL': '/var/mail/cltbld', 02:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:25 INFO - 'MOZ_NO_REMOTE': '1', 02:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:25 INFO - 'NO_EM_RESTART': '1', 02:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:25 INFO - 'PWD': '/builds/slave/test', 02:44:25 INFO - 'SHELL': '/bin/bash', 02:44:25 INFO - 'SHLVL': '1', 02:44:25 INFO - 'TERM': 'linux', 02:44:25 INFO - 'TMOUT': '86400', 02:44:25 INFO - 'USER': 'cltbld', 02:44:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:25 INFO - '_': '/tools/buildbot/bin/python'} 02:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:27 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 02:44:27 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 02:44:27 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 02:44:27 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 02:44:27 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 02:44:27 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 02:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44:28 INFO - Downloading docopt-0.6.1.tar.gz 02:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:28 INFO - Running setup.py install for blobuploader 02:44:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:28 INFO - Running setup.py install for requests 02:44:28 INFO - Running setup.py install for docopt 02:44:28 INFO - Successfully installed blobuploader requests docopt 02:44:28 INFO - Cleaning up... 02:44:28 INFO - Return code: 0 02:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:28 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')]} 02:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:28 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')]} 02:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:28 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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44: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 02:44: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 02:44:29 INFO - Using env: {'DISPLAY': ':0', 02:44:29 INFO - 'HOME': '/home/cltbld', 02:44:29 INFO - 'LANG': 'en_US.UTF-8', 02:44:29 INFO - 'LANGUAGE': 'en_US:en', 02:44:29 INFO - 'LOGNAME': 'cltbld', 02:44:29 INFO - 'MAIL': '/var/mail/cltbld', 02:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:29 INFO - 'MOZ_NO_REMOTE': '1', 02:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:29 INFO - 'NO_EM_RESTART': '1', 02:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:29 INFO - 'PWD': '/builds/slave/test', 02:44:29 INFO - 'SHELL': '/bin/bash', 02:44:29 INFO - 'SHLVL': '1', 02:44:29 INFO - 'TERM': 'linux', 02:44:29 INFO - 'TMOUT': '86400', 02:44:29 INFO - 'USER': 'cltbld', 02:44:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:29 INFO - '_': '/tools/buildbot/bin/python'} 02:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:29 INFO - Running setup.py (path:/tmp/pip-O8Mw5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:29 INFO - Running setup.py (path:/tmp/pip-NNGREm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:29 INFO - Running setup.py (path:/tmp/pip-lIDV2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:29 INFO - Running setup.py (path:/tmp/pip-34_dxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:29 INFO - Running setup.py (path:/tmp/pip-UK8y35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:29 INFO - Running setup.py (path:/tmp/pip-3YTL4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:29 INFO - Running setup.py (path:/tmp/pip-rdZisB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:29 INFO - Running setup.py (path:/tmp/pip-tAgqL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:29 INFO - Running setup.py (path:/tmp/pip-Nc6M6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:29 INFO - Running setup.py (path:/tmp/pip-0IyJRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:29 INFO - Running setup.py (path:/tmp/pip-kZt8t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:29 INFO - Running setup.py (path:/tmp/pip-y3ApRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:30 INFO - Running setup.py (path:/tmp/pip-_RjMAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:30 INFO - Running setup.py (path:/tmp/pip-YfGCzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:30 INFO - Running setup.py (path:/tmp/pip-tsWWLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:30 INFO - Running setup.py (path:/tmp/pip-LQW_4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:30 INFO - Running setup.py (path:/tmp/pip-bSiC6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:30 INFO - Running setup.py install for manifestparser 02:44:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:30 INFO - Running setup.py install for mozcrash 02:44:30 INFO - Running setup.py install for mozdebug 02:44:30 INFO - Running setup.py install for mozdevice 02:44:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:44:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:30 INFO - Running setup.py install for mozfile 02:44:30 INFO - Running setup.py install for mozhttpd 02:44:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for mozinfo 02:44:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for mozInstall 02:44:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for mozleak 02:44:31 INFO - Running setup.py install for mozlog 02:44:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for moznetwork 02:44:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for mozprocess 02:44:31 INFO - Running setup.py install for mozprofile 02:44:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for mozrunner 02:44:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:44:31 INFO - Running setup.py install for mozscreenshot 02:44:32 INFO - Running setup.py install for moztest 02:44:32 INFO - Running setup.py install for mozversion 02:44:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:44:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:44:32 INFO - Cleaning up... 02:44:32 INFO - Return code: 0 02:44:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:32 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')]} 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:32 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')]} 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:32 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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44:32 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 02:44:32 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 02:44:32 INFO - Using env: {'DISPLAY': ':0', 02:44:32 INFO - 'HOME': '/home/cltbld', 02:44:32 INFO - 'LANG': 'en_US.UTF-8', 02:44:32 INFO - 'LANGUAGE': 'en_US:en', 02:44:32 INFO - 'LOGNAME': 'cltbld', 02:44:32 INFO - 'MAIL': '/var/mail/cltbld', 02:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:32 INFO - 'MOZ_NO_REMOTE': '1', 02:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:32 INFO - 'NO_EM_RESTART': '1', 02:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:32 INFO - 'PWD': '/builds/slave/test', 02:44:32 INFO - 'SHELL': '/bin/bash', 02:44:32 INFO - 'SHLVL': '1', 02:44:32 INFO - 'TERM': 'linux', 02:44:32 INFO - 'TMOUT': '86400', 02:44:32 INFO - 'USER': 'cltbld', 02:44:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:32 INFO - '_': '/tools/buildbot/bin/python'} 02:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:32 INFO - Running setup.py (path:/tmp/pip-SEHrZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:32 INFO - Running setup.py (path:/tmp/pip-ghGKxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:32 INFO - Running setup.py (path:/tmp/pip-EsoJaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:32 INFO - Running setup.py (path:/tmp/pip-i9TJcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:32 INFO - Running setup.py (path:/tmp/pip-hxR96v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:32 INFO - Running setup.py (path:/tmp/pip-r6ufbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:32 INFO - Running setup.py (path:/tmp/pip-ecnjqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:32 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)) 02:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:32 INFO - Running setup.py (path:/tmp/pip-phzD5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44: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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:33 INFO - Running setup.py (path:/tmp/pip-2O0L6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44: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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:33 INFO - Running setup.py (path:/tmp/pip-Zq6ZI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:33 INFO - Running setup.py (path:/tmp/pip-AraJHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:33 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:33 INFO - Running setup.py (path:/tmp/pip-fkhe37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:33 INFO - Running setup.py (path:/tmp/pip-jO_ZQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:33 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:33 INFO - Running setup.py (path:/tmp/pip-Jzngnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:33 INFO - Running setup.py (path:/tmp/pip-7hw3QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:33 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:33 INFO - Running setup.py (path:/tmp/pip-XJornt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:33 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)) 02:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:33 INFO - Running setup.py (path:/tmp/pip-rsmXVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:33 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)) 02:44:33 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)) 02:44:33 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)) 02:44:33 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)) 02:44:33 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)) 02:44:33 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)) 02:44:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:35 INFO - Downloading blessings-1.6.tar.gz 02:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:44:35 INFO - Installing collected packages: blessings 02:44:35 INFO - Running setup.py install for blessings 02:44:35 INFO - Successfully installed blessings 02:44:35 INFO - Cleaning up... 02:44:35 INFO - Return code: 0 02:44:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:36 INFO - Reading from file tmpfile_stdout 02:44:36 INFO - Current package versions: 02:44:36 INFO - argparse == 1.2.1 02:44:36 INFO - blessings == 1.6 02:44:36 INFO - blobuploader == 1.2.4 02:44:36 INFO - docopt == 0.6.1 02:44:36 INFO - manifestparser == 1.1 02:44:36 INFO - mozInstall == 1.12 02:44:36 INFO - mozcrash == 0.17 02:44:36 INFO - mozdebug == 0.1 02:44:36 INFO - mozdevice == 0.48 02:44:36 INFO - mozfile == 1.2 02:44:36 INFO - mozhttpd == 0.7 02:44:36 INFO - mozinfo == 0.9 02:44:36 INFO - mozleak == 0.1 02:44:36 INFO - mozlog == 3.2 02:44:36 INFO - moznetwork == 0.27 02:44:36 INFO - mozprocess == 0.22 02:44:36 INFO - mozprofile == 0.28 02:44:36 INFO - mozrunner == 6.11 02:44:36 INFO - mozscreenshot == 0.1 02:44:36 INFO - mozsystemmonitor == 0.3 02:44:36 INFO - moztest == 0.7 02:44:36 INFO - mozversion == 1.4 02:44:36 INFO - psutil == 3.1.1 02:44:36 INFO - requests == 1.2.3 02:44:36 INFO - wsgiref == 0.1.2 02:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44: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 02:44: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 02:44:36 INFO - Using env: {'DISPLAY': ':0', 02:44:36 INFO - 'HOME': '/home/cltbld', 02:44:36 INFO - 'LANG': 'en_US.UTF-8', 02:44:36 INFO - 'LANGUAGE': 'en_US:en', 02:44:36 INFO - 'LOGNAME': 'cltbld', 02:44:36 INFO - 'MAIL': '/var/mail/cltbld', 02:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:36 INFO - 'MOZ_NO_REMOTE': '1', 02:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:36 INFO - 'NO_EM_RESTART': '1', 02:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:36 INFO - 'PWD': '/builds/slave/test', 02:44:36 INFO - 'SHELL': '/bin/bash', 02:44:36 INFO - 'SHLVL': '1', 02:44:36 INFO - 'TERM': 'linux', 02:44:36 INFO - 'TMOUT': '86400', 02:44:36 INFO - 'USER': 'cltbld', 02:44:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:36 INFO - '_': '/tools/buildbot/bin/python'} 02:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 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)) 02:44:36 INFO - Cleaning up... 02:44:36 INFO - Return code: 0 02:44:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:36 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 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44:36 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 02:44:36 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 02:44:36 INFO - Using env: {'DISPLAY': ':0', 02:44:36 INFO - 'HOME': '/home/cltbld', 02:44:36 INFO - 'LANG': 'en_US.UTF-8', 02:44:36 INFO - 'LANGUAGE': 'en_US:en', 02:44:36 INFO - 'LOGNAME': 'cltbld', 02:44:36 INFO - 'MAIL': '/var/mail/cltbld', 02:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:36 INFO - 'MOZ_NO_REMOTE': '1', 02:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:36 INFO - 'NO_EM_RESTART': '1', 02:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:36 INFO - 'PWD': '/builds/slave/test', 02:44:36 INFO - 'SHELL': '/bin/bash', 02:44:36 INFO - 'SHLVL': '1', 02:44:36 INFO - 'TERM': 'linux', 02:44:36 INFO - 'TMOUT': '86400', 02:44:36 INFO - 'USER': 'cltbld', 02:44:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:36 INFO - '_': '/tools/buildbot/bin/python'} 02:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:36 INFO - Downloading/unpacking jsonschema 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:44:38 INFO - Downloading/unpacking functools32 (from jsonschema) 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:44:38 INFO - warning: no files found matching '*.txt' 02:44:38 INFO - no previously-included directories found matching 'build' 02:44:38 INFO - no previously-included directories found matching 'dist' 02:44:38 INFO - no previously-included directories found matching '.git*' 02:44:38 INFO - Installing collected packages: jsonschema, functools32 02:44:38 INFO - Running setup.py install for functools32 02:44:38 INFO - warning: no files found matching '*.txt' 02:44:38 INFO - no previously-included directories found matching 'build' 02:44:38 INFO - no previously-included directories found matching 'dist' 02:44:38 INFO - no previously-included directories found matching '.git*' 02:44:38 INFO - Successfully installed jsonschema functools32 02:44:38 INFO - Cleaning up... 02:44:38 INFO - Return code: 0 02:44:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e4aa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', '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 02:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:44:38 INFO - Using env: {'DISPLAY': ':0', 02:44:38 INFO - 'HOME': '/home/cltbld', 02:44:38 INFO - 'LANG': 'en_US.UTF-8', 02:44:38 INFO - 'LANGUAGE': 'en_US:en', 02:44:38 INFO - 'LOGNAME': 'cltbld', 02:44:38 INFO - 'MAIL': '/var/mail/cltbld', 02:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:38 INFO - 'MOZ_NO_REMOTE': '1', 02:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:38 INFO - 'NO_EM_RESTART': '1', 02:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:38 INFO - 'PWD': '/builds/slave/test', 02:44:38 INFO - 'SHELL': '/bin/bash', 02:44:38 INFO - 'SHLVL': '1', 02:44:38 INFO - 'TERM': 'linux', 02:44:38 INFO - 'TMOUT': '86400', 02:44:38 INFO - 'USER': 'cltbld', 02:44:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:38 INFO - '_': '/tools/buildbot/bin/python'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 INFO - Downloading/unpacking flake8 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:44:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:44:40 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 02:44:40 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 02:44:40 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 02:44:40 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 02:44:40 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 02:44:40 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 02:44:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:44:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:44:41 INFO - no previously-included directories found matching 'docs/_build' 02:44:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:44:41 INFO - Running setup.py install for pep8 02:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:44:41 INFO - no previously-included directories found matching 'docs/_build' 02:44:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:44:41 INFO - Cleaning up... 02:44:41 INFO - Return code: 0 02:44:41 INFO - Running post-action listener: _resource_record_post_action 02:44:41 INFO - Running post-action listener: _start_resource_monitoring 02:44:41 INFO - Starting resource monitoring. 02:44:41 INFO - ##### 02:44:41 INFO - ##### Finished create-virtualenv step (success) 02:44:41 INFO - ##### 02:44:41 INFO - ##### 02:44:41 INFO - ##### Running install step. 02:44:41 INFO - ##### 02:44:41 INFO - Running pre-action listener: _resource_record_pre_action 02:44:41 INFO - Running main action method: install 02:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:42 INFO - Reading from file tmpfile_stdout 02:44:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:44:42 INFO - Reading from file tmpfile_stdout 02:44:42 INFO - Output received: 02:44:42 INFO - Usage: mozinstall [options] installer 02:44:42 INFO - Options: 02:44:42 INFO - -h, --help show this help message and exit 02:44:42 INFO - -d DEST, --destination=DEST 02:44:42 INFO - Directory to install application into. [default: 02:44:42 INFO - "/builds/slave/test"] 02:44:42 INFO - --app=APP Application being installed. [default: firefox] 02:44:42 INFO - mkdir: /builds/slave/test/build/application 02:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:44:58 INFO - Reading from file tmpfile_stdout 02:44:58 INFO - Output received: 02:44:58 INFO - /builds/slave/test/build/application/firefox/firefox 02:44:58 INFO - Running post-action listener: _resource_record_post_action 02:44:58 INFO - ##### 02:44:58 INFO - ##### Finished install step (success) 02:44:58 INFO - ##### 02:44:58 INFO - ##### 02:44:58 INFO - ##### Running run-tests step. 02:44:58 INFO - ##### 02:44:58 INFO - Running pre-action listener: _resource_record_pre_action 02:44:58 INFO - Running main action method: run_tests 02:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:44:58 INFO - Python 2.7.3 02:44:58 INFO - Return code: 0 02:44:58 INFO - grabbing minidump binary from tooltool 02:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:58 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 0x18c69c0>, '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 0x18c78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:44:58 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 02:44:58 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 02:44:58 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 02:44:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:44:58 INFO - Return code: 0 02:44:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:44:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:44:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:44:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:44:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:44:59 INFO - Return code: 0 02:44:59 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/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 02:44:59 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/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 02:44:59 INFO - Using env: {'DISPLAY': ':0', 02:44:59 INFO - 'HOME': '/home/cltbld', 02:44:59 INFO - 'LANG': 'en_US.UTF-8', 02:44:59 INFO - 'LANGUAGE': 'en_US:en', 02:44:59 INFO - 'LOGNAME': 'cltbld', 02:44:59 INFO - 'MAIL': '/var/mail/cltbld', 02:44:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:44:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:59 INFO - 'MOZ_NO_REMOTE': '1', 02:44:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:59 INFO - 'NO_EM_RESTART': '1', 02:44:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:59 INFO - 'PWD': '/builds/slave/test', 02:44:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:44:59 INFO - 'SHELL': '/bin/bash', 02:44:59 INFO - 'SHLVL': '1', 02:44:59 INFO - 'TERM': 'linux', 02:44:59 INFO - 'TMOUT': '86400', 02:44:59 INFO - 'USER': 'cltbld', 02:44:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076', 02:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:59 INFO - '_': '/tools/buildbot/bin/python'} 02:44:59 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/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 02:45:00 INFO - mozversion application_buildid: 20160518225441 02:45:00 INFO - mozversion application_changeset: 64c305e296c81d9016beb785db20ac0a78bdf528 02:45:00 INFO - mozversion application_display_name: Nightly 02:45:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:00 INFO - mozversion application_name: Firefox 02:45:00 INFO - mozversion application_remotingname: firefox 02:45:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:45:00 INFO - mozversion application_vendor: Mozilla 02:45:00 INFO - mozversion application_version: 49.0a1 02:45:00 INFO - mozversion platform_buildid: 20160518225441 02:45:00 INFO - mozversion platform_changeset: 64c305e296c81d9016beb785db20ac0a78bdf528 02:45:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:45:00 INFO - mozversion platform_version: 49.0a1 02:45:00 INFO - using testdate: 1463651100 02:45:00 INFO - actual date: 1463651100 02:45:00 INFO - starting webserver on 'localhost:56640' 02:45:00 INFO - SUITE-START | Running 2 tests 02:45:00 INFO - TEST-START | dromaeo_css 02:45:00 INFO - operating with platform_type : linux_ 02:45:00 INFO - Initialising browser for dromaeo_css test... 02:45:00 INFO - TEST-INFO | started process 26860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrm3_z/profile http://localhost:56640/getInfo.html) 02:45:04 INFO - PROCESS | 26860 | __metrics Screen width/height:1600/1200 02:45:04 INFO - PROCESS | 26860 | colorDepth:24 02:45:04 INFO - PROCESS | 26860 | Browser inner width/height: 1024/697 02:45:04 INFO - PROCESS | 26860 | __metrics 02:45:05 ERROR - PROCESS | 26860 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:45:06 INFO - TEST-INFO | 26860: exit 0 02:45:06 INFO - Browser initialized. 02:45:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:06 INFO - TEST-INFO | started process 26944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrm3_z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:18 INFO - PROCESS | 26944 | RSS: Main: 152805376 02:45:18 INFO - PROCESS | 26944 | 02:46:08 INFO - PROCESS | 26944 | 1463651168864 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] 02:48:16 INFO - PROCESS | 26944 | Cycle 1(1): loaded http://localhost:56640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56640/tests/dromaeo/cssquery-ext.html) 02:48:17 INFO - PROCESS | 26944 | RSS: Main: 259964928 02:48:17 INFO - PROCESS | 26944 | 02:51:20 INFO - PROCESS | 26944 | Cycle 1(1): loaded http://localhost:56640/tests/dromaeo/cssquery-ext.html (next: http://localhost:56640/tests/dromaeo/cssquery-jquery.html) 02:51:20 INFO - PROCESS | 26944 | RSS: Main: 233324544 02:51:20 INFO - PROCESS | 26944 | 02:54:22 INFO - PROCESS | 26944 | Cycle 1(1): loaded http://localhost:56640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56640/tests/dromaeo/cssquery-mootools.html) 02:54:23 INFO - PROCESS | 26944 | RSS: Main: 235692032 02:54:23 INFO - PROCESS | 26944 | 02:57:25 INFO - PROCESS | 26944 | Cycle 1(1): loaded http://localhost:56640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56640/tests/dromaeo/cssquery-prototype.html) 02:57:25 INFO - PROCESS | 26944 | RSS: Main: 236912640 02:57:25 INFO - PROCESS | 26944 | 03:00:28 INFO - PROCESS | 26944 | Cycle 1(1): loaded http://localhost:56640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56640/tests/dromaeo/cssquery-yui.html) 03:00:28 INFO - PROCESS | 26944 | RSS: Main: 221622272 03:00:28 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | Cycle 1(1): loaded http://localhost:56640/tests/dromaeo/cssquery-yui.html (next: http://localhost:56640/tests/dromaeo/cssquery-dojo.html) 03:03:31 INFO - PROCESS | 26944 | RSS: Main: 286978048 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | __start_tp_report 03:03:31 INFO - PROCESS | 26944 | _x_x_mozilla_page_load 03:03:31 INFO - PROCESS | 26944 | _x_x_mozilla_page_load_details 03:03:31 INFO - PROCESS | 26944 | |i|pagename|runs| 03:03:31 INFO - PROCESS | 26944 | |0;dojo.html;3059.5716599676043;3079.3379423423967;3097.550855126007;3141.246100935776;3146.669599692032;5267.499587539178;5339.41266460689;5344.839654810362;5433.239346491489;5472.50747432731;5322.095243808552;5340.145576707728;5353.518183363496;5369.382521010085;5406.243125962358;4756.215224487964;4777.474477807438;4906.092372911005;4922.507749225067;4952.356193694833;4875.07373599015;4900.803967841282;4936.827211047614;4948.925766113512;4949.703017818924;4700.435947686283;4833.637477189207;4846.079244943449;4870.926936095943;4874.073925954058;4880.316755654176;4896.363472748555;4905.337779399807;4914.901701965977;4929.65492415531;4691.812327506896;4773.594244489223;4850.248211527183;4862.659613827033;4885.2427873679635;5291.682499050069;5363.731813409314;5364.892702145935;5404.7838086476495;5419;5801.24583804107;5847.2983242010805;5860;5863.2670916135485;5870.11948207768;5690.089585666315;5757.68332741699;5794.913076303858;5927.140564618149;5938.851528711773;5474.562035037187;5508.283923089973;5517.613767036309;5526.530244929186;5526.668399896019;6024.57827952048;6025.758969641165;6034.1853849730605;6034.306054803666;6038.849028774228;5483.588730845203;5619.80330688424;5671.291088613923;5684.77260909559;5779.826605201851;5817.185594016841;5819.418058194146;5821.592488525763;5857.297124345106;5880.94119058804;5713.143028545668;5725.77096916127;5763.798267060716;5779.479846813807;5781.277340332458;5528.115501519737;5745.626534275259;5806;5807.274090738658;5858.560607954335;4431.8448854289945;4442.777861106932;4444.200043992112;4446.021875187454;4480.215962206601;3858.2669292834835;3944.4083387492105;3958.148997965451;3978;3997.900052498711;5494.752736126884;5510.035743744828;5551.306086739158;5560.388357280696;5590.608657393944;5926.851828704317;5933.465988061009;5940.910886336708;5941.673207973603;5941.792037278675;5338.3060202173465;5484.7531861066345;5580.832575022756;5587;5587.189857470726;4861.246506791453;4863.732494712754;4888.584470320063;4891.364122664031;4917.28699338601;6087.786927457518;6090.451859332681;6093.360197179321;6101.389861013863;6105;5686.65880047182;5753.367129615655;5826.854328641818;5912.6452412854505;5920.615160014585;6007.3992600739575;6019.668918209365;6021.969890150696;6024.608400454132;6056.06131049688;5701.600887937971;5712.514436272797;5761.971190144022;5762.481376676119;5766.2503874497725;5613.410591887793;5786.797462088806;5834.679092649945;5855.121731740273;5862.149988251595;5687.260656114679;5717.542596592346;5725.541956643542;5733.913991290217;5736.139579063007;5700.258966334516;5721.084626459747;5724.169995350734;5724.856878578069;5725.08398656213;5381.1121165007335;5398.08232600451;5421.132618781134;5447.346318441812;5456.127019676833;5577.470140336662;5577.470140336662;5636.2954630671165;5639.351474580476;5643.125315576092;5421.241026256406;5425.918611220756;5472.425395333592;5478.369987451494;5511.559075274049 03:03:31 INFO - PROCESS | 26944 | |1;ext.html;582.2285471749932;586.5307753796963;588.7762650192923;590.8965930962081;625.9217597800275;35330.82334588327;36268.455973160424;36355.2728945421;36390;38270;36607.81696091516;37222.44166337507;37254.06864828381;37327.06682332936;37516;8335.791605209874;8443.662253509883;8501.744947651581;8507.489550626951;8513.53175575343;8224.506529608212;8311.376646751487;8311.750647480556;8313.542755148464;8315.41792074555;8478.78803029923;8522.829543409129;8543.871841922377;8545.615447304886;8546.61540230688;8468.407211495198;8506.617202225914;8510.106438823896;8523.14768523149;8524.957375213084;8412.906322178138;8495.320374370036;8507.95746021266;8510.531920744357;8516.06323304436;35991.10022249465;36345.81827090874;36388.45417318743;36426.271474570625;36460.81769591162;2967.065374407055;2989.7757668174754;3056.2664960409566;3118.6413562440384;3248.6101667800017;28278;28511.857440712873;28562.285942851388;28587.428251435063;29472.26319342012;3535.840887160084;3730.9067273318115;3740.682042026431;3775.452559378875;3802.9429558556644;299070;376804;377210;377430;378633;42842.78578607087;46557.534424656;47808.760956194994;48359.516404836206;48502;48717;48952.26571601429;48962.26556601654;48975.061496310336;49021;13722.725545489035;13850.930745346208;13885.861141388457;13902.721945561032;13908.791368129487;9588.616455341848;10263;10460.790784184273;10489.423081730425;10504.212184086224;15148.924255378653;15300.693986120215;15541.06753594788;15546.533603991898;15552.377904883679;6019.789307374221;6059.36376680451;6079.540910181525;6169.352218017133;6242.937570624326;851.4933614499363;908.6547112097493;923.132255679659;936.681528280388;991.1278075293695;27445.176644700692;28550.428991420056;28877.989270375438;29086.563701544495;29164.562531562042;970;970.9416735758058;991.2813210422386;1008.4655132779639;1053.5785685725618;13806.240656763974;13914.860851391559;14044.921486781992;14151.71696566063;14163.362648680833;577312;581668;581864;582308;583823;44752.77623611861;44774.77612611916;45150.54849451529;45183.707547782906;45184.096318073454;1103.8840921703265;1176.87054424015;1191.53530123252;1197.988020119805;1206.4691535724253;25938.610920835825;28710.425791483634;29074.982375616753;29097.418051639273;29153;37141.257174856895;37474;37527.43708844315;37574.81212593919;37615;329502;330734;331651;332383;334350;20740;22945.082196711945;22951.196708115134;23818.76181238235;24247.878760606083;34834.65165348314;38630.6136938627;38671.22657546777;39399.40900886431;39477.802610986764;33092.669073308956;33549;33604.49593256152;33680.32639347248;33783.49324760081;33972.49041264432;33979.66020339765;34337.65662343444;34347;34783.304333913686;33423.33153336968;34004;34165;34264.31471370509;34270.48594271138;30250;30625.081247562608;30735.7926221336;31057.669251059826;31177.8441107793;23349.299521013716;24235.75764242335;24238;24497.510049798548;24973.50264973488 03:03:31 INFO - PROCESS | 26944 | |2;jquery.html;375.3899912641956;379.510431543309;380.6060727147403;393.9231849789289;396.2056077564483;16855.66288674226;18295;18664.720029199554;18830.15264313106;18852.905735471304;15912.920435397808;15968.680626387466;15973.281202345894;16465.423710170147;16469.423570175048;5536.695481748512;5660.2075709400715;5714.657120572758;5722.027255366597;5723.742431590588;4111.444954931091;4567.995041090971;6145;6168.167297414837;6262.154609127755;6185.938140618604;6193.876122477548;6195.31851496335;6199.752009919598;6203.813885583417;5218.608604354669;5473.370562385337;5483.835484935458;5515.034868897967;5568.49883510482;3657.8536858525626;5000.974995125038;5228.111221092386;5262.210668399733;5381.381141168777;11961.222520536137;12105.576304829288;12135.514579416813;18794.24823007078;20951.371458856258;2248.572771173488;2293.3005433342823;2305.5388922215457;2390.9282721518384;2400.195934361991;8742;9122.27021838258;9394.295427842939;9412.90587094134;9718.930917599058;1825.9269629214816;1834.6612453971497;1842.060549119945;1945.8248757611882;2018.9596208075902;75657;79537;84026.57986710088;85285.57357213175;86788;10125.64560240388;10340.844887326695;10344.844827327595;10420.166386689047;10907.727306817234;13911;13972.301384930714;14045.578632641038;14076.436942522389;14128.364223609962;7240.275972402717;7430.256974302634;7515.248475152441;7615.276548727862;7670.156282808886;7143.464240182007;7196.244394338519;7196.96401517989;7412.96293518529;7436.590987495631;4132.359484279941;4192.203481338536;4263.467066616673;4300.569943005675;4354.934675979863;1796.8562514998769;1861.8138186181545;1869.44851268876;1876.934307299238;1912.8660993730584;794.6424109150905;896.9506677132821;915.0529202275612;925.7870689741397;945.8959514453404;16682.249298781582;17284.65430691379;17510.21204045821;17512.21195046226;18049.368272110412;877.2236570634907;884.9690260840969;886.0386480668418;888.5157589113949;929.5305870535336;9304.581293841793;9880.901190988141;9945.900540994497;10002.099811016898;10016.54925528353;470183;473828;474741;474879;475224;76961.61519192369;92786.53606731923;94054;95116.52441737747;95691.52154239184;428.8499025341168;858.4934888415739;888.3781353052889;890.496869268861;893.4728510179026;9792.902070979198;9894.554745036347;9961.402315860782;9971.650992215238;10066.597336106473;38852.6114738849;39096.80451597724;39120.41319380155;40665.39001915033;41248.587514124476;55895.72052139713;59014.81970360483;59250.40749592449;60404;60754;8127.431079824356;8260.669573217245;8411.747647570583;8416.074231834371;8511.702090426805;12121.69695757613;12326;12565.246085234916;12649.494020239088;12713.745725085262;11018.834717479405;11024.724381890517;11028.22802403824;11047;11050.33697978124;10736;10832.458377080957;10964.818044181075;11035.83446248323;11166;11039.116870650489;11398.145139114766;11403.714907127389;11462.541498339973;11600.419979001184;8242.17578242171;8250.834983300181;8312.33501319905;8361.331093512626;8423.410361274897;8335.208155225244;10789.298695584763;11343.092552595937;11350.318980861175;11408.54365825391 03:03:31 INFO - PROCESS | 26944 | |3;mootools.html;1031.886492485826;1222.8349172861667;1226.515526367085;1255.522901297507;1417.666848290652;7625.123110842254;8027.79930501737;8037.557934313618;8233.958830205856;8235.217654322845;8031.076426210988;8191.508509489435;8201.630926608303;8206.466579672317;8213.383996200293;1989.2838578111869;2223.755386907439;2264.569731750966;2279.282026161754;2298.609236429811;2308.35366097493;2313.9190128345513;2318.466752646892;2318.9652155217686;2321.257197696738;2244.0911430870524;2283.280766558537;2286.085565773687;2286.314105768271;2289.210222473244;1991.8506112041655;2241.618924782783;2310.1798861404127;2311.167979527386;2327.2669109230537;2229.1306390507716;2242.4281808138985;2250.133698526079;2250.291158285151;2281.6121259385777;8157.55133467659;8177.223163799429;8214.096449390563;8218.547979861105;8227.8354432911;4936.160852655057;5085.74571271435;5098.515641014134;5100.821471248526;5108.3359163308905;3134.7492200624124;3202.1034110448877;3225.935481290361;3344.9331013379838;3354.698077173066;999.3354419311149;1012.3094432298006;1033.3025207984656;1036.5330513378187;1047.7171163785736;11550.711232219177;11577.94211028948;11679.7080072998;11739.413029348498;11740.11949103812;4370.737755734603;4474.731516109044;4498.482674492475;4508.0533088051225;4555.293929440942;9972.80054398908;10032.1472674822;10043.69868903934;10048.59805607782;10051.748706282402;4368.825246990148;4937.8271760488215;4980.7509624518625;4987.875303117451;5004.524570165829;4479.7984090716;4586.954130458653;4593.770311484413;4627.514111018362;4630.560096790799;3726.2733766915735;3761.7366784324836;3793.943090853639;3816.885493435201;3848.7113466490127;1186.6202815099257;1206.1135065726685;1208.0215025829107;1227.7544491101814;1229.4344601483417;825.5376988886123;830.5598033042497;841.0286119531951;844.2064459408136;861.173273657296;5306.602004849575;5476.069068258405;5526.972365138229;5568.972155139199;5585.301837270341;421.5826331931366;425.1603083909316;425.25580234589466;431.0731926358355;435.13842591668674;3697.0757310672334;3705.2589482103685;3759.2293579816073;3763.41667041609;3792.241551689673;10055.798884022424;10440.68677939663;10510;10523.158147348193;10544;10300.896991030144;10369.429681367597;10390.116840068678;10403.167746580255;10429.947850260853;7658.578778167142;7708.099852224992;7718.189590093071;7804.3756499479905;7832.981712377468;5351.5718742501285;5376.381716102698;5384.219288203267;5404.648697834628;5408.513233808976;9653.517324133905;9737.561809718722;9742.220622350053;9785.755356116155;9851.901480985385;9680.370775899826;9952;10054.798904021733;10055.849162262719;10108.090271875566;6645.368689974444;6968.721251149897;7210.351068403869;7327.377172940147;7442.590657513672;7990.3208227299;8020.558869262013;8043.19568043191;8044.2760151586635;8060.395470339865;7087.574745515286;7247.420206383371;7257.52826066304;7363.668634911334;7403.370713489414;7247.891281630675;7258.745943891939;7261.346478816932;7292.854142917005;7304.123505179413;6377.7767778127545;6435.806925792233;6449.097126402401;6457.870842583216;6471.7734879279;4681.742504162167;4849.515048495122;4854.320395144612;4864.246041863516;4899.16714158601;4714.15145273854;4729.69256998294;4768.475467698481;4814.638902082288;4842.297866809364 03:03:31 INFO - PROCESS | 26944 | |4;prototype.html;325.2632786738039;325.5686215764112;332.93341331733654;333.46478901363326;334.1795891087379;5283.498067683574;5290.5767538596965;5343.492368225013;5344.278522399475;5353.437889021655;5274.4461831507715;5298.4966428189355;5304.310439642841;5305.310309659739;5362.758675859586;3975.2769352993146;4029;4100.056986893016;4129.91740165198;4136.482939632546;4103.343465045593;4107.732997355162;4114.444549985744;4117.897052573695;4150.543440221589;3916.471276377695;4131.0498585325395;4136.5242997055275;4138.544760076389;4142.2543942090415;3988.940165897514;4047.170330082326;4050.4531888195306;4087.5299340575916;4092.856750013735;3537.6462353764673;3542.3800834853796;3572.5534308211472;3586.1572530455583;3586.659267369596;5116.769745361467;5143.177091665316;5147.3051138096625;5148.845534633967;5175.715335656538;4597.724126557376;4711.552402521755;4731.455882573514;4744.739039352834;4754.833580824655;5441.238226648273;5472.318563903698;5547.833564993057;5551.694656793875;5578;3945.9740467478377;3952.7628342299554;3960.524737031546;3961.722679412442;4004.5194576650697;5596.1179992304;5660.915086273709;5707.24430896945;5731.885362292731;5744.080947048494;4079.8572049978106;4101.753894766323;4117.258893399157;4123.299039163349;4126.09225970286;4168.936376493655;4172.144710334374;4174.979125104355;4194.328907374806;4216.599423054805;4406.515283318832;4617.930731039037;4624.219675424918;4746;4760.928586071212;5527;5558.6942718150085;5562.110062389998;5588.748506317225;5610.775568977277;1377.7795552711518;1386.923719195454;1387.9028468007346;1406.8382136054486;1408.6760045189665;889.088684098791;901.8241442918699;943.9899307740651;957.3011701457835;958.8178246133212;5304.893902121936;5334.706591137525;5337.733113344318;5377.166539186433;5380.596455265871;5599.664020158803;5635.408282130317;5657.321121465368;5684.232628595169;5687.544996400278;5089.745512724349;5364.436734142937;5372.8716969436855;5384.892302153935;5410.97294513525;2994.625671791026;3002.174402039413;3022.6221722284713;3045.8020228685064;3046.9238269043453;5670.376258611549;5776.422357764274;5893.764249430061;5897.32180799205;5905.557083218776;5817.476427121579;5861;5901.58688891782;5905;5911.527077833849;5865.472107510344;5871.882562348729;5922.674252916131;5927.051671732502;5948.881022379528;5561.357310961327;5765.94234057654;5768.884622307614;5770.460997161235;5794.85512862165;5655.264815573949;5693.4875861172695;5709.286339207599;5720.570957178312;5739;5649.322081350264;5909.793157239476;6002.159697642246;6044.788432404845;6069.514438844793;3951.8616848410165;3967.821448034903;3969.5633480316565;3992.3612222044335;4001.0594861491572;5795.1017592273265;5831.970840145772;5841.386654401396;5855.824325270249;5874.794382196603;5343.62594618373;5588;5601.859953501195;5717.771289148387;5730.799422020209;5577.972110139423;5589.80435684749;5608.551315894801;5636.830895073154;5640.435956404327;5301;5343.118385466354;5519.862003449946;5528.391876893619;5536.307961504812;5592.944070559242;5609.214709940693;5617.887642247214;5624.553319306115;5679.602427830012;5486.341639003345;5497.47773961473;5521.861953451196;5530.617345663584;5544.750486228048 03:03:31 INFO - PROCESS | 26944 | |5;yui.html;643.8808820368236;668.3049628386477;682.8156397772599;693.2443636436284;711.3882061427173;12512.81230781539;12924.806127908078;13391.799123013137;13419.19484830911;13467.393967271471;11638.941805290962;11640.243384180043;11676;11720.648380548597;11797.233179843304;496.5679858523072;564.7486868343589;565.5108331293433;578.8003138917067;583.1456915618618;572.6764378126367;576.8875069361476;577.5523968924075;577.8613132848108;577.9682117483537;602.8372339468341;604.6764980735308;604.8366940925947;604.927408710953;605.3250625552499;517.1002455727026;586.6949186423036;601.1943995046659;601.4857297011037;606.4451027310006;440.8324836562118;441.1794063042738;441.2080315833055;441.22124450345166;441.4812595200626;10758;10762.192835537366;10779.137668986541;10791;10813.729656758565;11945.940270298679;11966.461509232018;12355.073369497324;12440.19138755978;12716.491340346374;11163.330200188015;11189.384583847885;11432.599154177633;11577.94211028948;11708.707282317924;3707.796071216082;3719.3863012602887;4194.077302993336;4220.599043090901;4316.3741257517795;59292.70353648247;59641.70179149076;59881.40118598802;60117.098243526816;60365.69817150886;9266.768330791785;9773.41359518431;9908.950455247821;9994.500274986221;10174.593016279414;15364.539063828102;15435.30541125652;15441.30514126867;15445.382184712711;15689.372425103096;7864.174261702553;7945.32464740492;7955.7613271600785;8134.3085837703275;8202.26179643835;4637.420322459692;4717.2216584263215;4725.149473094876;4841.080194762983;4874.8781280467565;3122.125804774667;3176.745860331168;3182.427163110616;3190.9042728718177;3193.2655489237604;574.1502576187266;591.482452853753;593.2051051590889;594.5481434110108;597.1699337920294;523.3275241314892;601.3715667127861;611.4222060153202;675.0279597379757;717.4188906985358;9508.857367139499;9628.351420363892;9712;9848.847889461289;9874.308798384043;692.5740669488229;700.1633048507088;714.1644276196862;715.441955274876;721.7365661533607;4571.46855803303;4582.9770851146195;4603.769811509411;4640.744759038285;4795.976020119947;66653.66673166603;67652.3234767646;67905;67952.3204767946;68219.65890170616;61257.38742612517;61623.6918815412;62339.68830155911;62464;62802.01417493072;53409.732951335;54143.45856541463;54753.45246547484;55209.447905521236;56235.43764562384;8940.15068568485;8952.597133129155;8956.910430895608;8957.41776784533;8987.865182022144;38227.617723822405;38251;38575;38640.806795965844;38844.6115538841;46194.076118478115;49543.50456495389;50518.242226365895;50793.746031269606;51353;10301.74245643865;10307.433091179757;10508.842367364343;10531.262811603114;10934.890651093387;12166.939165304117;12601.306928119042;12630.242185468902;12766.489340426651;13332.93333533326;12006;12035.578754743892;12253.142280040312;12279.69300767488;12327.013838892688;11565.36390498497;11580.6525804226;11602.88397116018;12016.459259333526;12271.754564908473;11433.885661143615;11473.139514536277;11486.885131148581;11697.23967942081;12199.207051541622;8925.687600933936;9043.140901614335;9242.260619150318;9288.426943833916;9371.484568348806;10190.235732320254;10205.59177632916;10250.538725757508;10310.484475776031;10392.636257730943 03:03:31 INFO - PROCESS | 26944 | __end_tp_report 03:03:31 INFO - PROCESS | 26944 | __start_cc_report 03:03:31 INFO - PROCESS | 26944 | _x_x_mozilla_cycle_collect,788 03:03:31 INFO - PROCESS | 26944 | __end_cc_report 03:03:31 INFO - PROCESS | 26944 | __startTimestamp1463652211697__endTimestamp 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | ------- Summary: start ------- 03:03:31 INFO - PROCESS | 26944 | Number of tests: 6 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | [#0] dojo.html Cycles:165 Average:5376.28 Median:5560.39 stddev:635.66 (11.4%) stddev-sans-first:611.07 03:03:31 INFO - PROCESS | 26944 | Values: 3059.6 3079.3 3097.6 3141.2 3146.7 5267.5 5339.4 5344.8 5433.2 5472.5 5322.1 5340.1 5353.5 5369.4 5406.2 4756.2 4777.5 4906.1 4922.5 4952.4 4875.1 4900.8 4936.8 4948.9 4949.7 4700.4 4833.6 4846.1 4870.9 4874.1 4880.3 4896.4 4905.3 4914.9 4929.7 4691.8 4773.6 4850.2 4862.7 4885.2 5291.7 5363.7 5364.9 5404.8 5419.0 5801.2 5847.3 5860.0 5863.3 5870.1 5690.1 5757.7 5794.9 5927.1 5938.9 5474.6 5508.3 5517.6 5526.5 5526.7 6024.6 6025.8 6034.2 6034.3 6038.8 5483.6 5619.8 5671.3 5684.8 5779.8 5817.2 5819.4 5821.6 5857.3 5880.9 5713.1 5725.8 5763.8 5779.5 5781.3 5528.1 5745.6 5806.0 5807.3 5858.6 4431.8 4442.8 4444.2 4446.0 4480.2 3858.3 3944.4 3958.1 3978.0 3997.9 5494.8 5510.0 5551.3 5560.4 5590.6 5926.9 5933.5 5940.9 5941.7 5941.8 5338.3 5484.8 5580.8 5587.0 5587.2 4861.2 4863.7 4888.6 4891.4 4917.3 6087.8 6090.5 6093.4 6101.4 6105.0 5686.7 5753.4 5826.9 5912.6 5920.6 6007.4 6019.7 6022.0 6024.6 6056.1 5701.6 5712.5 5762.0 5762.5 5766.3 5613.4 5786.8 5834.7 5855.1 5862.1 5687.3 5717.5 5725.5 5733.9 5736.1 5700.3 5721.1 5724.2 5724.9 5725.1 5381.1 5398.1 5421.1 5447.3 5456.1 5577.5 5577.5 5636.3 5639.4 5643.1 5421.2 5425.9 5472.4 5478.4 5511.6 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | [#1] ext.html Cycles:180 Average:54981.85 Median:36408.14 stddev:117443.70 (322.6%) stddev-sans-first:117702.14 03:03:31 INFO - PROCESS | 26944 | Values: 582.2 586.5 588.8 590.9 625.9 35330.8 36268.5 36355.3 36390.0 38270.0 36607.8 37222.4 37254.1 37327.1 37516.0 8335.8 8443.7 8501.7 8507.5 8513.5 8224.5 8311.4 8311.8 8313.5 8315.4 8478.8 8522.8 8543.9 8545.6 8546.6 8468.4 8506.6 8510.1 8523.1 8525.0 8412.9 8495.3 8508.0 8510.5 8516.1 35991.1 36345.8 36388.5 36426.3 36460.8 2967.1 2989.8 3056.3 3118.6 3248.6 28278.0 28511.9 28562.3 28587.4 29472.3 3535.8 3730.9 3740.7 3775.5 3802.9 299070.0 376804.0 377210.0 377430.0 378633.0 42842.8 46557.5 47808.8 48359.5 48502.0 48717.0 48952.3 48962.3 48975.1 49021.0 13722.7 13850.9 13885.9 13902.7 13908.8 9588.6 10263.0 10460.8 10489.4 10504.2 15148.9 15300.7 15541.1 15546.5 15552.4 6019.8 6059.4 6079.5 6169.4 6242.9 851.5 908.7 923.1 936.7 991.1 27445.2 28550.4 28878.0 29086.6 29164.6 970.0 970.9 991.3 1008.5 1053.6 13806.2 13914.9 14044.9 14151.7 14163.4 577312.0 581668.0 581864.0 582308.0 583823.0 44752.8 44774.8 45150.5 45183.7 45184.1 1103.9 1176.9 1191.5 1198.0 1206.5 25938.6 28710.4 29075.0 29097.4 29153.0 37141.3 37474.0 37527.4 37574.8 37615.0 329502.0 330734.0 331651.0 332383.0 334350.0 20740.0 22945.1 22951.2 23818.8 24247.9 34834.7 38630.6 38671.2 39399.4 39477.8 33092.7 33549.0 33604.5 33680.3 33783.5 33972.5 33979.7 34337.7 34347.0 34783.3 33423.3 34004.0 34165.0 34264.3 34270.5 30250.0 30625.1 30735.8 31057.7 31177.8 23349.3 24235.8 24238.0 24497.5 24973.5 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | [#2] jquery.html Cycles:180 Average:27646.12 Median:237375.50 stddev:78379.89 (33.0%) stddev-sans-first:78573.02 03:03:31 INFO - PROCESS | 26944 | Values: 375.4 379.5 380.6 393.9 396.2 16855.7 18295.0 18664.7 18830.2 18852.9 15912.9 15968.7 15973.3 16465.4 16469.4 5536.7 5660.2 5714.7 5722.0 5723.7 4111.4 4568.0 6145.0 6168.2 6262.2 6185.9 6193.9 6195.3 6199.8 6203.8 5218.6 5473.4 5483.8 5515.0 5568.5 3657.9 5001.0 5228.1 5262.2 5381.4 11961.2 12105.6 12135.5 18794.2 20951.4 2248.6 2293.3 2305.5 2390.9 2400.2 8742.0 9122.3 9394.3 9412.9 9718.9 1825.9 1834.7 1842.1 1945.8 2019.0 75657.0 79537.0 84026.6 85285.6 86788.0 10125.6 10340.8 10344.8 10420.2 10907.7 13911.0 13972.3 14045.6 14076.4 14128.4 7240.3 7430.3 7515.2 7615.3 7670.2 7143.5 7196.2 7197.0 7413.0 7436.6 4132.4 4192.2 4263.5 4300.6 4354.9 1796.9 1861.8 1869.4 1876.9 1912.9 794.6 897.0 915.1 925.8 945.9 16682.2 17284.7 17510.2 17512.2 18049.4 877.2 885.0 886.0 888.5 929.5 9304.6 9880.9 9945.9 10002.1 10016.5 470183.0 473828.0 474741.0 474879.0 475224.0 76961.6 92786.5 94054.0 95116.5 95691.5 428.8 858.5 888.4 890.5 893.5 9792.9 9894.6 9961.4 9971.7 10066.6 38852.6 39096.8 39120.4 40665.4 41248.6 55895.7 59014.8 59250.4 60404.0 60754.0 8127.4 8260.7 8411.7 8416.1 8511.7 12121.7 12326.0 12565.2 12649.5 12713.7 11018.8 11024.7 11028.2 11047.0 11050.3 10736.0 10832.5 10964.8 11035.8 11166.0 11039.1 11398.1 11403.7 11462.5 11600.4 8242.2 8250.8 8312.3 8361.3 8423.4 8335.2 10789.3 11343.1 11350.3 11408.5 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | [#3] mootools.html Cycles:180 Average:5465.73 Median:4629.04 stddev:3162.28 (68.3%) stddev-sans-first:3153.59 03:03:31 INFO - PROCESS | 26944 | Values: 1031.9 1222.8 1226.5 1255.5 1417.7 7625.1 8027.8 8037.6 8234.0 8235.2 8031.1 8191.5 8201.6 8206.5 8213.4 1989.3 2223.8 2264.6 2279.3 2298.6 2308.4 2313.9 2318.5 2319.0 2321.3 2244.1 2283.3 2286.1 2286.3 2289.2 1991.9 2241.6 2310.2 2311.2 2327.3 2229.1 2242.4 2250.1 2250.3 2281.6 8157.6 8177.2 8214.1 8218.5 8227.8 4936.2 5085.7 5098.5 5100.8 5108.3 3134.7 3202.1 3225.9 3344.9 3354.7 999.3 1012.3 1033.3 1036.5 1047.7 11550.7 11577.9 11679.7 11739.4 11740.1 4370.7 4474.7 4498.5 4508.1 4555.3 9972.8 10032.1 10043.7 10048.6 10051.7 4368.8 4937.8 4980.8 4987.9 5004.5 4479.8 4587.0 4593.8 4627.5 4630.6 3726.3 3761.7 3793.9 3816.9 3848.7 1186.6 1206.1 1208.0 1227.8 1229.4 825.5 830.6 841.0 844.2 861.2 5306.6 5476.1 5527.0 5569.0 5585.3 421.6 425.2 425.3 431.1 435.1 3697.1 3705.3 3759.2 3763.4 3792.2 10055.8 10440.7 10510.0 10523.2 10544.0 10300.9 10369.4 10390.1 10403.2 10429.9 7658.6 7708.1 7718.2 7804.4 7833.0 5351.6 5376.4 5384.2 5404.6 5408.5 9653.5 9737.6 9742.2 9785.8 9851.9 9680.4 9952.0 10054.8 10055.8 10108.1 6645.4 6968.7 7210.4 7327.4 7442.6 7990.3 8020.6 8043.2 8044.3 8060.4 7087.6 7247.4 7257.5 7363.7 7403.4 7247.9 7258.7 7261.3 7292.9 7304.1 6377.8 6435.8 6449.1 6457.9 6471.8 4681.7 4849.5 4854.3 4864.2 4899.2 4714.2 4729.7 4768.5 4814.6 4842.3 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | [#4] prototype.html Cycles:180 Average:4684.87 Median:5358.10 stddev:1393.04 (26.0%) stddev-sans-first:1357.97 03:03:31 INFO - PROCESS | 26944 | Values: 325.3 325.6 332.9 333.5 334.2 5283.5 5290.6 5343.5 5344.3 5353.4 5274.4 5298.5 5304.3 5305.3 5362.8 3975.3 4029.0 4100.1 4129.9 4136.5 4103.3 4107.7 4114.4 4117.9 4150.5 3916.5 4131.0 4136.5 4138.5 4142.3 3988.9 4047.2 4050.5 4087.5 4092.9 3537.6 3542.4 3572.6 3586.2 3586.7 5116.8 5143.2 5147.3 5148.8 5175.7 4597.7 4711.6 4731.5 4744.7 4754.8 5441.2 5472.3 5547.8 5551.7 5578.0 3946.0 3952.8 3960.5 3961.7 4004.5 5596.1 5660.9 5707.2 5731.9 5744.1 4079.9 4101.8 4117.3 4123.3 4126.1 4168.9 4172.1 4175.0 4194.3 4216.6 4406.5 4617.9 4624.2 4746.0 4760.9 5527.0 5558.7 5562.1 5588.7 5610.8 1377.8 1386.9 1387.9 1406.8 1408.7 889.1 901.8 944.0 957.3 958.8 5304.9 5334.7 5337.7 5377.2 5380.6 5599.7 5635.4 5657.3 5684.2 5687.5 5089.7 5364.4 5372.9 5384.9 5411.0 2994.6 3002.2 3022.6 3045.8 3046.9 5670.4 5776.4 5893.8 5897.3 5905.6 5817.5 5861.0 5901.6 5905.0 5911.5 5865.5 5871.9 5922.7 5927.1 5948.9 5561.4 5765.9 5768.9 5770.5 5794.9 5655.3 5693.5 5709.3 5720.6 5739.0 5649.3 5909.8 6002.2 6044.8 6069.5 3951.9 3967.8 3969.6 3992.4 4001.1 5795.1 5832.0 5841.4 5855.8 5874.8 5343.6 5588.0 5601.9 5717.8 5730.8 5578.0 5589.8 5608.6 5636.8 5640.4 5301.0 5343.1 5519.9 5528.4 5536.3 5592.9 5609.2 5617.9 5624.6 5679.6 5486.3 5497.5 5521.9 5530.6 5544.8 03:03:31 INFO - PROCESS | 26944 | 03:03:31 INFO - PROCESS | 26944 | [#5] yui.html Cycles:180 Average:15115.53 Median:4857.98 stddev:19048.30 (392.1%) stddev-sans-first:19070.74 03:03:31 INFO - PROCESS | 26944 | Values: 643.9 668.3 682.8 693.2 711.4 12512.8 12924.8 13391.8 13419.2 13467.4 11638.9 11640.2 11676.0 11720.6 11797.2 496.6 564.7 565.5 578.8 583.1 572.7 576.9 577.6 577.9 578.0 602.8 604.7 604.8 604.9 605.3 517.1 586.7 601.2 601.5 606.4 440.8 441.2 441.2 441.2 441.5 10758.0 10762.2 10779.1 10791.0 10813.7 11945.9 11966.5 12355.1 12440.2 12716.5 11163.3 11189.4 11432.6 11577.9 11708.7 3707.8 3719.4 4194.1 4220.6 4316.4 59292.7 59641.7 59881.4 60117.1 60365.7 9266.8 9773.4 9909.0 9994.5 10174.6 15364.5 15435.3 15441.3 15445.4 15689.4 7864.2 7945.3 7955.8 8134.3 8202.3 4637.4 4717.2 4725.1 4841.1 4874.9 3122.1 3176.7 3182.4 3190.9 3193.3 574.2 591.5 593.2 594.5 597.2 523.3 601.4 611.4 675.0 717.4 9508.9 9628.4 9712.0 9848.8 9874.3 692.6 700.2 714.2 715.4 721.7 4571.5 4583.0 4603.8 4640.7 4796.0 66653.7 67652.3 67905.0 67952.3 68219.7 61257.4 61623.7 62339.7 62464.0 62802.0 53409.7 54143.5 54753.5 55209.4 56235.4 8940.2 8952.6 8956.9 8957.4 8987.9 38227.6 38251.0 38575.0 38640.8 38844.6 46194.1 49543.5 50518.2 50793.7 51353.0 10301.7 10307.4 10508.8 10531.3 10934.9 12166.9 12601.3 12630.2 12766.5 13332.9 12006.0 12035.6 12253.1 12279.7 12327.0 11565.4 11580.7 11602.9 12016.5 12271.8 11433.9 11473.1 11486.9 11697.2 12199.2 8925.7 9043.1 9242.3 9288.4 9371.5 10190.2 10205.6 10250.5 10310.5 10392.6 03:03:31 INFO - PROCESS | 26944 | -------- Summary: end -------- 03:03:31 INFO - PROCESS | 26944 | 03:03:32 INFO - TEST-INFO | 26944: exit 0 03:03:32 INFO - TEST-OK | dromaeo_css | took 1112357ms 03:03:32 INFO - TEST-START | kraken 03:03:32 INFO - operating with platform_type : linux_ 03:03:32 INFO - Initialising browser for kraken test... 03:03:32 INFO - TEST-INFO | started process 27123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5mNNuW/profile http://localhost:56640/getInfo.html) 03:03:36 INFO - PROCESS | 27123 | __metrics Screen width/height:1600/1200 03:03:36 INFO - PROCESS | 27123 | colorDepth:24 03:03:36 INFO - PROCESS | 27123 | Browser inner width/height: 1024/697 03:03:36 INFO - PROCESS | 27123 | __metrics 03:03:37 ERROR - PROCESS | 27123 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:03:38 INFO - TEST-INFO | 27123: exit 0 03:03:38 INFO - Browser initialized. 03:03:38 INFO - Running cycle 1/1 for kraken test... 03:03:38 INFO - TEST-INFO | started process 27205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5mNNuW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:50 INFO - PROCESS | 27205 | RSS: Main: 153182208 03:03:50 INFO - PROCESS | 27205 | 03:03:53 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56640/tests/kraken/driver.html?testName=audio-beat-detection) 03:03:53 INFO - PROCESS | 27205 | RSS: Main: 208572416 03:03:53 INFO - PROCESS | 27205 | 03:03:56 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56640/tests/kraken/driver.html?testName=audio-dft) 03:03:57 INFO - PROCESS | 27205 | RSS: Main: 198307840 03:03:57 INFO - PROCESS | 27205 | 03:04:00 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56640/tests/kraken/driver.html?testName=audio-fft) 03:04:01 INFO - PROCESS | 27205 | RSS: Main: 266014720 03:04:01 INFO - PROCESS | 27205 | 03:04:03 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56640/tests/kraken/driver.html?testName=audio-oscillator) 03:04:03 INFO - PROCESS | 27205 | RSS: Main: 175050752 03:04:03 INFO - PROCESS | 27205 | 03:04:06 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:06 INFO - PROCESS | 27205 | RSS: Main: 179482624 03:04:06 INFO - PROCESS | 27205 | 03:04:09 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56640/tests/kraken/driver.html?testName=imaging-darkroom) 03:04:10 INFO - PROCESS | 27205 | RSS: Main: 215314432 03:04:10 INFO - PROCESS | 27205 | 03:04:14 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56640/tests/kraken/driver.html?testName=imaging-desaturate) 03:04:14 INFO - PROCESS | 27205 | RSS: Main: 213209088 03:04:14 INFO - PROCESS | 27205 | 03:04:17 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56640/tests/kraken/driver.html?testName=json-parse-financial) 03:04:18 INFO - PROCESS | 27205 | RSS: Main: 214401024 03:04:18 INFO - PROCESS | 27205 | 03:04:20 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:04:20 INFO - PROCESS | 27205 | RSS: Main: 202313728 03:04:20 INFO - PROCESS | 27205 | 03:04:22 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:04:23 INFO - PROCESS | 27205 | RSS: Main: 205746176 03:04:23 INFO - PROCESS | 27205 | 03:04:25 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:04:25 INFO - PROCESS | 27205 | RSS: Main: 216162304 03:04:25 INFO - PROCESS | 27205 | 03:04:28 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:04:29 INFO - PROCESS | 27205 | RSS: Main: 225030144 03:04:29 INFO - PROCESS | 27205 | 03:04:31 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:04:32 INFO - PROCESS | 27205 | RSS: Main: 221151232 03:04:32 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | Cycle 1(1): loaded http://localhost:56640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56640/tests/kraken/driver.html?testName=ai-astar) 03:04:34 INFO - PROCESS | 27205 | RSS: Main: 267313152 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | __start_tp_report 03:04:34 INFO - PROCESS | 27205 | _x_x_mozilla_page_load 03:04:34 INFO - PROCESS | 27205 | _x_x_mozilla_page_load_details 03:04:34 INFO - PROCESS | 27205 | |i|pagename|runs| 03:04:34 INFO - PROCESS | 27205 | |0;ai-astar;113;108;112;112;113;111;113;111;112;114 03:04:34 INFO - PROCESS | 27205 | |1;audio-beat-detection;159;127;160;215;127;156;159;126;184;125 03:04:34 INFO - PROCESS | 27205 | |2;audio-dft;162;162;161;160;161;161;161;161;161;161 03:04:34 INFO - PROCESS | 27205 | |3;audio-fft;75;75;75;169;75;74;75;76;139;75 03:04:34 INFO - PROCESS | 27205 | |4;audio-oscillator;92;92;159;92;92;92;121;92;92;134 03:04:34 INFO - PROCESS | 27205 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;116;117;117 03:04:34 INFO - PROCESS | 27205 | |6;imaging-darkroom;146;145;145;145;145;145;145;145;145;146 03:04:34 INFO - PROCESS | 27205 | |7;imaging-desaturate;95;95;95;95;94;96;95;96;94;94 03:04:34 INFO - PROCESS | 27205 | |8;json-parse-financial;55;55;55;56;55;56;54;109;53;53 03:04:34 INFO - PROCESS | 27205 | |9;json-stringify-tinderbox;62;62;62;63;63;62;62;62;63;63 03:04:34 INFO - PROCESS | 27205 | |10;stanford-crypto-aes;83;78;78;78;80;79;79;80;78;78 03:04:34 INFO - PROCESS | 27205 | |11;stanford-crypto-ccm;122;119;120;116;120;120;122;140;189;131 03:04:34 INFO - PROCESS | 27205 | |12;stanford-crypto-pbkdf2;164;160;158;159;158;161;159;161;158;164 03:04:34 INFO - PROCESS | 27205 | |13;stanford-crypto-sha256-iterative;62;67;62;63;63;61;62;65;61;61 03:04:34 INFO - PROCESS | 27205 | __end_tp_report 03:04:34 INFO - PROCESS | 27205 | __start_cc_report 03:04:34 INFO - PROCESS | 27205 | _x_x_mozilla_cycle_collect,1835 03:04:34 INFO - PROCESS | 27205 | __end_cc_report 03:04:34 INFO - PROCESS | 27205 | __startTimestamp1463652274403__endTimestamp 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | ------- Summary: start ------- 03:04:34 INFO - PROCESS | 27205 | Number of tests: 14 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:1.66 (1.5%) stddev-sans-first:1.72 03:04:34 INFO - PROCESS | 27205 | Values: 113.0 108.0 112.0 112.0 113.0 111.0 113.0 111.0 112.0 114.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:159.00 stddev:29.43 (18.5%) stddev-sans-first:31.15 03:04:34 INFO - PROCESS | 27205 | Values: 159.0 127.0 160.0 215.0 127.0 156.0 159.0 126.0 184.0 125.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 03:04:34 INFO - PROCESS | 27205 | Values: 162.0 162.0 161.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#3] audio-fft Cycles:10 Average:90.80 Median:75.00 stddev:34.05 (45.4%) stddev-sans-first:35.64 03:04:34 INFO - PROCESS | 27205 | Values: 75.0 75.0 75.0 169.0 75.0 74.0 75.0 76.0 139.0 75.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:92.00 stddev:24.01 (26.1%) stddev-sans-first:24.94 03:04:34 INFO - PROCESS | 27205 | Values: 92.0 92.0 159.0 92.0 92.0 92.0 121.0 92.0 92.0 134.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:04:34 INFO - PROCESS | 27205 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 03:04:34 INFO - PROCESS | 27205 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:04:34 INFO - PROCESS | 27205 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 95.0 96.0 94.0 94.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:55.00 stddev:17.21 (31.3%) stddev-sans-first:18.16 03:04:34 INFO - PROCESS | 27205 | Values: 55.0 55.0 55.0 56.0 55.0 56.0 54.0 109.0 53.0 53.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:04:34 INFO - PROCESS | 27205 | Values: 62.0 62.0 62.0 63.0 63.0 62.0 62.0 62.0 63.0 63.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.60 (2.0%) stddev-sans-first:0.87 03:04:34 INFO - PROCESS | 27205 | Values: 83.0 78.0 78.0 78.0 80.0 79.0 79.0 80.0 78.0 78.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:122.00 stddev:21.93 (18.0%) stddev-sans-first:23.07 03:04:34 INFO - PROCESS | 27205 | Values: 122.0 119.0 120.0 116.0 120.0 120.0 122.0 140.0 189.0 131.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:2.30 (1.4%) stddev-sans-first:1.99 03:04:34 INFO - PROCESS | 27205 | Values: 164.0 160.0 158.0 159.0 158.0 161.0 159.0 161.0 158.0 164.0 03:04:34 INFO - PROCESS | 27205 | 03:04:34 INFO - PROCESS | 27205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.95 (3.1%) stddev-sans-first:2.05 03:04:34 INFO - PROCESS | 27205 | Values: 62.0 67.0 62.0 63.0 63.0 61.0 62.0 65.0 61.0 61.0 03:04:34 INFO - PROCESS | 27205 | -------- Summary: end -------- 03:04:34 INFO - PROCESS | 27205 | 03:04:35 INFO - TEST-INFO | 27205: exit 0 03:04:35 INFO - TEST-OK | kraken | took 63045ms 03:04:35 INFO - SUITE-END | took 1175s 03:04:35 INFO - Completed test suite (00:19:35) 03:04:35 INFO - javascript benchmark 03:04:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.5716599676043, 3079.3379423423967, 3097.550855126007, 3141.246100935776, 3146.669599692032, 5267.499587539178, 5339.41266460689, 5344.839654810362, 5433.239346491489, 5472.50747432731, 5322.095243808552, 5340.145576707728, 5353.518183363496, 5369.382521010085, 5406.243125962358, 4756.215224487964, 4777.474477807438, 4906.092372911005, 4922.507749225067, 4952.356193694833, 4875.07373599015, 4900.803967841282, 4936.827211047614, 4948.925766113512, 4949.703017818924, 4700.435947686283, 4833.637477189207, 4846.079244943449, 4870.926936095943, 4874.073925954058, 4880.316755654176, 4896.363472748555, 4905.337779399807, 4914.901701965977, 4929.65492415531, 4691.812327506896, 4773.594244489223, 4850.248211527183, 4862.659613827033, 4885.2427873679635, 5291.682499050069, 5363.731813409314, 5364.892702145935, 5404.7838086476495, 5419.0, 5801.24583804107, 5847.2983242010805, 5860.0, 5863.2670916135485, 5870.11948207768, 5690.089585666315, 5757.68332741699, 5794.913076303858, 5927.140564618149, 5938.851528711773, 5474.562035037187, 5508.283923089973, 5517.613767036309, 5526.530244929186, 5526.668399896019, 6024.57827952048, 6025.758969641165, 6034.1853849730605, 6034.306054803666, 6038.849028774228, 5483.588730845203, 5619.80330688424, 5671.291088613923, 5684.77260909559, 5779.826605201851, 5817.185594016841, 5819.418058194146, 5821.592488525763, 5857.297124345106, 5880.94119058804, 5713.143028545668, 5725.77096916127, 5763.798267060716, 5779.479846813807, 5781.277340332458, 5528.115501519737, 5745.626534275259, 5806.0, 5807.274090738658, 5858.560607954335, 4431.8448854289945, 4442.777861106932, 4444.200043992112, 4446.021875187454, 4480.215962206601, 3858.2669292834835, 3944.4083387492105, 3958.148997965451, 3978.0, 3997.900052498711, 5494.752736126884, 5510.035743744828, 5551.306086739158, 5560.388357280696, 5590.608657393944, 5926.851828704317, 5933.465988061009, 5940.910886336708, 5941.673207973603, 5941.792037278675, 5338.3060202173465, 5484.7531861066345, 5580.832575022756, 5587.0, 5587.189857470726, 4861.246506791453, 4863.732494712754, 4888.584470320063, 4891.364122664031, 4917.28699338601, 6087.786927457518, 6090.451859332681, 6093.360197179321, 6101.389861013863, 6105.0, 5686.65880047182, 5753.367129615655, 5826.854328641818, 5912.6452412854505, 5920.615160014585, 6007.3992600739575, 6019.668918209365, 6021.969890150696, 6024.608400454132, 6056.06131049688, 5701.600887937971, 5712.514436272797, 5761.971190144022, 5762.481376676119, 5766.2503874497725, 5613.410591887793, 5786.797462088806, 5834.679092649945, 5855.121731740273, 5862.149988251595, 5687.260656114679, 5717.542596592346, 5725.541956643542, 5733.913991290217, 5736.139579063007, 5700.258966334516, 5721.084626459747, 5724.169995350734, 5724.856878578069, 5725.08398656213, 5381.1121165007335, 5398.08232600451, 5421.132618781134, 5447.346318441812, 5456.127019676833, 5577.470140336662, 5577.470140336662, 5636.2954630671165, 5639.351474580476, 5643.125315576092, 5421.241026256406, 5425.918611220756, 5472.425395333592, 5478.369987451494, 5511.559075274049], "value": 5332.016354321752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2285471749932, 586.5307753796963, 588.7762650192923, 590.8965930962081, 625.9217597800275, 35330.82334588327, 36268.455973160424, 36355.2728945421, 36390.0, 38270.0, 36607.81696091516, 37222.44166337507, 37254.06864828381, 37327.06682332936, 37516.0, 8335.791605209874, 8443.662253509883, 8501.744947651581, 8507.489550626951, 8513.53175575343, 8224.506529608212, 8311.376646751487, 8311.750647480556, 8313.542755148464, 8315.41792074555, 8478.78803029923, 8522.829543409129, 8543.871841922377, 8545.615447304886, 8546.61540230688, 8468.407211495198, 8506.617202225914, 8510.106438823896, 8523.14768523149, 8524.957375213084, 8412.906322178138, 8495.320374370036, 8507.95746021266, 8510.531920744357, 8516.06323304436, 35991.10022249465, 36345.81827090874, 36388.45417318743, 36426.271474570625, 36460.81769591162, 2967.065374407055, 2989.7757668174754, 3056.2664960409566, 3118.6413562440384, 3248.6101667800017, 28278.0, 28511.857440712873, 28562.285942851388, 28587.428251435063, 29472.26319342012, 3535.840887160084, 3730.9067273318115, 3740.682042026431, 3775.452559378875, 3802.9429558556644, 299070.0, 376804.0, 377210.0, 377430.0, 378633.0, 42842.78578607087, 46557.534424656, 47808.760956194994, 48359.516404836206, 48502.0, 48717.0, 48952.26571601429, 48962.26556601654, 48975.061496310336, 49021.0, 13722.725545489035, 13850.930745346208, 13885.861141388457, 13902.721945561032, 13908.791368129487, 9588.616455341848, 10263.0, 10460.790784184273, 10489.423081730425, 10504.212184086224, 15148.924255378653, 15300.693986120215, 15541.06753594788, 15546.533603991898, 15552.377904883679, 6019.789307374221, 6059.36376680451, 6079.540910181525, 6169.352218017133, 6242.937570624326, 851.4933614499363, 908.6547112097493, 923.132255679659, 936.681528280388, 991.1278075293695, 27445.176644700692, 28550.428991420056, 28877.989270375438, 29086.563701544495, 29164.562531562042, 970.0, 970.9416735758058, 991.2813210422386, 1008.4655132779639, 1053.5785685725618, 13806.240656763974, 13914.860851391559, 14044.921486781992, 14151.71696566063, 14163.362648680833, 577312.0, 581668.0, 581864.0, 582308.0, 583823.0, 44752.77623611861, 44774.77612611916, 45150.54849451529, 45183.707547782906, 45184.096318073454, 1103.8840921703265, 1176.87054424015, 1191.53530123252, 1197.988020119805, 1206.4691535724253, 25938.610920835825, 28710.425791483634, 29074.982375616753, 29097.418051639273, 29153.0, 37141.257174856895, 37474.0, 37527.43708844315, 37574.81212593919, 37615.0, 329502.0, 330734.0, 331651.0, 332383.0, 334350.0, 20740.0, 22945.082196711945, 22951.196708115134, 23818.76181238235, 24247.878760606083, 34834.65165348314, 38630.6136938627, 38671.22657546777, 39399.40900886431, 39477.802610986764, 33092.669073308956, 33549.0, 33604.49593256152, 33680.32639347248, 33783.49324760081, 33972.49041264432, 33979.66020339765, 34337.65662343444, 34347.0, 34783.304333913686, 33423.33153336968, 34004.0, 34165.0, 34264.31471370509, 34270.48594271138, 30250.0, 30625.081247562608, 30735.7926221336, 31057.669251059826, 31177.8441107793, 23349.299521013716, 24235.75764242335, 24238.0, 24497.510049798548, 24973.50264973488], "value": 17420.402388831015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.3899912641956, 379.510431543309, 380.6060727147403, 393.9231849789289, 396.2056077564483, 16855.66288674226, 18295.0, 18664.720029199554, 18830.15264313106, 18852.905735471304, 15912.920435397808, 15968.680626387466, 15973.281202345894, 16465.423710170147, 16469.423570175048, 5536.695481748512, 5660.2075709400715, 5714.657120572758, 5722.027255366597, 5723.742431590588, 4111.444954931091, 4567.995041090971, 6145.0, 6168.167297414837, 6262.154609127755, 6185.938140618604, 6193.876122477548, 6195.31851496335, 6199.752009919598, 6203.813885583417, 5218.608604354669, 5473.370562385337, 5483.835484935458, 5515.034868897967, 5568.49883510482, 3657.8536858525626, 5000.974995125038, 5228.111221092386, 5262.210668399733, 5381.381141168777, 11961.222520536137, 12105.576304829288, 12135.514579416813, 18794.24823007078, 20951.371458856258, 2248.572771173488, 2293.3005433342823, 2305.5388922215457, 2390.9282721518384, 2400.195934361991, 8742.0, 9122.27021838258, 9394.295427842939, 9412.90587094134, 9718.930917599058, 1825.9269629214816, 1834.6612453971497, 1842.060549119945, 1945.8248757611882, 2018.9596208075902, 75657.0, 79537.0, 84026.57986710088, 85285.57357213175, 86788.0, 10125.64560240388, 10340.844887326695, 10344.844827327595, 10420.166386689047, 10907.727306817234, 13911.0, 13972.301384930714, 14045.578632641038, 14076.436942522389, 14128.364223609962, 7240.275972402717, 7430.256974302634, 7515.248475152441, 7615.276548727862, 7670.156282808886, 7143.464240182007, 7196.244394338519, 7196.96401517989, 7412.96293518529, 7436.590987495631, 4132.359484279941, 4192.203481338536, 4263.467066616673, 4300.569943005675, 4354.934675979863, 1796.8562514998769, 1861.8138186181545, 1869.44851268876, 1876.934307299238, 1912.8660993730584, 794.6424109150905, 896.9506677132821, 915.0529202275612, 925.7870689741397, 945.8959514453404, 16682.249298781582, 17284.65430691379, 17510.21204045821, 17512.21195046226, 18049.368272110412, 877.2236570634907, 884.9690260840969, 886.0386480668418, 888.5157589113949, 929.5305870535336, 9304.581293841793, 9880.901190988141, 9945.900540994497, 10002.099811016898, 10016.54925528353, 470183.0, 473828.0, 474741.0, 474879.0, 475224.0, 76961.61519192369, 92786.53606731923, 94054.0, 95116.52441737747, 95691.52154239184, 428.8499025341168, 858.4934888415739, 888.3781353052889, 890.496869268861, 893.4728510179026, 9792.902070979198, 9894.554745036347, 9961.402315860782, 9971.650992215238, 10066.597336106473, 38852.6114738849, 39096.80451597724, 39120.41319380155, 40665.39001915033, 41248.587514124476, 55895.72052139713, 59014.81970360483, 59250.40749592449, 60404.0, 60754.0, 8127.431079824356, 8260.669573217245, 8411.747647570583, 8416.074231834371, 8511.702090426805, 12121.69695757613, 12326.0, 12565.246085234916, 12649.494020239088, 12713.745725085262, 11018.834717479405, 11024.724381890517, 11028.22802403824, 11047.0, 11050.33697978124, 10736.0, 10832.458377080957, 10964.818044181075, 11035.83446248323, 11166.0, 11039.116870650489, 11398.145139114766, 11403.714907127389, 11462.541498339973, 11600.419979001184, 8242.17578242171, 8250.834983300181, 8312.33501319905, 8361.331093512626, 8423.410361274897, 8335.208155225244, 10789.298695584763, 11343.092552595937, 11350.318980861175, 11408.54365825391], "value": 8477.78782364296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1031.886492485826, 1222.8349172861667, 1226.515526367085, 1255.522901297507, 1417.666848290652, 7625.123110842254, 8027.79930501737, 8037.557934313618, 8233.958830205856, 8235.217654322845, 8031.076426210988, 8191.508509489435, 8201.630926608303, 8206.466579672317, 8213.383996200293, 1989.2838578111869, 2223.755386907439, 2264.569731750966, 2279.282026161754, 2298.609236429811, 2308.35366097493, 2313.9190128345513, 2318.466752646892, 2318.9652155217686, 2321.257197696738, 2244.0911430870524, 2283.280766558537, 2286.085565773687, 2286.314105768271, 2289.210222473244, 1991.8506112041655, 2241.618924782783, 2310.1798861404127, 2311.167979527386, 2327.2669109230537, 2229.1306390507716, 2242.4281808138985, 2250.133698526079, 2250.291158285151, 2281.6121259385777, 8157.55133467659, 8177.223163799429, 8214.096449390563, 8218.547979861105, 8227.8354432911, 4936.160852655057, 5085.74571271435, 5098.515641014134, 5100.821471248526, 5108.3359163308905, 3134.7492200624124, 3202.1034110448877, 3225.935481290361, 3344.9331013379838, 3354.698077173066, 999.3354419311149, 1012.3094432298006, 1033.3025207984656, 1036.5330513378187, 1047.7171163785736, 11550.711232219177, 11577.94211028948, 11679.7080072998, 11739.413029348498, 11740.11949103812, 4370.737755734603, 4474.731516109044, 4498.482674492475, 4508.0533088051225, 4555.293929440942, 9972.80054398908, 10032.1472674822, 10043.69868903934, 10048.59805607782, 10051.748706282402, 4368.825246990148, 4937.8271760488215, 4980.7509624518625, 4987.875303117451, 5004.524570165829, 4479.7984090716, 4586.954130458653, 4593.770311484413, 4627.514111018362, 4630.560096790799, 3726.2733766915735, 3761.7366784324836, 3793.943090853639, 3816.885493435201, 3848.7113466490127, 1186.6202815099257, 1206.1135065726685, 1208.0215025829107, 1227.7544491101814, 1229.4344601483417, 825.5376988886123, 830.5598033042497, 841.0286119531951, 844.2064459408136, 861.173273657296, 5306.602004849575, 5476.069068258405, 5526.972365138229, 5568.972155139199, 5585.301837270341, 421.5826331931366, 425.1603083909316, 425.25580234589466, 431.0731926358355, 435.13842591668674, 3697.0757310672334, 3705.2589482103685, 3759.2293579816073, 3763.41667041609, 3792.241551689673, 10055.798884022424, 10440.68677939663, 10510.0, 10523.158147348193, 10544.0, 10300.896991030144, 10369.429681367597, 10390.116840068678, 10403.167746580255, 10429.947850260853, 7658.578778167142, 7708.099852224992, 7718.189590093071, 7804.3756499479905, 7832.981712377468, 5351.5718742501285, 5376.381716102698, 5384.219288203267, 5404.648697834628, 5408.513233808976, 9653.517324133905, 9737.561809718722, 9742.220622350053, 9785.755356116155, 9851.901480985385, 9680.370775899826, 9952.0, 10054.798904021733, 10055.849162262719, 10108.090271875566, 6645.368689974444, 6968.721251149897, 7210.351068403869, 7327.377172940147, 7442.590657513672, 7990.3208227299, 8020.558869262013, 8043.19568043191, 8044.2760151586635, 8060.395470339865, 7087.574745515286, 7247.420206383371, 7257.52826066304, 7363.668634911334, 7403.370713489414, 7247.891281630675, 7258.745943891939, 7261.346478816932, 7292.854142917005, 7304.123505179413, 6377.7767778127545, 6435.806925792233, 6449.097126402401, 6457.870842583216, 6471.7734879279, 4681.742504162167, 4849.515048495122, 4854.320395144612, 4864.246041863516, 4899.16714158601, 4714.15145273854, 4729.69256998294, 4768.475467698481, 4814.638902082288, 4842.297866809364], "value": 4274.251480740784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2632786738039, 325.5686215764112, 332.93341331733654, 333.46478901363326, 334.1795891087379, 5283.498067683574, 5290.5767538596965, 5343.492368225013, 5344.278522399475, 5353.437889021655, 5274.4461831507715, 5298.4966428189355, 5304.310439642841, 5305.310309659739, 5362.758675859586, 3975.2769352993146, 4029.0, 4100.056986893016, 4129.91740165198, 4136.482939632546, 4103.343465045593, 4107.732997355162, 4114.444549985744, 4117.897052573695, 4150.543440221589, 3916.471276377695, 4131.0498585325395, 4136.5242997055275, 4138.544760076389, 4142.2543942090415, 3988.940165897514, 4047.170330082326, 4050.4531888195306, 4087.5299340575916, 4092.856750013735, 3537.6462353764673, 3542.3800834853796, 3572.5534308211472, 3586.1572530455583, 3586.659267369596, 5116.769745361467, 5143.177091665316, 5147.3051138096625, 5148.845534633967, 5175.715335656538, 4597.724126557376, 4711.552402521755, 4731.455882573514, 4744.739039352834, 4754.833580824655, 5441.238226648273, 5472.318563903698, 5547.833564993057, 5551.694656793875, 5578.0, 3945.9740467478377, 3952.7628342299554, 3960.524737031546, 3961.722679412442, 4004.5194576650697, 5596.1179992304, 5660.915086273709, 5707.24430896945, 5731.885362292731, 5744.080947048494, 4079.8572049978106, 4101.753894766323, 4117.258893399157, 4123.299039163349, 4126.09225970286, 4168.936376493655, 4172.144710334374, 4174.979125104355, 4194.328907374806, 4216.599423054805, 4406.515283318832, 4617.930731039037, 4624.219675424918, 4746.0, 4760.928586071212, 5527.0, 5558.6942718150085, 5562.110062389998, 5588.748506317225, 5610.775568977277, 1377.7795552711518, 1386.923719195454, 1387.9028468007346, 1406.8382136054486, 1408.6760045189665, 889.088684098791, 901.8241442918699, 943.9899307740651, 957.3011701457835, 958.8178246133212, 5304.893902121936, 5334.706591137525, 5337.733113344318, 5377.166539186433, 5380.596455265871, 5599.664020158803, 5635.408282130317, 5657.321121465368, 5684.232628595169, 5687.544996400278, 5089.745512724349, 5364.436734142937, 5372.8716969436855, 5384.892302153935, 5410.97294513525, 2994.625671791026, 3002.174402039413, 3022.6221722284713, 3045.8020228685064, 3046.9238269043453, 5670.376258611549, 5776.422357764274, 5893.764249430061, 5897.32180799205, 5905.557083218776, 5817.476427121579, 5861.0, 5901.58688891782, 5905.0, 5911.527077833849, 5865.472107510344, 5871.882562348729, 5922.674252916131, 5927.051671732502, 5948.881022379528, 5561.357310961327, 5765.94234057654, 5768.884622307614, 5770.460997161235, 5794.85512862165, 5655.264815573949, 5693.4875861172695, 5709.286339207599, 5720.570957178312, 5739.0, 5649.322081350264, 5909.793157239476, 6002.159697642246, 6044.788432404845, 6069.514438844793, 3951.8616848410165, 3967.821448034903, 3969.5633480316565, 3992.3612222044335, 4001.0594861491572, 5795.1017592273265, 5831.970840145772, 5841.386654401396, 5855.824325270249, 5874.794382196603, 5343.62594618373, 5588.0, 5601.859953501195, 5717.771289148387, 5730.799422020209, 5577.972110139423, 5589.80435684749, 5608.551315894801, 5636.830895073154, 5640.435956404327, 5301.0, 5343.118385466354, 5519.862003449946, 5528.391876893619, 5536.307961504812, 5592.944070559242, 5609.214709940693, 5617.887642247214, 5624.553319306115, 5679.602427830012, 5486.341639003345, 5497.47773961473, 5521.861953451196, 5530.617345663584, 5544.750486228048], "value": 4238.353914869193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.8808820368236, 668.3049628386477, 682.8156397772599, 693.2443636436284, 711.3882061427173, 12512.81230781539, 12924.806127908078, 13391.799123013137, 13419.19484830911, 13467.393967271471, 11638.941805290962, 11640.243384180043, 11676.0, 11720.648380548597, 11797.233179843304, 496.5679858523072, 564.7486868343589, 565.5108331293433, 578.8003138917067, 583.1456915618618, 572.6764378126367, 576.8875069361476, 577.5523968924075, 577.8613132848108, 577.9682117483537, 602.8372339468341, 604.6764980735308, 604.8366940925947, 604.927408710953, 605.3250625552499, 517.1002455727026, 586.6949186423036, 601.1943995046659, 601.4857297011037, 606.4451027310006, 440.8324836562118, 441.1794063042738, 441.2080315833055, 441.22124450345166, 441.4812595200626, 10758.0, 10762.192835537366, 10779.137668986541, 10791.0, 10813.729656758565, 11945.940270298679, 11966.461509232018, 12355.073369497324, 12440.19138755978, 12716.491340346374, 11163.330200188015, 11189.384583847885, 11432.599154177633, 11577.94211028948, 11708.707282317924, 3707.796071216082, 3719.3863012602887, 4194.077302993336, 4220.599043090901, 4316.3741257517795, 59292.70353648247, 59641.70179149076, 59881.40118598802, 60117.098243526816, 60365.69817150886, 9266.768330791785, 9773.41359518431, 9908.950455247821, 9994.500274986221, 10174.593016279414, 15364.539063828102, 15435.30541125652, 15441.30514126867, 15445.382184712711, 15689.372425103096, 7864.174261702553, 7945.32464740492, 7955.7613271600785, 8134.3085837703275, 8202.26179643835, 4637.420322459692, 4717.2216584263215, 4725.149473094876, 4841.080194762983, 4874.8781280467565, 3122.125804774667, 3176.745860331168, 3182.427163110616, 3190.9042728718177, 3193.2655489237604, 574.1502576187266, 591.482452853753, 593.2051051590889, 594.5481434110108, 597.1699337920294, 523.3275241314892, 601.3715667127861, 611.4222060153202, 675.0279597379757, 717.4188906985358, 9508.857367139499, 9628.351420363892, 9712.0, 9848.847889461289, 9874.308798384043, 692.5740669488229, 700.1633048507088, 714.1644276196862, 715.441955274876, 721.7365661533607, 4571.46855803303, 4582.9770851146195, 4603.769811509411, 4640.744759038285, 4795.976020119947, 66653.66673166603, 67652.3234767646, 67905.0, 67952.3204767946, 68219.65890170616, 61257.38742612517, 61623.6918815412, 62339.68830155911, 62464.0, 62802.01417493072, 53409.732951335, 54143.45856541463, 54753.45246547484, 55209.447905521236, 56235.43764562384, 8940.15068568485, 8952.597133129155, 8956.910430895608, 8957.41776784533, 8987.865182022144, 38227.617723822405, 38251.0, 38575.0, 38640.806795965844, 38844.6115538841, 46194.076118478115, 49543.50456495389, 50518.242226365895, 50793.746031269606, 51353.0, 10301.74245643865, 10307.433091179757, 10508.842367364343, 10531.262811603114, 10934.890651093387, 12166.939165304117, 12601.306928119042, 12630.242185468902, 12766.489340426651, 13332.93333533326, 12006.0, 12035.578754743892, 12253.142280040312, 12279.69300767488, 12327.013838892688, 11565.36390498497, 11580.6525804226, 11602.88397116018, 12016.459259333526, 12271.754564908473, 11433.885661143615, 11473.139514536277, 11486.885131148581, 11697.23967942081, 12199.207051541622, 8925.687600933936, 9043.140901614335, 9242.260619150318, 9288.426943833916, 9371.484568348806, 10190.235732320254, 10205.59177632916, 10250.538725757508, 10310.484475776031, 10392.636257730943], "value": 6206.3768141170385, "unit": "score"}], "name": "dromaeo_css", "value": 6676.181900763945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 112.0, 113.0, 111.0, 113.0, 111.0, 112.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 160.0, 215.0, 127.0, 156.0, 159.0, 126.0, 184.0, 125.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 169.0, 75.0, 74.0, 75.0, 76.0, 139.0, 75.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 159.0, 92.0, 92.0, 92.0, 121.0, 92.0, 92.0, 134.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 54.0, 109.0, 53.0, 53.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 78.0, 78.0, 80.0, 79.0, 79.0, 80.0, 78.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 120.0, 116.0, 120.0, 120.0, 122.0, 140.0, 189.0, 131.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 158.0, 159.0, 158.0, 161.0, 159.0, 161.0, 158.0, 164.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 62.0, 63.0, 63.0, 61.0, 62.0, 65.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1534.6000000000001, "alertThreshold": 2.0}]} 03:04:35 INFO - Return code: 0 03:04:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:04:35 ERROR - # TBPL SUCCESS # 03:04:35 INFO - Running post-action listener: _resource_record_post_action 03:04:35 INFO - ##### 03:04:35 INFO - ##### Finished run-tests step (success) 03:04:35 INFO - ##### 03:04:35 INFO - Running post-run listener: _resource_record_post_run 03:04:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553316352; Read time: 16; Write time: 663156 03:04:35 INFO - TinderboxPrint: CPU usage
13.1% 03:04:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:04:35 INFO - TinderboxPrint: I/O write bytes / time
553,316,352 / 663,156 03:04:35 INFO - TinderboxPrint: CPU idle
8,276.2 (86.9%) 03:04:35 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 03:04:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:04:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261910528; Read time: 0; Write time: 335476 03:04:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289611776; Read time: 16; Write time: 327488 03:04:36 INFO - Running post-run listener: _upload_blobber_files 03:04:36 INFO - Blob upload gear active. 03:04:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:04:36 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 03:04:36 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'] 03:04:36 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 03:04:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:37 INFO - (blobuploader) - INFO - Done attempting. 03:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:04:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:38 INFO - (blobuploader) - INFO - Done attempting. 03:04:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:04:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:04:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:43 INFO - (blobuploader) - INFO - Done attempting. 03:04:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:04:43 INFO - Return code: 0 03:04:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:04:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:04:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24726eadc3d71904a6a1cc04b00d8e95976e25f065eb1b6fe750109a3c5b10c638e317a72e4e3b63e7177d273523d89a1f9eed2ca0bf38362177f1e4c8ff895c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6145f2b61840382257ae85a8cf487e9feeca6b5038f50ca9b95ae2706c3859a5e3a29872b665aa032cd340783a301d4801b00acb67ee232d5a85ab2e3a198de2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20a4bd98e111bbaa865f4d15bcbac054dd54bf81a3223f8be25fc506b1a2ffa92f7beea05159ab91dc99891d8f7906cdbb3352dd7335887b9541f9377ee3fb64"} 03:04:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:04:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:04:43 INFO - Contents: 03:04:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24726eadc3d71904a6a1cc04b00d8e95976e25f065eb1b6fe750109a3c5b10c638e317a72e4e3b63e7177d273523d89a1f9eed2ca0bf38362177f1e4c8ff895c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6145f2b61840382257ae85a8cf487e9feeca6b5038f50ca9b95ae2706c3859a5e3a29872b665aa032cd340783a301d4801b00acb67ee232d5a85ab2e3a198de2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20a4bd98e111bbaa865f4d15bcbac054dd54bf81a3223f8be25fc506b1a2ffa92f7beea05159ab91dc99891d8f7906cdbb3352dd7335887b9541f9377ee3fb64"} 03:04:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:04:43 INFO - Copying logs to upload dir... 03:04:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:04:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.998567 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-19 03:04:42.992835) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 03:04:42.996919) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076 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/24726eadc3d71904a6a1cc04b00d8e95976e25f065eb1b6fe750109a3c5b10c638e317a72e4e3b63e7177d273523d89a1f9eed2ca0bf38362177f1e4c8ff895c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6145f2b61840382257ae85a8cf487e9feeca6b5038f50ca9b95ae2706c3859a5e3a29872b665aa032cd340783a301d4801b00acb67ee232d5a85ab2e3a198de2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20a4bd98e111bbaa865f4d15bcbac054dd54bf81a3223f8be25fc506b1a2ffa92f7beea05159ab91dc99891d8f7906cdbb3352dd7335887b9541f9377ee3fb64"} build_url:https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/Mc9gu2axTmCHLZ460yWhww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24726eadc3d71904a6a1cc04b00d8e95976e25f065eb1b6fe750109a3c5b10c638e317a72e4e3b63e7177d273523d89a1f9eed2ca0bf38362177f1e4c8ff895c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6145f2b61840382257ae85a8cf487e9feeca6b5038f50ca9b95ae2706c3859a5e3a29872b665aa032cd340783a301d4801b00acb67ee232d5a85ab2e3a198de2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20a4bd98e111bbaa865f4d15bcbac054dd54bf81a3223f8be25fc506b1a2ffa92f7beea05159ab91dc99891d8f7906cdbb3352dd7335887b9541f9377ee3fb64"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 03:04:43.021904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 03:04:43.022231) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1463651044.820434-1196752076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004754 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 03:04:43.104554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 03:04:43.105027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 03:04:43.105485) ========= ========= Total master_lag: 0.17 =========