builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1464089226.47 results: success (0) buildid: 20160524014837 builduid: dd9aba9143b24646b26cca35f0712920 revision: df5daa1095f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.469783) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.470235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.470532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.486381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.486652) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 04:27:06-- 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% 59.8M=0s 2016-05-24 04:27:06 (59.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.606497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.606811) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.655890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:06.656203) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev df5daa1095f2 --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 df5daa1095f2 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 04:27:06,976 Setting DEBUG logging. 2016-05-24 04:27:06,976 attempt 1/10 2016-05-24 04:27:06,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/df5daa1095f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 04:27:07,489 unpacking tar archive at: mozilla-inbound-df5daa1095f2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.797220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:07.466073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:07.466426) ========= script_repo_revision: df5daa1095f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:07.466853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:07.467120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 04:27:07.476202) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-24 04:27:07.476508) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:27:07 INFO - MultiFileLogger online at 20160524 04:27:07 in /builds/slave/test 04:27: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 04:27:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:07 INFO - {'append_to_log': False, 04:27:07 INFO - 'base_work_dir': '/builds/slave/test', 04:27:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:27:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:07 INFO - 'branch': 'Mozilla-Inbound', 04:27:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:07 INFO - 'config_files': ('talos/linux_config.py',), 04:27:07 INFO - 'default_actions': ('clobber', 04:27:07 INFO - 'read-buildbot-config', 04:27:07 INFO - 'download-and-extract', 04:27:07 INFO - 'populate-webroot', 04:27:07 INFO - 'create-virtualenv', 04:27:07 INFO - 'install', 04:27:07 INFO - 'run-tests'), 04:27:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:07 INFO - 'download_minidump_stackwalk': True, 04:27:07 INFO - 'download_symbols': 'ondemand', 04:27:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:07 INFO - 'installer_path': 'installer.exe', 04:27:07 INFO - 'log_level': 'info', 04:27:07 INFO - 'log_name': 'talos', 04:27:07 INFO - 'log_to_console': True, 04:27:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:27:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:27:07 INFO - 'opt_config_files': (), 04:27:07 INFO - 'pip_index': False, 04:27:07 INFO - 'sps_profile': False, 04:27:07 INFO - 'sps_profile_interval': 0, 04:27:07 INFO - 'suite': 'dromaeojs', 04:27:07 INFO - 'system_bits': '32', 04:27:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:07 INFO - 'title': 'talos-linux64-ix-041', 04:27:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:07 INFO - 'use_talos_json': True, 04:27:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:07 INFO - 'work_dir': 'build'} 04:27:07 INFO - ##### 04:27:07 INFO - ##### Running clobber step. 04:27:07 INFO - ##### 04:27:07 INFO - Running pre-action listener: _resource_record_pre_action 04:27:07 INFO - Running main action method: clobber 04:27:07 INFO - rmtree: /builds/slave/test/build 04:27:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:08 INFO - Running post-action listener: _resource_record_post_action 04:27:08 INFO - ##### 04:27:08 INFO - ##### Finished clobber step (success) 04:27:08 INFO - ##### 04:27:08 INFO - ##### 04:27:08 INFO - ##### Running read-buildbot-config step. 04:27:08 INFO - ##### 04:27:08 INFO - Running pre-action listener: _resource_record_pre_action 04:27:08 INFO - Running main action method: read_buildbot_config 04:27:08 INFO - Using buildbot properties: 04:27:08 INFO - { 04:27:08 INFO - "project": "", 04:27:08 INFO - "product": "firefox", 04:27:08 INFO - "script_repo_revision": "production", 04:27:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:27:08 INFO - "repository": "", 04:27:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:27:08 INFO - "buildid": "20160524014837", 04:27:08 INFO - "pgo_build": "True", 04:27:08 INFO - "basedir": "/builds/slave/test", 04:27:08 INFO - "buildnumber": 1051, 04:27:08 INFO - "slavename": "talos-linux64-ix-041", 04:27:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:27:08 INFO - "platform": "ubuntu64_hw", 04:27:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:27:08 INFO - "branch": "mozilla-inbound", 04:27:08 INFO - "repo_path": "integration/mozilla-inbound", 04:27:08 INFO - "revision": "df5daa1095f2", 04:27:08 INFO - "stage_platform": "linux64-pgo", 04:27:08 INFO - "builduid": "dd9aba9143b24646b26cca35f0712920", 04:27:08 INFO - "slavebuilddir": "test" 04:27:08 INFO - } 04:27:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:27:08 INFO - Running post-action listener: _resource_record_post_action 04:27:08 INFO - ##### 04:27:08 INFO - ##### Finished read-buildbot-config step (success) 04:27:08 INFO - ##### 04:27:08 INFO - ##### 04:27:08 INFO - ##### Running download-and-extract step. 04:27:08 INFO - ##### 04:27:08 INFO - Running pre-action listener: _resource_record_pre_action 04:27:08 INFO - Running main action method: download_and_extract 04:27:08 INFO - mkdir: /builds/slave/test/build/tests 04:27: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')]} 04:27:08 INFO - https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:27:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:27:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:27:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:09 INFO - Downloaded 1361 bytes. 04:27:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:27:09 INFO - Using the following test package requirements: 04:27:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:27:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:27:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'jsshell-linux-x86_64.zip'], 04:27:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:27:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:27:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:27:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:27:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:27:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:27: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')]} 04:27:09 INFO - https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:27:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:27:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:10 INFO - Downloaded 24416041 bytes. 04:27: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'] 04:27: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 04:27:11 INFO - Return code: 0 04:27: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 04:27: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')]} 04:27:11 INFO - https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:27:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:27:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:12 INFO - Downloaded 24416041 bytes. 04:27: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'] 04:27: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 04:27:14 INFO - Return code: 0 04:27: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')]} 04:27:14 INFO - https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:14 INFO - Downloaded 10840359 bytes. 04:27:14 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'] 04:27:14 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 04:27:15 INFO - Return code: 0 04:27: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')]} 04:27:15 INFO - https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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 04:27:16 INFO - Downloaded 58630040 bytes. 04:27:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:27:16 INFO - mkdir: /builds/slave/test/properties 04:27:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:16 INFO - Contents: 04:27:16 INFO - build_url:https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:27:17 INFO - Running post-action listener: _resource_record_post_action 04:27:17 INFO - Running post-action listener: set_extra_try_arguments 04:27:17 INFO - ##### 04:27:17 INFO - ##### Finished download-and-extract step (success) 04:27:17 INFO - ##### 04:27:17 INFO - ##### 04:27:17 INFO - ##### Running populate-webroot step. 04:27:17 INFO - ##### 04:27:17 INFO - Running pre-action listener: _resource_record_pre_action 04:27:17 INFO - Running main action method: populate_webroot 04:27:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:17 INFO - '--tppagecycles', 04:27:17 INFO - '7'], 04:27:17 INFO - 'tests': ['tsvgm']}}, 04:27:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['damp', 'tps']}, 04:27:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'tests': ['damp', 'tps']}, 04:27:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['dromaeo_dom']}, 04:27:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['a11yr', 04:27:17 INFO - 'ts_paint', 04:27:17 INFO - 'tpaint', 04:27:17 INFO - 'sessionrestore', 04:27:17 INFO - 'sessionrestore_no_auto_restore', 04:27:17 INFO - 'tabpaint']}, 04:27:17 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:17 INFO - 'ts_paint', 04:27:17 INFO - 'tpaint', 04:27:17 INFO - 'sessionrestore', 04:27:17 INFO - 'sessionrestore_no_auto_restore', 04:27:17 INFO - 'tabpaint']}, 04:27:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:17 INFO - 'ts_paint', 04:27:17 INFO - 'tpaint', 04:27:17 INFO - 'sessionrestore', 04:27:17 INFO - 'sessionrestore_no_auto_restore', 04:27:17 INFO - 'tabpaint']}, 04:27:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:17 INFO - 'ts_paint', 04:27:17 INFO - 'tpaint', 04:27:17 INFO - 'sessionrestore', 04:27:17 INFO - 'sessionrestore_no_auto_restore', 04:27:17 INFO - 'tabpaint']}, 04:27:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['a11yr', 04:27:17 INFO - 'ts_paint', 04:27:17 INFO - 'tpaint', 04:27:17 INFO - 'sessionrestore', 04:27:17 INFO - 'sessionrestore_no_auto_restore', 04:27:17 INFO - 'tabpaint']}, 04:27:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['a11yr', 04:27:17 INFO - 'ts_paint', 04:27:17 INFO - 'tpaint', 04:27:17 INFO - 'sessionrestore', 04:27:17 INFO - 'sessionrestore_no_auto_restore', 04:27:17 INFO - 'tabpaint']}, 04:27:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['tsvgx', 04:27:17 INFO - 'tsvgr_opacity', 04:27:17 INFO - 'tart', 04:27:17 INFO - 'tscrollx', 04:27:17 INFO - 'cart']}, 04:27:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:17 INFO - 'tsvgr_opacity', 04:27:17 INFO - 'tart', 04:27:17 INFO - 'tscrollx', 04:27:17 INFO - 'cart']}, 04:27:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'talos_options': ['--disable-e10s'], 04:27:17 INFO - 'tests': ['tp5o']}, 04:27:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'tests': ['tp5o']}, 04:27:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'talos_options': ['--disable-e10s', 04:27:17 INFO - '--xperf_path', 04:27:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:17 INFO - 'tests': ['tp5n']}, 04:27:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:17 INFO - 'talos_options': ['--xperf_path', 04:27:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:17 INFO - 'tests': ['tp5n']}}, 04:27:17 INFO - 'talos.zip': {'path': '', 04:27:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:17 INFO - Running post-action listener: _resource_record_post_action 04:27:17 INFO - ##### 04:27:17 INFO - ##### Finished populate-webroot step (success) 04:27:17 INFO - ##### 04:27:17 INFO - ##### 04:27:17 INFO - ##### Running create-virtualenv step. 04:27:17 INFO - ##### 04:27:17 INFO - Running pre-action listener: _resource_record_pre_action 04:27:17 INFO - Running main action method: create_virtualenv 04:27:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27: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 04:27:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:17 INFO - Using real prefix '/usr' 04:27:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:19 INFO - Installing pip.................done. 04:27:19 INFO - Return code: 0 04:27:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:19 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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27:19 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 04:27:19 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 04:27:19 INFO - Using env: {'DISPLAY': ':0', 04:27:19 INFO - 'HOME': '/home/cltbld', 04:27:19 INFO - 'LANG': 'en_US.UTF-8', 04:27:19 INFO - 'LANGUAGE': 'en_US:en', 04:27:19 INFO - 'LOGNAME': 'cltbld', 04:27:19 INFO - 'MAIL': '/var/mail/cltbld', 04:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:19 INFO - 'MOZ_NO_REMOTE': '1', 04:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:19 INFO - 'NO_EM_RESTART': '1', 04:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:19 INFO - 'PWD': '/builds/slave/test', 04:27:19 INFO - 'SHELL': '/bin/bash', 04:27:19 INFO - 'SHLVL': '1', 04:27:19 INFO - 'TERM': 'linux', 04:27:19 INFO - 'TMOUT': '86400', 04:27:19 INFO - 'USER': 'cltbld', 04:27:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:19 INFO - '_': '/tools/buildbot/bin/python'} 04:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27: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 04:27:20 INFO - Cleaning up... 04:27:20 INFO - Return code: 0 04:27:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27: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 04:27: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 04:27:20 INFO - Using env: {'DISPLAY': ':0', 04:27:20 INFO - 'HOME': '/home/cltbld', 04:27:20 INFO - 'LANG': 'en_US.UTF-8', 04:27:20 INFO - 'LANGUAGE': 'en_US:en', 04:27:20 INFO - 'LOGNAME': 'cltbld', 04:27:20 INFO - 'MAIL': '/var/mail/cltbld', 04:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:20 INFO - 'MOZ_NO_REMOTE': '1', 04:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:20 INFO - 'NO_EM_RESTART': '1', 04:27:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:20 INFO - 'PWD': '/builds/slave/test', 04:27:20 INFO - 'SHELL': '/bin/bash', 04:27:20 INFO - 'SHLVL': '1', 04:27:20 INFO - 'TERM': 'linux', 04:27:20 INFO - 'TMOUT': '86400', 04:27:20 INFO - 'USER': 'cltbld', 04:27:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:20 INFO - '_': '/tools/buildbot/bin/python'} 04:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:20 INFO - Downloading/unpacking psutil>=3.1.1 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:22 INFO - Installing collected packages: psutil 04:27:22 INFO - Running setup.py install for psutil 04:27:22 INFO - building 'psutil._psutil_linux' extension 04:27: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 04:27: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 04:27:22 INFO - building 'psutil._psutil_posix' extension 04:27: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 04:27: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:22 INFO - Successfully installed psutil 04:27:22 INFO - Cleaning up... 04:27:22 INFO - Return code: 0 04:27:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:22 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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27:22 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 04:27:22 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 04:27:22 INFO - Using env: {'DISPLAY': ':0', 04:27:22 INFO - 'HOME': '/home/cltbld', 04:27:22 INFO - 'LANG': 'en_US.UTF-8', 04:27:22 INFO - 'LANGUAGE': 'en_US:en', 04:27:22 INFO - 'LOGNAME': 'cltbld', 04:27:22 INFO - 'MAIL': '/var/mail/cltbld', 04:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:22 INFO - 'MOZ_NO_REMOTE': '1', 04:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:22 INFO - 'NO_EM_RESTART': '1', 04:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:22 INFO - 'PWD': '/builds/slave/test', 04:27:22 INFO - 'SHELL': '/bin/bash', 04:27:22 INFO - 'SHLVL': '1', 04:27:22 INFO - 'TERM': 'linux', 04:27:22 INFO - 'TMOUT': '86400', 04:27:22 INFO - 'USER': 'cltbld', 04:27:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:22 INFO - '_': '/tools/buildbot/bin/python'} 04:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:25 INFO - Installing collected packages: mozsystemmonitor 04:27:25 INFO - Running setup.py install for mozsystemmonitor 04:27:25 INFO - Successfully installed mozsystemmonitor 04:27:25 INFO - Cleaning up... 04:27:25 INFO - Return code: 0 04:27:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27: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 04:27: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 04:27:25 INFO - Using env: {'DISPLAY': ':0', 04:27:25 INFO - 'HOME': '/home/cltbld', 04:27:25 INFO - 'LANG': 'en_US.UTF-8', 04:27:25 INFO - 'LANGUAGE': 'en_US:en', 04:27:25 INFO - 'LOGNAME': 'cltbld', 04:27:25 INFO - 'MAIL': '/var/mail/cltbld', 04:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:25 INFO - 'MOZ_NO_REMOTE': '1', 04:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:25 INFO - 'NO_EM_RESTART': '1', 04:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:25 INFO - 'PWD': '/builds/slave/test', 04:27:25 INFO - 'SHELL': '/bin/bash', 04:27:25 INFO - 'SHLVL': '1', 04:27:25 INFO - 'TERM': 'linux', 04:27:25 INFO - 'TMOUT': '86400', 04:27:25 INFO - 'USER': 'cltbld', 04:27:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:25 INFO - '_': '/tools/buildbot/bin/python'} 04:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:28 INFO - Downloading docopt-0.6.1.tar.gz 04:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:28 INFO - Running setup.py install for blobuploader 04:27:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:28 INFO - Running setup.py install for requests 04:27:28 INFO - Running setup.py install for docopt 04:27:28 INFO - Successfully installed blobuploader requests docopt 04:27:28 INFO - Cleaning up... 04:27:28 INFO - Return code: 0 04:27:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27:28 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 04:27:28 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 04:27:28 INFO - Using env: {'DISPLAY': ':0', 04:27:28 INFO - 'HOME': '/home/cltbld', 04:27:28 INFO - 'LANG': 'en_US.UTF-8', 04:27:28 INFO - 'LANGUAGE': 'en_US:en', 04:27:28 INFO - 'LOGNAME': 'cltbld', 04:27:28 INFO - 'MAIL': '/var/mail/cltbld', 04:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:28 INFO - 'MOZ_NO_REMOTE': '1', 04:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:28 INFO - 'NO_EM_RESTART': '1', 04:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:28 INFO - 'PWD': '/builds/slave/test', 04:27:28 INFO - 'SHELL': '/bin/bash', 04:27:28 INFO - 'SHLVL': '1', 04:27:28 INFO - 'TERM': 'linux', 04:27:28 INFO - 'TMOUT': '86400', 04:27:28 INFO - 'USER': 'cltbld', 04:27:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:28 INFO - '_': '/tools/buildbot/bin/python'} 04:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:28 INFO - Running setup.py (path:/tmp/pip-n4pUlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:28 INFO - Running setup.py (path:/tmp/pip-qbrFhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:29 INFO - Running setup.py (path:/tmp/pip-zvGDm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:29 INFO - Running setup.py (path:/tmp/pip-vuHlJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:29 INFO - Running setup.py (path:/tmp/pip-bbaApz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:29 INFO - Running setup.py (path:/tmp/pip-d7ngmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:29 INFO - Running setup.py (path:/tmp/pip-SmyVWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:29 INFO - Running setup.py (path:/tmp/pip-oFbtPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:29 INFO - Running setup.py (path:/tmp/pip-9FzOz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:29 INFO - Running setup.py (path:/tmp/pip-gPj_T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:29 INFO - Running setup.py (path:/tmp/pip-v2Fx9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:29 INFO - Running setup.py (path:/tmp/pip-1aHAZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:29 INFO - Running setup.py (path:/tmp/pip-eJDyIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:29 INFO - Running setup.py (path:/tmp/pip-cef4IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:29 INFO - Running setup.py (path:/tmp/pip-E9ttVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:29 INFO - Running setup.py (path:/tmp/pip-5ThKZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:30 INFO - Running setup.py (path:/tmp/pip-Qmpss8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:30 INFO - Running setup.py install for manifestparser 04:27:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Running setup.py install for mozcrash 04:27:30 INFO - Running setup.py install for mozdebug 04:27:30 INFO - Running setup.py install for mozdevice 04:27:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Running setup.py install for mozfile 04:27:30 INFO - Running setup.py install for mozhttpd 04:27:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Running setup.py install for mozinfo 04:27:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Running setup.py install for mozInstall 04:27:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:30 INFO - Running setup.py install for mozleak 04:27:31 INFO - Running setup.py install for mozlog 04:27:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for moznetwork 04:27:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozprocess 04:27:31 INFO - Running setup.py install for mozprofile 04:27:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozrunner 04:27:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Running setup.py install for mozscreenshot 04:27:31 INFO - Running setup.py install for moztest 04:27:31 INFO - Running setup.py install for mozversion 04:27:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:31 INFO - Cleaning up... 04:27:31 INFO - Return code: 0 04:27:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:31 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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27:31 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 04:27:31 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 04:27:31 INFO - Using env: {'DISPLAY': ':0', 04:27:31 INFO - 'HOME': '/home/cltbld', 04:27:31 INFO - 'LANG': 'en_US.UTF-8', 04:27:31 INFO - 'LANGUAGE': 'en_US:en', 04:27:31 INFO - 'LOGNAME': 'cltbld', 04:27:31 INFO - 'MAIL': '/var/mail/cltbld', 04:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:31 INFO - 'MOZ_NO_REMOTE': '1', 04:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:31 INFO - 'NO_EM_RESTART': '1', 04:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:31 INFO - 'PWD': '/builds/slave/test', 04:27:31 INFO - 'SHELL': '/bin/bash', 04:27:31 INFO - 'SHLVL': '1', 04:27:31 INFO - 'TERM': 'linux', 04:27:31 INFO - 'TMOUT': '86400', 04:27:31 INFO - 'USER': 'cltbld', 04:27:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:31 INFO - '_': '/tools/buildbot/bin/python'} 04:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:32 INFO - Running setup.py (path:/tmp/pip-60u0SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:32 INFO - Running setup.py (path:/tmp/pip-Lpuhyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:32 INFO - Running setup.py (path:/tmp/pip-VxzcSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:32 INFO - Running setup.py (path:/tmp/pip-kWUnRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:32 INFO - Running setup.py (path:/tmp/pip-FctALI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:32 INFO - Running setup.py (path:/tmp/pip-QWizFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:32 INFO - Running setup.py (path:/tmp/pip-bWn4RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27: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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:32 INFO - Running setup.py (path:/tmp/pip-Q71DlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:32 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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:32 INFO - Running setup.py (path:/tmp/pip-ncaOJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:32 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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:32 INFO - Running setup.py (path:/tmp/pip-8toN5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:32 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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:32 INFO - Running setup.py (path:/tmp/pip-eLCOzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:32 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)) 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:32 INFO - Running setup.py (path:/tmp/pip-exITb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27: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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:33 INFO - Running setup.py (path:/tmp/pip-vlQtIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27: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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:33 INFO - Running setup.py (path:/tmp/pip-pTvgOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27: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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:33 INFO - Running setup.py (path:/tmp/pip-g1m6VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27: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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:33 INFO - Running setup.py (path:/tmp/pip-iH8dN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27: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)) 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:33 INFO - Running setup.py (path:/tmp/pip-eVZeVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27: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)) 04:27: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)) 04:27: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)) 04:27: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)) 04:27: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)) 04:27: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)) 04:27:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:35 INFO - Downloading blessings-1.6.tar.gz 04:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:35 INFO - Installing collected packages: blessings 04:27:35 INFO - Running setup.py install for blessings 04:27:35 INFO - Successfully installed blessings 04:27:35 INFO - Cleaning up... 04:27:35 INFO - Return code: 0 04:27:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:35 INFO - Reading from file tmpfile_stdout 04:27:35 INFO - Current package versions: 04:27:35 INFO - argparse == 1.2.1 04:27:35 INFO - blessings == 1.6 04:27:35 INFO - blobuploader == 1.2.4 04:27:35 INFO - docopt == 0.6.1 04:27:35 INFO - manifestparser == 1.1 04:27:35 INFO - mozInstall == 1.12 04:27:35 INFO - mozcrash == 0.17 04:27:35 INFO - mozdebug == 0.1 04:27:35 INFO - mozdevice == 0.48 04:27:35 INFO - mozfile == 1.2 04:27:35 INFO - mozhttpd == 0.7 04:27:35 INFO - mozinfo == 0.9 04:27:35 INFO - mozleak == 0.1 04:27:35 INFO - mozlog == 3.2 04:27:35 INFO - moznetwork == 0.27 04:27:35 INFO - mozprocess == 0.22 04:27:35 INFO - mozprofile == 0.28 04:27:35 INFO - mozrunner == 6.11 04:27:35 INFO - mozscreenshot == 0.1 04:27:35 INFO - mozsystemmonitor == 0.3 04:27:35 INFO - moztest == 0.7 04:27:35 INFO - mozversion == 1.4 04:27:35 INFO - psutil == 3.1.1 04:27:35 INFO - requests == 1.2.3 04:27:35 INFO - wsgiref == 0.1.2 04:27:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:35 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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27:35 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 04:27:35 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 04:27:35 INFO - Using env: {'DISPLAY': ':0', 04:27:35 INFO - 'HOME': '/home/cltbld', 04:27:35 INFO - 'LANG': 'en_US.UTF-8', 04:27:35 INFO - 'LANGUAGE': 'en_US:en', 04:27:35 INFO - 'LOGNAME': 'cltbld', 04:27:35 INFO - 'MAIL': '/var/mail/cltbld', 04:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:35 INFO - 'MOZ_NO_REMOTE': '1', 04:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:35 INFO - 'NO_EM_RESTART': '1', 04:27:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:35 INFO - 'PWD': '/builds/slave/test', 04:27:35 INFO - 'SHELL': '/bin/bash', 04:27:35 INFO - 'SHLVL': '1', 04:27:35 INFO - 'TERM': 'linux', 04:27:35 INFO - 'TMOUT': '86400', 04:27:35 INFO - 'USER': 'cltbld', 04:27:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:35 INFO - '_': '/tools/buildbot/bin/python'} 04:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 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)) 04:27:35 INFO - Cleaning up... 04:27:35 INFO - Return code: 0 04:27:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:27:35 INFO - Using env: {'DISPLAY': ':0', 04:27:35 INFO - 'HOME': '/home/cltbld', 04:27:35 INFO - 'LANG': 'en_US.UTF-8', 04:27:35 INFO - 'LANGUAGE': 'en_US:en', 04:27:35 INFO - 'LOGNAME': 'cltbld', 04:27:35 INFO - 'MAIL': '/var/mail/cltbld', 04:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:35 INFO - 'MOZ_NO_REMOTE': '1', 04:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:35 INFO - 'NO_EM_RESTART': '1', 04:27:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:35 INFO - 'PWD': '/builds/slave/test', 04:27:35 INFO - 'SHELL': '/bin/bash', 04:27:35 INFO - 'SHLVL': '1', 04:27:35 INFO - 'TERM': 'linux', 04:27:35 INFO - 'TMOUT': '86400', 04:27:35 INFO - 'USER': 'cltbld', 04:27:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:35 INFO - '_': '/tools/buildbot/bin/python'} 04:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:36 INFO - Downloading/unpacking jsonschema 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:38 INFO - Downloading/unpacking functools32 (from jsonschema) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:38 INFO - warning: no files found matching '*.txt' 04:27:38 INFO - no previously-included directories found matching 'build' 04:27:38 INFO - no previously-included directories found matching 'dist' 04:27:38 INFO - no previously-included directories found matching '.git*' 04:27:38 INFO - Installing collected packages: jsonschema, functools32 04:27:38 INFO - Running setup.py install for functools32 04:27:38 INFO - warning: no files found matching '*.txt' 04:27:38 INFO - no previously-included directories found matching 'build' 04:27:38 INFO - no previously-included directories found matching 'dist' 04:27:38 INFO - no previously-included directories found matching '.git*' 04:27:38 INFO - Successfully installed jsonschema functools32 04:27:38 INFO - Cleaning up... 04:27:38 INFO - Return code: 0 04:27:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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 0x7f0d6dc48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', '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 04:27: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 04:27: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 04:27:38 INFO - Using env: {'DISPLAY': ':0', 04:27:38 INFO - 'HOME': '/home/cltbld', 04:27:38 INFO - 'LANG': 'en_US.UTF-8', 04:27:38 INFO - 'LANGUAGE': 'en_US:en', 04:27:38 INFO - 'LOGNAME': 'cltbld', 04:27:38 INFO - 'MAIL': '/var/mail/cltbld', 04:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:38 INFO - 'MOZ_NO_REMOTE': '1', 04:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:38 INFO - 'NO_EM_RESTART': '1', 04:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:38 INFO - 'PWD': '/builds/slave/test', 04:27:38 INFO - 'SHELL': '/bin/bash', 04:27:38 INFO - 'SHLVL': '1', 04:27:38 INFO - 'TERM': 'linux', 04:27:38 INFO - 'TMOUT': '86400', 04:27:38 INFO - 'USER': 'cltbld', 04:27:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:38 INFO - '_': '/tools/buildbot/bin/python'} 04:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:38 INFO - Downloading/unpacking flake8 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:27:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:27:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:27:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:41 INFO - no previously-included directories found matching 'docs/_build' 04:27:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:27:41 INFO - Running setup.py install for pep8 04:27:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:27:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:27:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:27:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:27:41 INFO - no previously-included directories found matching 'docs/_build' 04:27:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:27:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:27:41 INFO - Cleaning up... 04:27:41 INFO - Return code: 0 04:27:41 INFO - Running post-action listener: _resource_record_post_action 04:27:41 INFO - Running post-action listener: _start_resource_monitoring 04:27:41 INFO - Starting resource monitoring. 04:27:41 INFO - ##### 04:27:41 INFO - ##### Finished create-virtualenv step (success) 04:27:41 INFO - ##### 04:27:41 INFO - ##### 04:27:41 INFO - ##### Running install step. 04:27:41 INFO - ##### 04:27:41 INFO - Running pre-action listener: _resource_record_pre_action 04:27:41 INFO - Running main action method: install 04:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:41 INFO - Reading from file tmpfile_stdout 04:27:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:41 INFO - Reading from file tmpfile_stdout 04:27:41 INFO - Output received: 04:27:41 INFO - Usage: mozinstall [options] installer 04:27:41 INFO - Options: 04:27:41 INFO - -h, --help show this help message and exit 04:27:41 INFO - -d DEST, --destination=DEST 04:27:41 INFO - Directory to install application into. [default: 04:27:41 INFO - "/builds/slave/test"] 04:27:41 INFO - --app=APP Application being installed. [default: firefox] 04:27:41 INFO - mkdir: /builds/slave/test/build/application 04:27:41 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'] 04:27:41 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 04:27:58 INFO - Reading from file tmpfile_stdout 04:27:58 INFO - Output received: 04:27:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:58 INFO - Running post-action listener: _resource_record_post_action 04:27:58 INFO - ##### 04:27:58 INFO - ##### Finished install step (success) 04:27:58 INFO - ##### 04:27:58 INFO - ##### 04:27:58 INFO - ##### Running run-tests step. 04:27:58 INFO - ##### 04:27:58 INFO - Running pre-action listener: _resource_record_pre_action 04:27:58 INFO - Running main action method: run_tests 04:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:58 INFO - Python 2.7.3 04:27:58 INFO - Return code: 0 04:27:58 INFO - grabbing minidump binary from tooltool 04:27: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')]} 04:27: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 0x28f19c0>, '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 0x28f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27: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 04:27: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 04:27: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 04:27:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:58 INFO - Return code: 0 04:27:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:59 INFO - Return code: 0 04:27: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/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:27: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/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 04:27:59 INFO - Using env: {'DISPLAY': ':0', 04:27:59 INFO - 'HOME': '/home/cltbld', 04:27:59 INFO - 'LANG': 'en_US.UTF-8', 04:27:59 INFO - 'LANGUAGE': 'en_US:en', 04:27:59 INFO - 'LOGNAME': 'cltbld', 04:27:59 INFO - 'MAIL': '/var/mail/cltbld', 04:27:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:59 INFO - 'MOZ_NO_REMOTE': '1', 04:27:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:59 INFO - 'NO_EM_RESTART': '1', 04:27:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:59 INFO - 'PWD': '/builds/slave/test', 04:27:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:59 INFO - 'SHELL': '/bin/bash', 04:27:59 INFO - 'SHLVL': '1', 04:27:59 INFO - 'TERM': 'linux', 04:27:59 INFO - 'TMOUT': '86400', 04:27:59 INFO - 'USER': 'cltbld', 04:27:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495', 04:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:59 INFO - '_': '/tools/buildbot/bin/python'} 04:27: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/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:27:59 INFO - mozversion application_buildid: 20160524014837 04:27:59 INFO - mozversion application_changeset: df5daa1095f2d2b0c71c6f50f308dc9e2daa8c13 04:27:59 INFO - mozversion application_display_name: Nightly 04:27:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:59 INFO - mozversion application_name: Firefox 04:27:59 INFO - mozversion application_remotingname: firefox 04:27:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:27:59 INFO - mozversion application_vendor: Mozilla 04:27:59 INFO - mozversion application_version: 49.0a1 04:27:59 INFO - mozversion platform_buildid: 20160524014837 04:27:59 INFO - mozversion platform_changeset: df5daa1095f2d2b0c71c6f50f308dc9e2daa8c13 04:27:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:27:59 INFO - mozversion platform_version: 49.0a1 04:27:59 INFO - using testdate: 1464089279 04:27:59 INFO - actual date: 1464089279 04:27:59 INFO - starting webserver on 'localhost:43632' 04:27:59 INFO - SUITE-START | Running 2 tests 04:27:59 INFO - TEST-START | dromaeo_css 04:27:59 INFO - operating with platform_type : linux_ 04:27:59 INFO - Initialising browser for dromaeo_css test... 04:27:59 INFO - TEST-INFO | started process 605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJMRZZ1/profile http://localhost:43632/getInfo.html) 04:28:04 INFO - PROCESS | 605 | __metrics Screen width/height:1600/1200 04:28:04 INFO - PROCESS | 605 | colorDepth:24 04:28:04 INFO - PROCESS | 605 | Browser inner width/height: 1024/697 04:28:04 INFO - PROCESS | 605 | __metrics 04:28:05 ERROR - PROCESS | 605 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:28:06 INFO - TEST-INFO | 605: exit 0 04:28:06 INFO - Browser initialized. 04:28:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:06 INFO - TEST-INFO | started process 689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJMRZZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:18 INFO - PROCESS | 689 | RSS: Main: 153255936 04:28:18 INFO - PROCESS | 689 | 04:29:08 INFO - PROCESS | 689 | 1464089348939 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] 04:31:17 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:43632/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43632/tests/dromaeo/cssquery-ext.html) 04:31:18 INFO - PROCESS | 689 | RSS: Main: 242499584 04:31:18 INFO - PROCESS | 689 | 04:34:20 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:43632/tests/dromaeo/cssquery-ext.html (next: http://localhost:43632/tests/dromaeo/cssquery-jquery.html) 04:34:20 INFO - PROCESS | 689 | RSS: Main: 247771136 04:34:20 INFO - PROCESS | 689 | 04:37:23 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:43632/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43632/tests/dromaeo/cssquery-mootools.html) 04:37:23 INFO - PROCESS | 689 | RSS: Main: 242892800 04:37:23 INFO - PROCESS | 689 | 04:40:25 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:43632/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43632/tests/dromaeo/cssquery-prototype.html) 04:40:26 INFO - PROCESS | 689 | RSS: Main: 239878144 04:40:26 INFO - PROCESS | 689 | 04:43:28 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:43632/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43632/tests/dromaeo/cssquery-yui.html) 04:43:29 INFO - PROCESS | 689 | RSS: Main: 203165696 04:43:29 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:43632/tests/dromaeo/cssquery-yui.html (next: http://localhost:43632/tests/dromaeo/cssquery-dojo.html) 04:46:32 INFO - PROCESS | 689 | RSS: Main: 270364672 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | __start_tp_report 04:46:32 INFO - PROCESS | 689 | _x_x_mozilla_page_load 04:46:32 INFO - PROCESS | 689 | _x_x_mozilla_page_load_details 04:46:32 INFO - PROCESS | 689 | |i|pagename|runs| 04:46:32 INFO - PROCESS | 689 | |0;dojo.html;3105.1305634422356;3105.2392163919844;3136.576562164107;3157.668444813296;3166.8733250669975;5246.842594722155;5255.553277971368;5323.707196104213;5413.945860541394;5419.376771671254;5348.0640887844565;5363.329583802025;5374.328208973879;5424.159255315422;5431.918521222175;4802.903941921169;4887.486813884544;4896.069746748124;4908.410990681105;5084.542391184793;4999.075171093359;5022.347094877661;5026.220935754964;5041.949580504203;5053.191489361703;4759.7144171349655;4798.4001999750035;4807.302941073543;4808.230683090706;4837.298591704219;4864.416270047617;4870.512948705136;4878.341423907763;4923.08922849274;4932.309476673268;4816.277558366238;4853.805847766085;4855.053264613402;4859.125357435661;4896.314515967767;5220.843374698765;5233.371995360581;5247.737613119367;5251.186066159751;5318.680879147263;5713.428657134295;5715.571332150105;5722.7424765885635;5723.685197314146;5724.055530837407;5738.8278351649515;5756.222909907151;5756.798512052058;5765.654060756368;5767.33675627304;5185;5319.654222475527;5360.544353729938;5364.758585863685;5403.891922161535;5920.259967504062;5992.0712289595185;5992.580519363602;5997.220361353084;6023.488003519662;5442.91835622466;5767.769289228384;5768.50967667753;5769.1923130761725;5769.624974376652;5788.160716696056;5789.1026890831145;5800.970995144998;5837.620554663933;5840.912386314209;5721.170430287585;5747.051736463437;5753.280839895013;5764.827055188351;5765.308163020381;5586.748596313095;5699.287589051369;5718.971405143031;5765.971170144123;5775.595708300379;4360.912781744348;4394.670399720034;4398.73607583546;4434.312681534368;4439.334099885043;3914.3345631242755;3915.5105611798526;3917.3536366499206;3933.350997085449;3949.447077409165;5262.736863156827;5302.125149350314;5402.297701298806;5466.1527463243265;5507.779688812483;5764.913526297109;5805.651660900359;5831.067029275296;5840.094785308284;5888.882222355529;5473.534749546254;5481.068218402881;5481.397046324901;5482.17767334895;5483.314585676791;4619.5611416915335;4823.27650852375;4840.7337596432535;4856.271559266068;4906.31311616374;5978.133170690313;5981.6710080945095;5987.161797348374;5987.550933679904;6032.155498230251;5784.797532086441;5796.594238403271;5796.710164491843;5798.5651076168615;5798.884022319615;5774.595778295647;5816.47651711348;5897.351291358033;5921.467067963904;5997;5605.495505404533;5609.354924183771;5618.353889302783;5621.213030175861;5632.662040277596;5694.861027794374;5720.2849643794525;5771.394003629558;5776.133579963039;5776.884462310814;5350.036993341236;5360.276362690986;5406.02691515531;5412.215228791882;5443.972780136074;5414.620976531605;5424.077906755782;5425.755840987086;5430.484104010113;5430.891382172414;5308.150695888639;5354.812581559627;5364.758585863724;5365.248865158803;5403.946230485175;5500.312460942382;5528.668279903219;5534.695591742493;5580.972095139498;5624.409437009055;5440.047991601533;5445.863853403538;5452.372977107525;5456.454354564512;5499.477549632778 04:46:32 INFO - PROCESS | 689 | |1;ext.html;621.1738387944035;642.396147621236;645.8288553533317;647.7182425644845;651.4853265919924;42165.57834421655;44076.55923440769;44238.778806105925;47623.76188119055;47670.284945725754;45493.31760023602;45708;46016.76991615046;46159.76920115395;46207.537924620825;8670.436421632605;8853.026167121612;8876.955615221916;8887.822243555125;8889.199972002518;8706;8781.42920710155;8800.647974081028;8806.075362086985;8809.603567839462;8782.824343513126;8823.11768823119;8840.513771742551;8861.556922153899;8863.601137948808;8788.121187881225;8818.647254109828;8820.426672266314;8828.38201325901;8832.60253288597;8557.101504342018;8643.65425382984;8646.65413383464;8652.480851148888;8661.047284798668;41455.7927210362;41751;41805.37291940623;41887;41947;3462.2556150427527;3525.876594319212;3570.8214589270433;3594.245208506217;4013.257547353749;30842.84578577093;32244.193895152574;32364.190895227573;32567.51148732771;33645.495317570254;4055.4322394864744;4160.479940007499;4173.394857745609;4261.211675839949;4322.222000039991;333823;334813;336108;336409;338075;55741;56155.157672634945;56481.71759141178;56690.71654641783;56791;53654.195187072226;57962.7101864488;59015.704921475975;59062.704686477155;59081;15656.843431565538;15930.123843188736;15936.681266374608;15944.920275398548;15965.920170399073;12280.938595306967;12378.195417298028;12388.132830701945;12388.62834114978;12392.194507356993;13672.248026358448;14483.131012139305;15614.609634759221;15829.604259893595;16274.430394936357;6338;6343.1436756038265;6361.109444677749;6403.935960640427;6452.548321617442;1002.9548670309707;1068.556549032143;1099.1591432554103;1128.949197286124;1135.1656532448808;32760.508592371134;32888;33234.50148247778;33416.49875251873;33477.163070922936;1146.8738438771895;1167.0371943146768;1172.724409763705;1174.213277104342;1211.2732360583755;17304.221310041077;17470.21384037696;17540.03529805873;17553.12234388301;17560.648787024187;497938;502607;504236;504417;506763;57749;57820;57871;57908.42091579115;57932.4206757927;1264.5068423314915;1351.1420248142304;1374.0450386981151;1394;1401.2363262022018;32884.342313154084;34365.312693746484;34423.483647744804;34494.48258276078;34512.65487345094;49001.81488203255;49780.502194977584;49781.75109124431;49813.501864980884;49831.252531211336;381203;389098;389117;389835;391424;38670.61329386783;40130;41009.17981640291;42008.15983680248;44362;49153.50846491489;49762.25356619581;49849.50150498449;49913;50462.74768626133;40869;41537.1692566153;41824.37263441112;42775.57224427716;43112;41531.792341038104;41732.1653566933;41818.37272440855;41982.790086049376;42632.57367426286;41156.79421602993;41964.790176048926;42096;42416.57583424126;42481.15037699167;35151.12122196965;36259.45610815893;36967.821350437065;37311.626883730816;37338.8133059333;28581.28546786264;28615.850701647727;28879.5668064975;29007.85496072506;29100.272493186993 04:46:32 INFO - PROCESS | 689 | |2;jquery.html;390.5821866624154;396.7500474700938;403.2700811531127;409.12651489070834;416.9437125987991;14077.648058798535;17315.826841731578;17773.733393999086;19127.330543430966;19156.42530724079;15465.458708945162;17111.40110096147;17640.38258660947;17734.201960911756;18901.716474252862;5583.8883222335635;5811.215485909412;5817.389174136718;5821.446962538574;5826.359100498942;4122.340425531916;5733.569982251348;6059.6364218147055;6303.180586523768;6305.558610897239;6205.844853878667;6381.585196962205;6404.7117879695525;6406.391392817698;6435.485161187117;6477.449416799578;6507.154069970874;6511.38141876521;6528.673566321665;6529.51028672849;5488.945110548883;5710.628809127394;5717.542596592304;5726.083826587767;5734.713264336809;22161.44596385087;22889.656655150186;22917.54164916709;23000.88499557508;23231.419214519603;2233.1737257214936;2310.3415526575013;2337.322176568793;2406.7111946566347;2521.1678249061324;14063.593640635956;14227;14546.272686365744;14770.261486925718;14975.32611032506;1962.842972562206;1998.6202621501868;2019.5355068334366;2115.619188546061;2162.664786958024;79419.20580794176;82426;82509.17490825136;82534.17465825385;83276.58361708213;10726.302790318761;10814.134869210444;11113.388763618079;11137.164712646583;11437.284407338799;14934.551963441114;14948.476803311833;14962.251887405586;15029.473968411054;15038.473653422077;7939.523628582304;8047.396445266511;8159.632816523271;8200;8205.179482051866;6847.794566163023;7780.4553681242905;7807.960960195162;7947.443678942419;7987.760367188994;4280.208161490134;4319.028218650841;4591.219492686251;4609.884752881205;4675.322078298627;1810.1673230314202;1849.2048419179612;1862.2830210369104;1869.9621709951107;1886.8584856135844;916.2212119698203;1017.6438246613774;1060.9151267898549;1089.26594248437;1093.0545078507034;16332;18055.819441805677;18819.341323053628;19463.318783842496;19832.50418739514;1005.7435353984687;1011.3780025284544;1020.2144348851343;1066.3713945125148;1091.9781604368027;10558.947205263925;10950.178736594788;11007.284526505751;11040.944795275973;11073.390963497084;411476;415347;448255;450787;453670;85154;87766.12233877707;88741.55629221813;89466.10533894578;89660;993.7267251505893;1014.5130337438071;1031.1029404418205;1039.2673165418362;1045.4197920154236;16873.240704168096;16980.320787168373;17315.82684173142;17361.392351267645;17517.124143792505;39113.217735645696;40294.79852600835;40505;40645.79677101596;41130.79434602808;54461;55292.44707552873;55474.613134671956;56514.71742641261;58075.70962145162;7895.407844411578;8223.588820559067;8268.875966860382;8352.540610266493;8406.705765298186;9330.020347863649;9657.661981830603;11864.347460889388;12750.744985100431;13458.596242112751;11958.46186921608;12036.819447708116;12109.576164834189;12136.332501712137;12442.377881105727;11657.708557286136;11820.881791182323;11930.582429614922;12076.335801531;12218.26690398579;11816.76366472683;12104.939475302566;12189.756204875675;12231.143819932518;12480.375981200723;8147.266745992889;8246.463979841292;8470.237678608955;8521.744347669579;8639.352048596505;8214.26071653554;11199.88800112021;11705.590304339306;12029.45867435985;12291.262524248574 04:46:32 INFO - PROCESS | 689 | |3;mootools.html;1374.6769509165338;1484.5768955847582;1514.5456363091073;1646.5389690886557;1828.5063032981086;8569.271611912987;8913.598888050037;8924.687635932743;9200.723978280646;9200.769980750485;8949.105089491048;9107.271418286538;9145.268378529718;9147.542622868863;9169.358144929858;1983.4347211044856;2186.289455926822;2260.2202240227093;2269.092363054775;2307.63077907534;2160.4922843131853;2167.7615462299136;2176.4450065233345;2179.4333473296897;2180.738311402634;2253.2902135827244;2269.319204238722;2273.8863056847176;2274.442761523429;2276.7950884420484;1941.0779879557238;2214.8671079735186;2282.6690129931235;2285;2285.394370491821;2079.199508189343;2080.708700781892;2086.1446806809136;2094.5077906691913;2095.1619352259067;9079.273658107335;9136.177744003006;9151.633934642607;9169.816603667889;9170.954145229298;5235.58115350771;5365.570754339683;5368.865778355534;5372.489613486712;5378.731063446812;3232.983835080833;3255.300110476259;3313.5526703894907;3365.528825964367;3368.79787212768;1049.4437947887632;1055.9102476289524;1068.2895874243618;1076.6769969009265;1079.6976846482996;12794.168379055332;12864.742705145938;12899.226046437243;12912;12914.67713307175;4513.932291015637;4551.977240113778;4595.770211489412;4678.69588476748;4684.180268453007;10671.413072281099;10682.519286631965;10690.412027338416;10695.893041069645;10696;4457.710248833815;5370.436104209002;5374.113271310268;5388.299521062315;5393.27190829233;4838.7338696372035;4958.42978057528;4963.875903102379;4996.925046124311;5007.774650140679;4028;4065.8170382332864;4116.897077573025;4154.293770059097;4157.688173387008;1274.3055035005943;1283.7047479079863;1283.7304166125032;1293.2176033499786;1298.8181654568368;914.4696076275744;923.7321176858636;926.4395041000232;927;932.8787257656461;5616.438356164351;5647.887042259132;5709.65742055478;5724.484796368347;6016;929.4376901974343;949.8147861167006;991.8760154980628;994.4580203788952;1004.8645031114794;3872.206197729459;3917.3928041153667;3920.3923391874305;3970.305196590585;4014.9397759033636;11019;11381.317120972768;11432.256903301259;11464.885351146382;11471.827922581168;10926.235163538477;11495.310281383145;11498.885011149949;11508.597199098158;11538.192326537062;8534.061253262136;8555.786105347292;8563.186497282748;8567.657293708307;8626;5569.164625306236;5580.190872323572;5713.114467257582;5764.250647415809;5778.537716982715;10029.648962286285;10246.53890574911;10271.897281027394;10349.172066234532;10599.576016959236;10275.691729248134;10550.366977981346;10550.947245263724;10554.2084343673;10592.523336450033;6725.865482690417;7451.2176221495965;7678.232176782277;7828.412869034732;7856.332211762065;8767.561621919007;8800.691975780817;8811.251043661361;8830.028696843214;8839.911600884167;7710.683345558237;7894.842103158019;7960.522368657899;7962.044554653478;7990.760277191694;7717;7737.226277372218;7792.961035194788;7873.527588344488;8002.599870006593;6553;6596.967015164893;6600.702968366339;6616.801495955129;6631.20425548918;4899.485554016777;4927.876803079952;4938.654294199515;4949.084419382426;5071.619628527801;4982.4768399317545;5037.168867136881;5049.419316778471;5080.593552515716;5209.921851172159 04:46:32 INFO - PROCESS | 689 | |4;prototype.html;307.24877674086855;312.16962878742544;317.6299610953241;318.9952150717738;321.22905027932967;5303.3370828646375;5320.866978325544;5334.5999050071205;5336.893262134755;5381.5425688816495;5247.921281180776;5276.525112739852;5277.947220527793;5290.709011004393;5290.709011004393;4077.7572335215586;4083.2241874043984;4113.938290925638;4124.97937510312;4132.318167502373;3959.722819402643;4084.550699423061;4112.2803509385885;4113.876583702494;4143.792810359485;4019.2765302245584;4053.1488387438526;4059.883532028686;4071.3485842265245;4086.16233672098;3817.3892177251505;3902.70729695274;4062.4109504121884;4062.9187416251657;4074.57216992216;3558.857645694169;3570.410882204433;3573.3032058748554;3585.533880595532;3596.29872174926;5039.21892106724;5041.949580504184;5048.14181589127;5062;5080.59355251579;4416.712913660602;4499.595036446735;4629.305604159403;4642.141203877293;4676.555727205944;5443.646162999393;5451.809186678487;5467.633091727068;5480.890382192374;5496.725163741797;3924.1170736584327;3926.5484469285825;3940.7241493095494;3949.3681011038097;3959.1685745993377;5644.266245388114;5663.66018038919;5723.971380143114;5732.627379220337;5807.303123625192;4013.6187062229624;4028.67770578353;4048.6356227939627;4049.919001619951;4078.469798926121;4069.9389509157386;4111.198316328288;4117.835286588503;4118.485189351331;4130.648894843912;4463.419755431773;4611.239145540948;4653.488116307203;4659.161350956792;4680.742559159211;5472.644278121909;5496.148097044965;5497.670139791625;5519.668819870821;5537.252470916455;1395.0931894268604;1409.8167238258961;1414.6180531256502;1415.348939487847;1419.3471003338373;882.991671240725;905.800723840754;913.4744975890146;920.6374565642752;921.1249313152532;4803.639727020487;4819.2530157825595;4846.273059041172;4854.237965576635;4861.270809378621;4990.72551009698;5067.569256613156;5067.682402575283;5101.362329708786;5101.668391554537;4587.632989360844;4758.381410416624;4794.904101917942;4809.134355815917;4810.807567697253;2899.7680185585104;2959.5708622249654;3022.9848850755607;3023.6091397956748;3027.350094198667;5897.144913987448;5900.557458190567;5904.1734157218025;5919.437653422918;5921.496672782776;5450.482204190595;5747.195392645033;5750.30996280449;5756.25168728071;5769.1923130761725;5839.0949402842625;5848.385919478478;5851.151583020438;5881.941180588225;5904.261967254093;5667;5696.54427645779;5709.457601527848;5709.7145142741865;5729.570282228933;5403.83788486346;5634.943650563442;5642.266505354278;5658.547316214611;5693.402192769865;5931.822045338647;5938.910916336345;5943.197668314895;5956;5976.432238937294;3814.5041144652128;3909.3745000799736;3929.526427589654;3930.7248492606386;3970.622790834866;5706.487780738024;5725.34158571753;5730.971345143247;5754;5787.623804452697;5554.50009499147;5623.634463759842;5640.435956404491;5655.660660360391;5661.348944871228;5423.267858839164;5467.39858615544;5523.8895222094525;5556.361018482926;5559.33288005442;5420.457954204706;5422.186671999231;5448.700321482198;5487.835364939058;5497.47773961473;5532.616845788553;5560.666360018412;5595.412481689526;5606.971965140148;5625.578081643811;5231.378272735465;5413.350397952271;5459.672419654833;5467.769751805812;5502.9174562380795 04:46:32 INFO - PROCESS | 689 | |5;yui.html;821.3921697943522;840.9621567029487;841.6801615386153;842.9957850210748;848.9872651910218;16252.512424627266;16774.07742574158;16825.411110611116;17376.218070186842;17446.82553174468;14622.122672639649;14677.926610366932;14772;14789.186594737284;14866.256687165625;680.0852852912849;791.6160662078887;824.1140773668301;829.6598394658191;832.8292699996487;819.4755356571799;825.7646570727344;827.9751607451786;828.7928017995501;829.5271695133777;856.8157846063095;858.1761508951414;860.2601762484259;866.1295398124876;866.3935245328264;702.6135625406032;829.6722794496201;850.056437354536;854.7136709202393;855.2516548020482;620.6307247187916;623.3579413204407;625.0343219725489;625.3902445116021;625.7090452939404;14094.224817635026;14101.576952691436;14108.294585270696;14121.15273083608;14159.71680566383;12487.812682809765;12732.172408793398;12981.350932453339;12987.285699286536;13103.541376051793;12159.93920030403;12516.624501264976;12548.937255313756;12578.81131783024;12812.935935320264;4331.133773245332;4409;4424.823007079713;4449.822007119711;4468.977655111704;58778;59331.703341483015;59678.403215967715;59866.40133598652;61240.38759612392;10533.613298686894;10686.358818470917;10828.566857325777;11320.886791131983;11361.602343917923;18927.337543185924;18932.621347573247;18935.33726319572;18940.810591893904;18943.810561894206;8165.63254653542;8366.414350995494;8386.287165590871;8555;8560.272376848037;4528.637708983273;4535.183666939916;4606.562376574288;4712.246040633482;4776.402949631296;3257.820819854931;3337.8497967591516;3354.8825791097192;3355.261842394669;3356.781809182395;618.6164577961692;625.7215539085155;629.0658372317106;655.3773914780977;664.7241394821192;646.7833275852548;739.8520295940833;741.3402072155785;757.3448966643923;769.8498792735475;9052.321075919332;9118.95440522793;9138.588763505659;9154.908450915538;9192.356535042616;710.8222944263935;750.6809605917573;755.8374949385908;772.907251129868;773.9961300193463;4529.750863702462;4767.070421267889;4860.684055536379;4925.605951523869;4950.183219768698;73565.26434735692;73923;74305.62847185838;74698.62650686712;75214.62392688001;65474.67262663656;66422.33577664162;66440.33559664438;67130;68274.3172568278;58058.12912806311;58645;58661.70669146627;58809.70595146997;59206.56118593864;9460.858087128561;9550.761230969281;9611.951940240255;9653.46905920153;9663.27525435581;36649;36766.264674705824;37540.81229593835;37783.62216377801;38159.23681526409;47941;52519;52664.21003685024;53015.46984530105;53748;11824.940875295568;11925.940370298093;12099.33453660057;12209.633710988684;12292;9707.126358627758;9849.901500984899;13554;14897.47858824936;14970.775438368652;8757.592392555372;11611.14860840898;11888.643340699793;12705.682357941125;12828.29444380568;10980.231383803057;12039.578614748441;12429.067819913362;13399.464021439033;13659.180449173082;12161.635150945485;12281.201721888048;12615.49538018469;12635.87364126347;12668.683282918;9980.500974951077;10344.27590068688;10433.53049112807;10497.317674351143;10839.512221950188;9664.062577947878;9668.56491457872;9750.122488976027;9763.511824408894;10001.749956251151 04:46:32 INFO - PROCESS | 689 | __end_tp_report 04:46:32 INFO - PROCESS | 689 | __start_cc_report 04:46:32 INFO - PROCESS | 689 | _x_x_mozilla_cycle_collect,790 04:46:32 INFO - PROCESS | 689 | __end_cc_report 04:46:32 INFO - PROCESS | 689 | __startTimestamp1464090392457__endTimestamp 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | ------- Summary: start ------- 04:46:32 INFO - PROCESS | 689 | Number of tests: 6 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | [#0] dojo.html Cycles:165 Average:5316.09 Median:5440.05 stddev:604.48 (11.1%) stddev-sans-first:580.91 04:46:32 INFO - PROCESS | 689 | Values: 3105.1 3105.2 3136.6 3157.7 3166.9 5246.8 5255.6 5323.7 5413.9 5419.4 5348.1 5363.3 5374.3 5424.2 5431.9 4802.9 4887.5 4896.1 4908.4 5084.5 4999.1 5022.3 5026.2 5041.9 5053.2 4759.7 4798.4 4807.3 4808.2 4837.3 4864.4 4870.5 4878.3 4923.1 4932.3 4816.3 4853.8 4855.1 4859.1 4896.3 5220.8 5233.4 5247.7 5251.2 5318.7 5713.4 5715.6 5722.7 5723.7 5724.1 5738.8 5756.2 5756.8 5765.7 5767.3 5185.0 5319.7 5360.5 5364.8 5403.9 5920.3 5992.1 5992.6 5997.2 6023.5 5442.9 5767.8 5768.5 5769.2 5769.6 5788.2 5789.1 5801.0 5837.6 5840.9 5721.2 5747.1 5753.3 5764.8 5765.3 5586.7 5699.3 5719.0 5766.0 5775.6 4360.9 4394.7 4398.7 4434.3 4439.3 3914.3 3915.5 3917.4 3933.4 3949.4 5262.7 5302.1 5402.3 5466.2 5507.8 5764.9 5805.7 5831.1 5840.1 5888.9 5473.5 5481.1 5481.4 5482.2 5483.3 4619.6 4823.3 4840.7 4856.3 4906.3 5978.1 5981.7 5987.2 5987.6 6032.2 5784.8 5796.6 5796.7 5798.6 5798.9 5774.6 5816.5 5897.4 5921.5 5997.0 5605.5 5609.4 5618.4 5621.2 5632.7 5694.9 5720.3 5771.4 5776.1 5776.9 5350.0 5360.3 5406.0 5412.2 5444.0 5414.6 5424.1 5425.8 5430.5 5430.9 5308.2 5354.8 5364.8 5365.2 5403.9 5500.3 5528.7 5534.7 5581.0 5624.4 5440.0 5445.9 5452.4 5456.5 5499.5 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | [#1] ext.html Cycles:180 Average:57973.28 Median:41855.69 stddev:109629.64 (261.9%) stddev-sans-first:109852.61 04:46:32 INFO - PROCESS | 689 | Values: 621.2 642.4 645.8 647.7 651.5 42165.6 44076.6 44238.8 47623.8 47670.3 45493.3 45708.0 46016.8 46159.8 46207.5 8670.4 8853.0 8877.0 8887.8 8889.2 8706.0 8781.4 8800.6 8806.1 8809.6 8782.8 8823.1 8840.5 8861.6 8863.6 8788.1 8818.6 8820.4 8828.4 8832.6 8557.1 8643.7 8646.7 8652.5 8661.0 41455.8 41751.0 41805.4 41887.0 41947.0 3462.3 3525.9 3570.8 3594.2 4013.3 30842.8 32244.2 32364.2 32567.5 33645.5 4055.4 4160.5 4173.4 4261.2 4322.2 333823.0 334813.0 336108.0 336409.0 338075.0 55741.0 56155.2 56481.7 56690.7 56791.0 53654.2 57962.7 59015.7 59062.7 59081.0 15656.8 15930.1 15936.7 15944.9 15965.9 12280.9 12378.2 12388.1 12388.6 12392.2 13672.2 14483.1 15614.6 15829.6 16274.4 6338.0 6343.1 6361.1 6403.9 6452.5 1003.0 1068.6 1099.2 1128.9 1135.2 32760.5 32888.0 33234.5 33416.5 33477.2 1146.9 1167.0 1172.7 1174.2 1211.3 17304.2 17470.2 17540.0 17553.1 17560.6 497938.0 502607.0 504236.0 504417.0 506763.0 57749.0 57820.0 57871.0 57908.4 57932.4 1264.5 1351.1 1374.0 1394.0 1401.2 32884.3 34365.3 34423.5 34494.5 34512.7 49001.8 49780.5 49781.8 49813.5 49831.3 381203.0 389098.0 389117.0 389835.0 391424.0 38670.6 40130.0 41009.2 42008.2 44362.0 49153.5 49762.3 49849.5 49913.0 50462.7 40869.0 41537.2 41824.4 42775.6 43112.0 41531.8 41732.2 41818.4 41982.8 42632.6 41156.8 41964.8 42096.0 42416.6 42481.2 35151.1 36259.5 36967.8 37311.6 37338.8 28581.3 28615.9 28879.6 29007.9 29100.3 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | [#2] jquery.html Cycles:180 Average:27298.34 Median:12770.88 stddev:72162.37 (565.1%) stddev-sans-first:72336.52 04:46:32 INFO - PROCESS | 689 | Values: 390.6 396.8 403.3 409.1 416.9 14077.6 17315.8 17773.7 19127.3 19156.4 15465.5 17111.4 17640.4 17734.2 18901.7 5583.9 5811.2 5817.4 5821.4 5826.4 4122.3 5733.6 6059.6 6303.2 6305.6 6205.8 6381.6 6404.7 6406.4 6435.5 6477.4 6507.2 6511.4 6528.7 6529.5 5488.9 5710.6 5717.5 5726.1 5734.7 22161.4 22889.7 22917.5 23000.9 23231.4 2233.2 2310.3 2337.3 2406.7 2521.2 14063.6 14227.0 14546.3 14770.3 14975.3 1962.8 1998.6 2019.5 2115.6 2162.7 79419.2 82426.0 82509.2 82534.2 83276.6 10726.3 10814.1 11113.4 11137.2 11437.3 14934.6 14948.5 14962.3 15029.5 15038.5 7939.5 8047.4 8159.6 8200.0 8205.2 6847.8 7780.5 7808.0 7947.4 7987.8 4280.2 4319.0 4591.2 4609.9 4675.3 1810.2 1849.2 1862.3 1870.0 1886.9 916.2 1017.6 1060.9 1089.3 1093.1 16332.0 18055.8 18819.3 19463.3 19832.5 1005.7 1011.4 1020.2 1066.4 1092.0 10558.9 10950.2 11007.3 11040.9 11073.4 411476.0 415347.0 448255.0 450787.0 453670.0 85154.0 87766.1 88741.6 89466.1 89660.0 993.7 1014.5 1031.1 1039.3 1045.4 16873.2 16980.3 17315.8 17361.4 17517.1 39113.2 40294.8 40505.0 40645.8 41130.8 54461.0 55292.4 55474.6 56514.7 58075.7 7895.4 8223.6 8268.9 8352.5 8406.7 9330.0 9657.7 11864.3 12750.7 13458.6 11958.5 12036.8 12109.6 12136.3 12442.4 11657.7 11820.9 11930.6 12076.3 12218.3 11816.8 12104.9 12189.8 12231.1 12480.4 8147.3 8246.5 8470.2 8521.7 8639.4 8214.3 11199.9 11705.6 12029.5 12291.3 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | [#3] mootools.html Cycles:180 Average:5866.54 Median:4681.44 stddev:3463.33 (74.0%) stddev-sans-first:3456.60 04:46:32 INFO - PROCESS | 689 | Values: 1374.7 1484.6 1514.5 1646.5 1828.5 8569.3 8913.6 8924.7 9200.7 9200.8 8949.1 9107.3 9145.3 9147.5 9169.4 1983.4 2186.3 2260.2 2269.1 2307.6 2160.5 2167.8 2176.4 2179.4 2180.7 2253.3 2269.3 2273.9 2274.4 2276.8 1941.1 2214.9 2282.7 2285.0 2285.4 2079.2 2080.7 2086.1 2094.5 2095.2 9079.3 9136.2 9151.6 9169.8 9171.0 5235.6 5365.6 5368.9 5372.5 5378.7 3233.0 3255.3 3313.6 3365.5 3368.8 1049.4 1055.9 1068.3 1076.7 1079.7 12794.2 12864.7 12899.2 12912.0 12914.7 4513.9 4552.0 4595.8 4678.7 4684.2 10671.4 10682.5 10690.4 10695.9 10696.0 4457.7 5370.4 5374.1 5388.3 5393.3 4838.7 4958.4 4963.9 4996.9 5007.8 4028.0 4065.8 4116.9 4154.3 4157.7 1274.3 1283.7 1283.7 1293.2 1298.8 914.5 923.7 926.4 927.0 932.9 5616.4 5647.9 5709.7 5724.5 6016.0 929.4 949.8 991.9 994.5 1004.9 3872.2 3917.4 3920.4 3970.3 4014.9 11019.0 11381.3 11432.3 11464.9 11471.8 10926.2 11495.3 11498.9 11508.6 11538.2 8534.1 8555.8 8563.2 8567.7 8626.0 5569.2 5580.2 5713.1 5764.3 5778.5 10029.6 10246.5 10271.9 10349.2 10599.6 10275.7 10550.4 10550.9 10554.2 10592.5 6725.9 7451.2 7678.2 7828.4 7856.3 8767.6 8800.7 8811.3 8830.0 8839.9 7710.7 7894.8 7960.5 7962.0 7990.8 7717.0 7737.2 7793.0 7873.5 8002.6 6553.0 6597.0 6600.7 6616.8 6631.2 4899.5 4927.9 4938.7 4949.1 5071.6 4982.5 5037.2 5049.4 5080.6 5209.9 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | [#4] prototype.html Cycles:180 Average:4602.35 Median:5239.65 stddev:1367.65 (26.1%) stddev-sans-first:1332.95 04:46:32 INFO - PROCESS | 689 | Values: 307.2 312.2 317.6 319.0 321.2 5303.3 5320.9 5334.6 5336.9 5381.5 5247.9 5276.5 5277.9 5290.7 5290.7 4077.8 4083.2 4113.9 4125.0 4132.3 3959.7 4084.6 4112.3 4113.9 4143.8 4019.3 4053.1 4059.9 4071.3 4086.2 3817.4 3902.7 4062.4 4062.9 4074.6 3558.9 3570.4 3573.3 3585.5 3596.3 5039.2 5041.9 5048.1 5062.0 5080.6 4416.7 4499.6 4629.3 4642.1 4676.6 5443.6 5451.8 5467.6 5480.9 5496.7 3924.1 3926.5 3940.7 3949.4 3959.2 5644.3 5663.7 5724.0 5732.6 5807.3 4013.6 4028.7 4048.6 4049.9 4078.5 4069.9 4111.2 4117.8 4118.5 4130.6 4463.4 4611.2 4653.5 4659.2 4680.7 5472.6 5496.1 5497.7 5519.7 5537.3 1395.1 1409.8 1414.6 1415.3 1419.3 883.0 905.8 913.5 920.6 921.1 4803.6 4819.3 4846.3 4854.2 4861.3 4990.7 5067.6 5067.7 5101.4 5101.7 4587.6 4758.4 4794.9 4809.1 4810.8 2899.8 2959.6 3023.0 3023.6 3027.4 5897.1 5900.6 5904.2 5919.4 5921.5 5450.5 5747.2 5750.3 5756.3 5769.2 5839.1 5848.4 5851.2 5881.9 5904.3 5667.0 5696.5 5709.5 5709.7 5729.6 5403.8 5634.9 5642.3 5658.5 5693.4 5931.8 5938.9 5943.2 5956.0 5976.4 3814.5 3909.4 3929.5 3930.7 3970.6 5706.5 5725.3 5731.0 5754.0 5787.6 5554.5 5623.6 5640.4 5655.7 5661.3 5423.3 5467.4 5523.9 5556.4 5559.3 5420.5 5422.2 5448.7 5487.8 5497.5 5532.6 5560.7 5595.4 5607.0 5625.6 5231.4 5413.4 5459.7 5467.8 5502.9 04:46:32 INFO - PROCESS | 689 | 04:46:32 INFO - PROCESS | 689 | [#5] yui.html Cycles:180 Average:16181.91 Median:53381.73 stddev:20105.06 (37.7%) stddev-sans-first:20128.37 04:46:32 INFO - PROCESS | 689 | Values: 821.4 841.0 841.7 843.0 849.0 16252.5 16774.1 16825.4 17376.2 17446.8 14622.1 14677.9 14772.0 14789.2 14866.3 680.1 791.6 824.1 829.7 832.8 819.5 825.8 828.0 828.8 829.5 856.8 858.2 860.3 866.1 866.4 702.6 829.7 850.1 854.7 855.3 620.6 623.4 625.0 625.4 625.7 14094.2 14101.6 14108.3 14121.2 14159.7 12487.8 12732.2 12981.4 12987.3 13103.5 12159.9 12516.6 12548.9 12578.8 12812.9 4331.1 4409.0 4424.8 4449.8 4469.0 58778.0 59331.7 59678.4 59866.4 61240.4 10533.6 10686.4 10828.6 11320.9 11361.6 18927.3 18932.6 18935.3 18940.8 18943.8 8165.6 8366.4 8386.3 8555.0 8560.3 4528.6 4535.2 4606.6 4712.2 4776.4 3257.8 3337.8 3354.9 3355.3 3356.8 618.6 625.7 629.1 655.4 664.7 646.8 739.9 741.3 757.3 769.8 9052.3 9119.0 9138.6 9154.9 9192.4 710.8 750.7 755.8 772.9 774.0 4529.8 4767.1 4860.7 4925.6 4950.2 73565.3 73923.0 74305.6 74698.6 75214.6 65474.7 66422.3 66440.3 67130.0 68274.3 58058.1 58645.0 58661.7 58809.7 59206.6 9460.9 9550.8 9612.0 9653.5 9663.3 36649.0 36766.3 37540.8 37783.6 38159.2 47941.0 52519.0 52664.2 53015.5 53748.0 11824.9 11925.9 12099.3 12209.6 12292.0 9707.1 9849.9 13554.0 14897.5 14970.8 8757.6 11611.1 11888.6 12705.7 12828.3 10980.2 12039.6 12429.1 13399.5 13659.2 12161.6 12281.2 12615.5 12635.9 12668.7 9980.5 10344.3 10433.5 10497.3 10839.5 9664.1 9668.6 9750.1 9763.5 10001.7 04:46:32 INFO - PROCESS | 689 | -------- Summary: end -------- 04:46:32 INFO - PROCESS | 689 | 04:46:33 INFO - TEST-INFO | 689: exit 0 04:46:33 INFO - TEST-OK | dromaeo_css | took 1113493ms 04:46:33 INFO - TEST-START | kraken 04:46:33 INFO - operating with platform_type : linux_ 04:46:33 INFO - Initialising browser for kraken test... 04:46:33 INFO - TEST-INFO | started process 882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCS3Uu3/profile http://localhost:43632/getInfo.html) 04:46:37 INFO - PROCESS | 882 | __metrics Screen width/height:1600/1200 04:46:37 INFO - PROCESS | 882 | colorDepth:24 04:46:37 INFO - PROCESS | 882 | Browser inner width/height: 1024/697 04:46:37 INFO - PROCESS | 882 | __metrics 04:46:38 ERROR - PROCESS | 882 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:46:39 INFO - TEST-INFO | 882: exit 0 04:46:39 INFO - Browser initialized. 04:46:39 INFO - Running cycle 1/1 for kraken test... 04:46:39 INFO - TEST-INFO | started process 969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCS3Uu3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:51 INFO - PROCESS | 969 | RSS: Main: 152801280 04:46:51 INFO - PROCESS | 969 | 04:46:54 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43632/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:54 INFO - PROCESS | 969 | RSS: Main: 209657856 04:46:54 INFO - PROCESS | 969 | 04:46:57 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43632/tests/kraken/driver.html?testName=audio-dft) 04:46:58 INFO - PROCESS | 969 | RSS: Main: 197177344 04:46:58 INFO - PROCESS | 969 | 04:47:01 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43632/tests/kraken/driver.html?testName=audio-fft) 04:47:01 INFO - PROCESS | 969 | RSS: Main: 265723904 04:47:01 INFO - PROCESS | 969 | 04:47:03 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43632/tests/kraken/driver.html?testName=audio-oscillator) 04:47:04 INFO - PROCESS | 969 | RSS: Main: 174858240 04:47:04 INFO - PROCESS | 969 | 04:47:06 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43632/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:07 INFO - PROCESS | 969 | RSS: Main: 179200000 04:47:07 INFO - PROCESS | 969 | 04:47:10 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43632/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:10 INFO - PROCESS | 969 | RSS: Main: 215470080 04:47:10 INFO - PROCESS | 969 | 04:47:14 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43632/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:14 INFO - PROCESS | 969 | RSS: Main: 215396352 04:47:14 INFO - PROCESS | 969 | 04:47:17 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43632/tests/kraken/driver.html?testName=json-parse-financial) 04:47:18 INFO - PROCESS | 969 | RSS: Main: 216035328 04:47:18 INFO - PROCESS | 969 | 04:47:19 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43632/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:20 INFO - PROCESS | 969 | RSS: Main: 204029952 04:47:20 INFO - PROCESS | 969 | 04:47:22 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:22 INFO - PROCESS | 969 | RSS: Main: 206581760 04:47:22 INFO - PROCESS | 969 | 04:47:24 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:25 INFO - PROCESS | 969 | RSS: Main: 217370624 04:47:25 INFO - PROCESS | 969 | 04:47:28 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:28 INFO - PROCESS | 969 | RSS: Main: 224620544 04:47:28 INFO - PROCESS | 969 | 04:47:31 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:32 INFO - PROCESS | 969 | RSS: Main: 221155328 04:47:32 INFO - PROCESS | 969 | 04:47:33 INFO - PROCESS | 969 | Cycle 1(1): loaded http://localhost:43632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43632/tests/kraken/driver.html?testName=ai-astar) 04:47:34 INFO - PROCESS | 969 | RSS: Main: 266244096 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | __start_tp_report 04:47:34 INFO - PROCESS | 969 | _x_x_mozilla_page_load 04:47:34 INFO - PROCESS | 969 | _x_x_mozilla_page_load_details 04:47:34 INFO - PROCESS | 969 | |i|pagename|runs| 04:47:34 INFO - PROCESS | 969 | |0;ai-astar;112;109;111;111;112;110;108;112;109;110 04:47:34 INFO - PROCESS | 969 | |1;audio-beat-detection;154;125;125;182;129;128;148;128;167;124 04:47:34 INFO - PROCESS | 969 | |2;audio-dft;161;162;163;163;162;162;162;164;160;161 04:47:34 INFO - PROCESS | 969 | |3;audio-fft;75;75;76;105;75;76;74;74;97;74 04:47:34 INFO - PROCESS | 969 | |4;audio-oscillator;83;82;128;83;83;83;117;82;83;121 04:47:34 INFO - PROCESS | 969 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;117;117;117 04:47:34 INFO - PROCESS | 969 | |6;imaging-darkroom;145;146;146;146;145;145;145;146;145;146 04:47:34 INFO - PROCESS | 969 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 04:47:34 INFO - PROCESS | 969 | |8;json-parse-financial;55;55;57;57;57;56;55;79;55;53 04:47:34 INFO - PROCESS | 969 | |9;json-stringify-tinderbox;62;62;62;63;64;63;63;63;63;63 04:47:34 INFO - PROCESS | 969 | |10;stanford-crypto-aes;85;82;80;79;80;81;88;83;88;81 04:47:34 INFO - PROCESS | 969 | |11;stanford-crypto-ccm;124;125;124;119;133;131;128;129;170;130 04:47:34 INFO - PROCESS | 969 | |12;stanford-crypto-pbkdf2;162;161;167;164;164;167;167;166;159;161 04:47:34 INFO - PROCESS | 969 | |13;stanford-crypto-sha256-iterative;64;63;65;63;62;67;63;63;62;63 04:47:34 INFO - PROCESS | 969 | __end_tp_report 04:47:34 INFO - PROCESS | 969 | __start_cc_report 04:47:34 INFO - PROCESS | 969 | _x_x_mozilla_cycle_collect,1613 04:47:34 INFO - PROCESS | 969 | __end_cc_report 04:47:34 INFO - PROCESS | 969 | __startTimestamp1464090454007__endTimestamp 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | ------- Summary: start ------- 04:47:34 INFO - PROCESS | 969 | Number of tests: 14 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.43 (1.3%) stddev-sans-first:1.39 04:47:34 INFO - PROCESS | 969 | Values: 112.0 109.0 111.0 111.0 112.0 110.0 108.0 112.0 109.0 110.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:138.50 stddev:20.70 (14.9%) stddev-sans-first:21.42 04:47:34 INFO - PROCESS | 969 | Values: 154.0 125.0 125.0 182.0 129.0 128.0 148.0 128.0 167.0 124.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 04:47:34 INFO - PROCESS | 969 | Values: 161.0 162.0 163.0 163.0 162.0 162.0 162.0 164.0 160.0 161.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:11.20 (14.9%) stddev-sans-first:11.73 04:47:34 INFO - PROCESS | 969 | Values: 75.0 75.0 76.0 105.0 75.0 76.0 74.0 74.0 97.0 74.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:19.16 (23.1%) stddev-sans-first:19.87 04:47:34 INFO - PROCESS | 969 | Values: 83.0 82.0 128.0 83.0 83.0 83.0 117.0 82.0 83.0 121.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:47:34 INFO - PROCESS | 969 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:47:34 INFO - PROCESS | 969 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:47:34 INFO - PROCESS | 969 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.50 stddev:7.52 (13.3%) stddev-sans-first:7.90 04:47:34 INFO - PROCESS | 969 | Values: 55.0 55.0 57.0 57.0 57.0 56.0 55.0 79.0 55.0 53.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 04:47:34 INFO - PROCESS | 969 | Values: 62.0 62.0 62.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.27 (4.0%) stddev-sans-first:3.36 04:47:34 INFO - PROCESS | 969 | Values: 85.0 82.0 80.0 79.0 80.0 81.0 88.0 83.0 88.0 81.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:129.50 stddev:14.21 (11.0%) stddev-sans-first:14.82 04:47:34 INFO - PROCESS | 969 | Values: 124.0 125.0 124.0 119.0 133.0 131.0 128.0 129.0 170.0 130.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:165.00 stddev:2.94 (1.8%) stddev-sans-first:3.04 04:47:34 INFO - PROCESS | 969 | Values: 162.0 161.0 167.0 164.0 164.0 167.0 167.0 166.0 159.0 161.0 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - PROCESS | 969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 04:47:34 INFO - PROCESS | 969 | Values: 64.0 63.0 65.0 63.0 62.0 67.0 63.0 63.0 62.0 63.0 04:47:34 INFO - PROCESS | 969 | -------- Summary: end -------- 04:47:34 INFO - PROCESS | 969 | 04:47:34 INFO - TEST-INFO | 969: exit 0 04:47:35 INFO - TEST-OK | kraken | took 61820ms 04:47:35 INFO - SUITE-END | took 1175s 04:47:35 INFO - Completed test suite (00:19:35) 04:47:35 INFO - javascript benchmark 04:47:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.1305634422356, 3105.2392163919844, 3136.576562164107, 3157.668444813296, 3166.8733250669975, 5246.842594722155, 5255.553277971368, 5323.707196104213, 5413.945860541394, 5419.376771671254, 5348.0640887844565, 5363.329583802025, 5374.328208973879, 5424.159255315422, 5431.918521222175, 4802.903941921169, 4887.486813884544, 4896.069746748124, 4908.410990681105, 5084.542391184793, 4999.075171093359, 5022.347094877661, 5026.220935754964, 5041.949580504203, 5053.191489361703, 4759.7144171349655, 4798.4001999750035, 4807.302941073543, 4808.230683090706, 4837.298591704219, 4864.416270047617, 4870.512948705136, 4878.341423907763, 4923.08922849274, 4932.309476673268, 4816.277558366238, 4853.805847766085, 4855.053264613402, 4859.125357435661, 4896.314515967767, 5220.843374698765, 5233.371995360581, 5247.737613119367, 5251.186066159751, 5318.680879147263, 5713.428657134295, 5715.571332150105, 5722.7424765885635, 5723.685197314146, 5724.055530837407, 5738.8278351649515, 5756.222909907151, 5756.798512052058, 5765.654060756368, 5767.33675627304, 5185.0, 5319.654222475527, 5360.544353729938, 5364.758585863685, 5403.891922161535, 5920.259967504062, 5992.0712289595185, 5992.580519363602, 5997.220361353084, 6023.488003519662, 5442.91835622466, 5767.769289228384, 5768.50967667753, 5769.1923130761725, 5769.624974376652, 5788.160716696056, 5789.1026890831145, 5800.970995144998, 5837.620554663933, 5840.912386314209, 5721.170430287585, 5747.051736463437, 5753.280839895013, 5764.827055188351, 5765.308163020381, 5586.748596313095, 5699.287589051369, 5718.971405143031, 5765.971170144123, 5775.595708300379, 4360.912781744348, 4394.670399720034, 4398.73607583546, 4434.312681534368, 4439.334099885043, 3914.3345631242755, 3915.5105611798526, 3917.3536366499206, 3933.350997085449, 3949.447077409165, 5262.736863156827, 5302.125149350314, 5402.297701298806, 5466.1527463243265, 5507.779688812483, 5764.913526297109, 5805.651660900359, 5831.067029275296, 5840.094785308284, 5888.882222355529, 5473.534749546254, 5481.068218402881, 5481.397046324901, 5482.17767334895, 5483.314585676791, 4619.5611416915335, 4823.27650852375, 4840.7337596432535, 4856.271559266068, 4906.31311616374, 5978.133170690313, 5981.6710080945095, 5987.161797348374, 5987.550933679904, 6032.155498230251, 5784.797532086441, 5796.594238403271, 5796.710164491843, 5798.5651076168615, 5798.884022319615, 5774.595778295647, 5816.47651711348, 5897.351291358033, 5921.467067963904, 5997.0, 5605.495505404533, 5609.354924183771, 5618.353889302783, 5621.213030175861, 5632.662040277596, 5694.861027794374, 5720.2849643794525, 5771.394003629558, 5776.133579963039, 5776.884462310814, 5350.036993341236, 5360.276362690986, 5406.02691515531, 5412.215228791882, 5443.972780136074, 5414.620976531605, 5424.077906755782, 5425.755840987086, 5430.484104010113, 5430.891382172414, 5308.150695888639, 5354.812581559627, 5364.758585863724, 5365.248865158803, 5403.946230485175, 5500.312460942382, 5528.668279903219, 5534.695591742493, 5580.972095139498, 5624.409437009055, 5440.047991601533, 5445.863853403538, 5452.372977107525, 5456.454354564512, 5499.477549632778], "value": 5275.737669455346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.1738387944035, 642.396147621236, 645.8288553533317, 647.7182425644845, 651.4853265919924, 42165.57834421655, 44076.55923440769, 44238.778806105925, 47623.76188119055, 47670.284945725754, 45493.31760023602, 45708.0, 46016.76991615046, 46159.76920115395, 46207.537924620825, 8670.436421632605, 8853.026167121612, 8876.955615221916, 8887.822243555125, 8889.199972002518, 8706.0, 8781.42920710155, 8800.647974081028, 8806.075362086985, 8809.603567839462, 8782.824343513126, 8823.11768823119, 8840.513771742551, 8861.556922153899, 8863.601137948808, 8788.121187881225, 8818.647254109828, 8820.426672266314, 8828.38201325901, 8832.60253288597, 8557.101504342018, 8643.65425382984, 8646.65413383464, 8652.480851148888, 8661.047284798668, 41455.7927210362, 41751.0, 41805.37291940623, 41887.0, 41947.0, 3462.2556150427527, 3525.876594319212, 3570.8214589270433, 3594.245208506217, 4013.257547353749, 30842.84578577093, 32244.193895152574, 32364.190895227573, 32567.51148732771, 33645.495317570254, 4055.4322394864744, 4160.479940007499, 4173.394857745609, 4261.211675839949, 4322.222000039991, 333823.0, 334813.0, 336108.0, 336409.0, 338075.0, 55741.0, 56155.157672634945, 56481.71759141178, 56690.71654641783, 56791.0, 53654.195187072226, 57962.7101864488, 59015.704921475975, 59062.704686477155, 59081.0, 15656.843431565538, 15930.123843188736, 15936.681266374608, 15944.920275398548, 15965.920170399073, 12280.938595306967, 12378.195417298028, 12388.132830701945, 12388.62834114978, 12392.194507356993, 13672.248026358448, 14483.131012139305, 15614.609634759221, 15829.604259893595, 16274.430394936357, 6338.0, 6343.1436756038265, 6361.109444677749, 6403.935960640427, 6452.548321617442, 1002.9548670309707, 1068.556549032143, 1099.1591432554103, 1128.949197286124, 1135.1656532448808, 32760.508592371134, 32888.0, 33234.50148247778, 33416.49875251873, 33477.163070922936, 1146.8738438771895, 1167.0371943146768, 1172.724409763705, 1174.213277104342, 1211.2732360583755, 17304.221310041077, 17470.21384037696, 17540.03529805873, 17553.12234388301, 17560.648787024187, 497938.0, 502607.0, 504236.0, 504417.0, 506763.0, 57749.0, 57820.0, 57871.0, 57908.42091579115, 57932.4206757927, 1264.5068423314915, 1351.1420248142304, 1374.0450386981151, 1394.0, 1401.2363262022018, 32884.342313154084, 34365.312693746484, 34423.483647744804, 34494.48258276078, 34512.65487345094, 49001.81488203255, 49780.502194977584, 49781.75109124431, 49813.501864980884, 49831.252531211336, 381203.0, 389098.0, 389117.0, 389835.0, 391424.0, 38670.61329386783, 40130.0, 41009.17981640291, 42008.15983680248, 44362.0, 49153.50846491489, 49762.25356619581, 49849.50150498449, 49913.0, 50462.74768626133, 40869.0, 41537.1692566153, 41824.37263441112, 42775.57224427716, 43112.0, 41531.792341038104, 41732.1653566933, 41818.37272440855, 41982.790086049376, 42632.57367426286, 41156.79421602993, 41964.790176048926, 42096.0, 42416.57583424126, 42481.15037699167, 35151.12122196965, 36259.45610815893, 36967.821350437065, 37311.626883730816, 37338.8133059333, 28581.28546786264, 28615.850701647727, 28879.5668064975, 29007.85496072506, 29100.272493186993], "value": 20163.730228521163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5821866624154, 396.7500474700938, 403.2700811531127, 409.12651489070834, 416.9437125987991, 14077.648058798535, 17315.826841731578, 17773.733393999086, 19127.330543430966, 19156.42530724079, 15465.458708945162, 17111.40110096147, 17640.38258660947, 17734.201960911756, 18901.716474252862, 5583.8883222335635, 5811.215485909412, 5817.389174136718, 5821.446962538574, 5826.359100498942, 4122.340425531916, 5733.569982251348, 6059.6364218147055, 6303.180586523768, 6305.558610897239, 6205.844853878667, 6381.585196962205, 6404.7117879695525, 6406.391392817698, 6435.485161187117, 6477.449416799578, 6507.154069970874, 6511.38141876521, 6528.673566321665, 6529.51028672849, 5488.945110548883, 5710.628809127394, 5717.542596592304, 5726.083826587767, 5734.713264336809, 22161.44596385087, 22889.656655150186, 22917.54164916709, 23000.88499557508, 23231.419214519603, 2233.1737257214936, 2310.3415526575013, 2337.322176568793, 2406.7111946566347, 2521.1678249061324, 14063.593640635956, 14227.0, 14546.272686365744, 14770.261486925718, 14975.32611032506, 1962.842972562206, 1998.6202621501868, 2019.5355068334366, 2115.619188546061, 2162.664786958024, 79419.20580794176, 82426.0, 82509.17490825136, 82534.17465825385, 83276.58361708213, 10726.302790318761, 10814.134869210444, 11113.388763618079, 11137.164712646583, 11437.284407338799, 14934.551963441114, 14948.476803311833, 14962.251887405586, 15029.473968411054, 15038.473653422077, 7939.523628582304, 8047.396445266511, 8159.632816523271, 8200.0, 8205.179482051866, 6847.794566163023, 7780.4553681242905, 7807.960960195162, 7947.443678942419, 7987.760367188994, 4280.208161490134, 4319.028218650841, 4591.219492686251, 4609.884752881205, 4675.322078298627, 1810.1673230314202, 1849.2048419179612, 1862.2830210369104, 1869.9621709951107, 1886.8584856135844, 916.2212119698203, 1017.6438246613774, 1060.9151267898549, 1089.26594248437, 1093.0545078507034, 16332.0, 18055.819441805677, 18819.341323053628, 19463.318783842496, 19832.50418739514, 1005.7435353984687, 1011.3780025284544, 1020.2144348851343, 1066.3713945125148, 1091.9781604368027, 10558.947205263925, 10950.178736594788, 11007.284526505751, 11040.944795275973, 11073.390963497084, 411476.0, 415347.0, 448255.0, 450787.0, 453670.0, 85154.0, 87766.12233877707, 88741.55629221813, 89466.10533894578, 89660.0, 993.7267251505893, 1014.5130337438071, 1031.1029404418205, 1039.2673165418362, 1045.4197920154236, 16873.240704168096, 16980.320787168373, 17315.82684173142, 17361.392351267645, 17517.124143792505, 39113.217735645696, 40294.79852600835, 40505.0, 40645.79677101596, 41130.79434602808, 54461.0, 55292.44707552873, 55474.613134671956, 56514.71742641261, 58075.70962145162, 7895.407844411578, 8223.588820559067, 8268.875966860382, 8352.540610266493, 8406.705765298186, 9330.020347863649, 9657.661981830603, 11864.347460889388, 12750.744985100431, 13458.596242112751, 11958.46186921608, 12036.819447708116, 12109.576164834189, 12136.332501712137, 12442.377881105727, 11657.708557286136, 11820.881791182323, 11930.582429614922, 12076.335801531, 12218.26690398579, 11816.76366472683, 12104.939475302566, 12189.756204875675, 12231.143819932518, 12480.375981200723, 8147.266745992889, 8246.463979841292, 8470.237678608955, 8521.744347669579, 8639.352048596505, 8214.26071653554, 11199.88800112021, 11705.590304339306, 12029.45867435985, 12291.262524248574], "value": 9228.291164853224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.6769509165338, 1484.5768955847582, 1514.5456363091073, 1646.5389690886557, 1828.5063032981086, 8569.271611912987, 8913.598888050037, 8924.687635932743, 9200.723978280646, 9200.769980750485, 8949.105089491048, 9107.271418286538, 9145.268378529718, 9147.542622868863, 9169.358144929858, 1983.4347211044856, 2186.289455926822, 2260.2202240227093, 2269.092363054775, 2307.63077907534, 2160.4922843131853, 2167.7615462299136, 2176.4450065233345, 2179.4333473296897, 2180.738311402634, 2253.2902135827244, 2269.319204238722, 2273.8863056847176, 2274.442761523429, 2276.7950884420484, 1941.0779879557238, 2214.8671079735186, 2282.6690129931235, 2285.0, 2285.394370491821, 2079.199508189343, 2080.708700781892, 2086.1446806809136, 2094.5077906691913, 2095.1619352259067, 9079.273658107335, 9136.177744003006, 9151.633934642607, 9169.816603667889, 9170.954145229298, 5235.58115350771, 5365.570754339683, 5368.865778355534, 5372.489613486712, 5378.731063446812, 3232.983835080833, 3255.300110476259, 3313.5526703894907, 3365.528825964367, 3368.79787212768, 1049.4437947887632, 1055.9102476289524, 1068.2895874243618, 1076.6769969009265, 1079.6976846482996, 12794.168379055332, 12864.742705145938, 12899.226046437243, 12912.0, 12914.67713307175, 4513.932291015637, 4551.977240113778, 4595.770211489412, 4678.69588476748, 4684.180268453007, 10671.413072281099, 10682.519286631965, 10690.412027338416, 10695.893041069645, 10696.0, 4457.710248833815, 5370.436104209002, 5374.113271310268, 5388.299521062315, 5393.27190829233, 4838.7338696372035, 4958.42978057528, 4963.875903102379, 4996.925046124311, 5007.774650140679, 4028.0, 4065.8170382332864, 4116.897077573025, 4154.293770059097, 4157.688173387008, 1274.3055035005943, 1283.7047479079863, 1283.7304166125032, 1293.2176033499786, 1298.8181654568368, 914.4696076275744, 923.7321176858636, 926.4395041000232, 927.0, 932.8787257656461, 5616.438356164351, 5647.887042259132, 5709.65742055478, 5724.484796368347, 6016.0, 929.4376901974343, 949.8147861167006, 991.8760154980628, 994.4580203788952, 1004.8645031114794, 3872.206197729459, 3917.3928041153667, 3920.3923391874305, 3970.305196590585, 4014.9397759033636, 11019.0, 11381.317120972768, 11432.256903301259, 11464.885351146382, 11471.827922581168, 10926.235163538477, 11495.310281383145, 11498.885011149949, 11508.597199098158, 11538.192326537062, 8534.061253262136, 8555.786105347292, 8563.186497282748, 8567.657293708307, 8626.0, 5569.164625306236, 5580.190872323572, 5713.114467257582, 5764.250647415809, 5778.537716982715, 10029.648962286285, 10246.53890574911, 10271.897281027394, 10349.172066234532, 10599.576016959236, 10275.691729248134, 10550.366977981346, 10550.947245263724, 10554.2084343673, 10592.523336450033, 6725.865482690417, 7451.2176221495965, 7678.232176782277, 7828.412869034732, 7856.332211762065, 8767.561621919007, 8800.691975780817, 8811.251043661361, 8830.028696843214, 8839.911600884167, 7710.683345558237, 7894.842103158019, 7960.522368657899, 7962.044554653478, 7990.760277191694, 7717.0, 7737.226277372218, 7792.961035194788, 7873.527588344488, 8002.599870006593, 6553.0, 6596.967015164893, 6600.702968366339, 6616.801495955129, 6631.20425548918, 4899.485554016777, 4927.876803079952, 4938.654294199515, 4949.084419382426, 5071.619628527801, 4982.4768399317545, 5037.168867136881, 5049.419316778471, 5080.593552515716, 5209.921851172159], "value": 4627.502715760361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.24877674086855, 312.16962878742544, 317.6299610953241, 318.9952150717738, 321.22905027932967, 5303.3370828646375, 5320.866978325544, 5334.5999050071205, 5336.893262134755, 5381.5425688816495, 5247.921281180776, 5276.525112739852, 5277.947220527793, 5290.709011004393, 5290.709011004393, 4077.7572335215586, 4083.2241874043984, 4113.938290925638, 4124.97937510312, 4132.318167502373, 3959.722819402643, 4084.550699423061, 4112.2803509385885, 4113.876583702494, 4143.792810359485, 4019.2765302245584, 4053.1488387438526, 4059.883532028686, 4071.3485842265245, 4086.16233672098, 3817.3892177251505, 3902.70729695274, 4062.4109504121884, 4062.9187416251657, 4074.57216992216, 3558.857645694169, 3570.410882204433, 3573.3032058748554, 3585.533880595532, 3596.29872174926, 5039.21892106724, 5041.949580504184, 5048.14181589127, 5062.0, 5080.59355251579, 4416.712913660602, 4499.595036446735, 4629.305604159403, 4642.141203877293, 4676.555727205944, 5443.646162999393, 5451.809186678487, 5467.633091727068, 5480.890382192374, 5496.725163741797, 3924.1170736584327, 3926.5484469285825, 3940.7241493095494, 3949.3681011038097, 3959.1685745993377, 5644.266245388114, 5663.66018038919, 5723.971380143114, 5732.627379220337, 5807.303123625192, 4013.6187062229624, 4028.67770578353, 4048.6356227939627, 4049.919001619951, 4078.469798926121, 4069.9389509157386, 4111.198316328288, 4117.835286588503, 4118.485189351331, 4130.648894843912, 4463.419755431773, 4611.239145540948, 4653.488116307203, 4659.161350956792, 4680.742559159211, 5472.644278121909, 5496.148097044965, 5497.670139791625, 5519.668819870821, 5537.252470916455, 1395.0931894268604, 1409.8167238258961, 1414.6180531256502, 1415.348939487847, 1419.3471003338373, 882.991671240725, 905.800723840754, 913.4744975890146, 920.6374565642752, 921.1249313152532, 4803.639727020487, 4819.2530157825595, 4846.273059041172, 4854.237965576635, 4861.270809378621, 4990.72551009698, 5067.569256613156, 5067.682402575283, 5101.362329708786, 5101.668391554537, 4587.632989360844, 4758.381410416624, 4794.904101917942, 4809.134355815917, 4810.807567697253, 2899.7680185585104, 2959.5708622249654, 3022.9848850755607, 3023.6091397956748, 3027.350094198667, 5897.144913987448, 5900.557458190567, 5904.1734157218025, 5919.437653422918, 5921.496672782776, 5450.482204190595, 5747.195392645033, 5750.30996280449, 5756.25168728071, 5769.1923130761725, 5839.0949402842625, 5848.385919478478, 5851.151583020438, 5881.941180588225, 5904.261967254093, 5667.0, 5696.54427645779, 5709.457601527848, 5709.7145142741865, 5729.570282228933, 5403.83788486346, 5634.943650563442, 5642.266505354278, 5658.547316214611, 5693.402192769865, 5931.822045338647, 5938.910916336345, 5943.197668314895, 5956.0, 5976.432238937294, 3814.5041144652128, 3909.3745000799736, 3929.526427589654, 3930.7248492606386, 3970.622790834866, 5706.487780738024, 5725.34158571753, 5730.971345143247, 5754.0, 5787.623804452697, 5554.50009499147, 5623.634463759842, 5640.435956404491, 5655.660660360391, 5661.348944871228, 5423.267858839164, 5467.39858615544, 5523.8895222094525, 5556.361018482926, 5559.33288005442, 5420.457954204706, 5422.186671999231, 5448.700321482198, 5487.835364939058, 5497.47773961473, 5532.616845788553, 5560.666360018412, 5595.412481689526, 5606.971965140148, 5625.578081643811, 5231.378272735465, 5413.350397952271, 5459.672419654833, 5467.769751805812, 5502.9174562380795], "value": 4163.210350269376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.3921697943522, 840.9621567029487, 841.6801615386153, 842.9957850210748, 848.9872651910218, 16252.512424627266, 16774.07742574158, 16825.411110611116, 17376.218070186842, 17446.82553174468, 14622.122672639649, 14677.926610366932, 14772.0, 14789.186594737284, 14866.256687165625, 680.0852852912849, 791.6160662078887, 824.1140773668301, 829.6598394658191, 832.8292699996487, 819.4755356571799, 825.7646570727344, 827.9751607451786, 828.7928017995501, 829.5271695133777, 856.8157846063095, 858.1761508951414, 860.2601762484259, 866.1295398124876, 866.3935245328264, 702.6135625406032, 829.6722794496201, 850.056437354536, 854.7136709202393, 855.2516548020482, 620.6307247187916, 623.3579413204407, 625.0343219725489, 625.3902445116021, 625.7090452939404, 14094.224817635026, 14101.576952691436, 14108.294585270696, 14121.15273083608, 14159.71680566383, 12487.812682809765, 12732.172408793398, 12981.350932453339, 12987.285699286536, 13103.541376051793, 12159.93920030403, 12516.624501264976, 12548.937255313756, 12578.81131783024, 12812.935935320264, 4331.133773245332, 4409.0, 4424.823007079713, 4449.822007119711, 4468.977655111704, 58778.0, 59331.703341483015, 59678.403215967715, 59866.40133598652, 61240.38759612392, 10533.613298686894, 10686.358818470917, 10828.566857325777, 11320.886791131983, 11361.602343917923, 18927.337543185924, 18932.621347573247, 18935.33726319572, 18940.810591893904, 18943.810561894206, 8165.63254653542, 8366.414350995494, 8386.287165590871, 8555.0, 8560.272376848037, 4528.637708983273, 4535.183666939916, 4606.562376574288, 4712.246040633482, 4776.402949631296, 3257.820819854931, 3337.8497967591516, 3354.8825791097192, 3355.261842394669, 3356.781809182395, 618.6164577961692, 625.7215539085155, 629.0658372317106, 655.3773914780977, 664.7241394821192, 646.7833275852548, 739.8520295940833, 741.3402072155785, 757.3448966643923, 769.8498792735475, 9052.321075919332, 9118.95440522793, 9138.588763505659, 9154.908450915538, 9192.356535042616, 710.8222944263935, 750.6809605917573, 755.8374949385908, 772.907251129868, 773.9961300193463, 4529.750863702462, 4767.070421267889, 4860.684055536379, 4925.605951523869, 4950.183219768698, 73565.26434735692, 73923.0, 74305.62847185838, 74698.62650686712, 75214.62392688001, 65474.67262663656, 66422.33577664162, 66440.33559664438, 67130.0, 68274.3172568278, 58058.12912806311, 58645.0, 58661.70669146627, 58809.70595146997, 59206.56118593864, 9460.858087128561, 9550.761230969281, 9611.951940240255, 9653.46905920153, 9663.27525435581, 36649.0, 36766.264674705824, 37540.81229593835, 37783.62216377801, 38159.23681526409, 47941.0, 52519.0, 52664.21003685024, 53015.46984530105, 53748.0, 11824.940875295568, 11925.940370298093, 12099.33453660057, 12209.633710988684, 12292.0, 9707.126358627758, 9849.901500984899, 13554.0, 14897.47858824936, 14970.775438368652, 8757.592392555372, 11611.14860840898, 11888.643340699793, 12705.682357941125, 12828.29444380568, 10980.231383803057, 12039.578614748441, 12429.067819913362, 13399.464021439033, 13659.180449173082, 12161.635150945485, 12281.201721888048, 12615.49538018469, 12635.87364126347, 12668.683282918, 9980.500974951077, 10344.27590068688, 10433.53049112807, 10497.317674351143, 10839.512221950188, 9664.062577947878, 9668.56491457872, 9750.122488976027, 9763.511824408894, 10001.749956251151], "value": 6971.881751217495, "unit": "score"}], "name": "dromaeo_css", "value": 7134.404944650649, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 111.0, 112.0, 110.0, 108.0, 112.0, 109.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 125.0, 182.0, 129.0, 128.0, 148.0, 128.0, 167.0, 124.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 164.0, 160.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 75.0, 76.0, 74.0, 74.0, 97.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 83.0, 83.0, 83.0, 117.0, 82.0, 83.0, 121.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 57.0, 57.0, 56.0, 55.0, 79.0, 55.0, 53.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 80.0, 79.0, 80.0, 81.0, 88.0, 83.0, 88.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 124.0, 119.0, 133.0, 131.0, 128.0, 129.0, 170.0, 130.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 167.0, 164.0, 164.0, 167.0, 167.0, 166.0, 159.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 62.0, 67.0, 63.0, 63.0, 62.0, 63.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1507.1, "alertThreshold": 2.0}]} 04:47:35 INFO - Return code: 0 04:47:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:35 ERROR - # TBPL SUCCESS # 04:47:35 INFO - Running post-action listener: _resource_record_post_action 04:47:35 INFO - ##### 04:47:35 INFO - ##### Finished run-tests step (success) 04:47:35 INFO - ##### 04:47:35 INFO - Running post-run listener: _resource_record_post_run 04:47:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538206208; Read time: 8; Write time: 598020 04:47:35 INFO - TinderboxPrint: CPU usage
13.1% 04:47:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:47:35 INFO - TinderboxPrint: I/O write bytes / time
538,206,208 / 598,020 04:47:35 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 04:47:35 INFO - TinderboxPrint: CPU user
1,204.7 (12.7%) 04:47:35 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247304192; Read time: 0; Write time: 323892 04:47:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289341440; Read time: 8; Write time: 274068 04:47:35 INFO - Running post-run listener: _upload_blobber_files 04:47:35 INFO - Blob upload gear active. 04:47:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:35 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 04:47:35 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'] 04:47:35 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 04:47:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:40 INFO - (blobuploader) - INFO - Done attempting. 04:47:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:41 INFO - (blobuploader) - INFO - Done attempting. 04:47:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:42 INFO - (blobuploader) - INFO - Done attempting. 04:47:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:42 INFO - Return code: 0 04:47:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3ad6639100a871718539cea4fd61ebe113937320df36b7ad18e3e91023b0bbd84ce76ae3a505e756119547f47c6f4f4e66ad50ed97fd7d9e9d795a01962c20d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/234c3529ab8fe577ccc18e666ae29d05a10db7f6748a15bad7f5b44516fc01f53c77679cf8acc5493ca47102335a2ef2ae2f8e032490879fac110f7f2448b9da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b1503601df18fa7dd4d9ac012bf52320fa5c48f11fa74483b041c6a559c0cbb0382bd5806939371ce3fb1d043e897caab4ac3bd42b14347c59f0236e10da2a"} 04:47:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:42 INFO - Contents: 04:47:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3ad6639100a871718539cea4fd61ebe113937320df36b7ad18e3e91023b0bbd84ce76ae3a505e756119547f47c6f4f4e66ad50ed97fd7d9e9d795a01962c20d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/234c3529ab8fe577ccc18e666ae29d05a10db7f6748a15bad7f5b44516fc01f53c77679cf8acc5493ca47102335a2ef2ae2f8e032490879fac110f7f2448b9da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b1503601df18fa7dd4d9ac012bf52320fa5c48f11fa74483b041c6a559c0cbb0382bd5806939371ce3fb1d043e897caab4ac3bd42b14347c59f0236e10da2a"} 04:47:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:42 INFO - Copying logs to upload dir... 04:47:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.435017 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-24 04:47:41.926781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 04:47:41.929945) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495 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/a3ad6639100a871718539cea4fd61ebe113937320df36b7ad18e3e91023b0bbd84ce76ae3a505e756119547f47c6f4f4e66ad50ed97fd7d9e9d795a01962c20d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/234c3529ab8fe577ccc18e666ae29d05a10db7f6748a15bad7f5b44516fc01f53c77679cf8acc5493ca47102335a2ef2ae2f8e032490879fac110f7f2448b9da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b1503601df18fa7dd4d9ac012bf52320fa5c48f11fa74483b041c6a559c0cbb0382bd5806939371ce3fb1d043e897caab4ac3bd42b14347c59f0236e10da2a"} build_url:https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/D6B_r76qSo-Rh7jS2NDC7A/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/a3ad6639100a871718539cea4fd61ebe113937320df36b7ad18e3e91023b0bbd84ce76ae3a505e756119547f47c6f4f4e66ad50ed97fd7d9e9d795a01962c20d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/234c3529ab8fe577ccc18e666ae29d05a10db7f6748a15bad7f5b44516fc01f53c77679cf8acc5493ca47102335a2ef2ae2f8e032490879fac110f7f2448b9da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62b1503601df18fa7dd4d9ac012bf52320fa5c48f11fa74483b041c6a559c0cbb0382bd5806939371ce3fb1d043e897caab4ac3bd42b14347c59f0236e10da2a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 04:47:41.955151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:47:41.955475) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464089226.111865-875968495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004726 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:47:42.040401) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 04:47:42.040738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 04:47:42.041042) ========= ========= Total master_lag: 0.17 =========