builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1460826433.12 results: success (0) buildid: 20160416073335 builduid: c5ea970218e54896a87139a1620fbfd5 revision: 037893f93079315cf4dfaac7e6ae6691876abcc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.116510) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.117078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.117548) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.146219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.146489) ========= 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=1861a34ebfea852630dec091000001fa-1460825603.761688-782848961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 10:07:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2016-04-16 10:07:14 (106 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081705 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.258712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.259066) ========= 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=1861a34ebfea852630dec091000001fa-1460825603.761688-782848961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015177 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.322129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:13.322579) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 037893f93079315cf4dfaac7e6ae6691876abcc6 --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 037893f93079315cf4dfaac7e6ae6691876abcc6 --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=1861a34ebfea852630dec091000001fa-1460825603.761688-782848961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 10:07:15,014 truncating revision to first 12 chars 2016-04-16 10:07:15,014 Setting DEBUG logging. 2016-04-16 10:07:15,014 attempt 1/10 2016-04-16 10:07:15,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/037893f93079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 10:07:15,607 unpacking tar archive at: mozilla-inbound-037893f93079/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.210221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.210610) ========= script_repo_revision: 037893f93079315cf4dfaac7e6ae6691876abcc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.211089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.211393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:07:14.225146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-16 10:07:14.225459) ========= /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=1861a34ebfea852630dec091000001fa-1460825603.761688-782848961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:15 INFO - MultiFileLogger online at 20160416 10:07:15 in /builds/slave/test 10:07:15 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 10:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:16 INFO - {'append_to_log': False, 10:07:16 INFO - 'base_work_dir': '/builds/slave/test', 10:07:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:07:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:16 INFO - 'branch': 'Mozilla-Inbound', 10:07:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:16 INFO - 'config_files': ('talos/linux_config.py',), 10:07:16 INFO - 'default_actions': ('clobber', 10:07:16 INFO - 'read-buildbot-config', 10:07:16 INFO - 'download-and-extract', 10:07:16 INFO - 'populate-webroot', 10:07:16 INFO - 'create-virtualenv', 10:07:16 INFO - 'install', 10:07:16 INFO - 'run-tests'), 10:07:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:16 INFO - 'download_minidump_stackwalk': True, 10:07:16 INFO - 'download_symbols': 'ondemand', 10:07:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:16 INFO - 'installer_path': 'installer.exe', 10:07:16 INFO - 'log_level': 'info', 10:07:16 INFO - 'log_name': 'talos', 10:07:16 INFO - 'log_to_console': True, 10:07:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:16 INFO - 'opt_config_files': (), 10:07:16 INFO - 'pip_index': False, 10:07:16 INFO - 'sps_profile': False, 10:07:16 INFO - 'sps_profile_interval': 0, 10:07:16 INFO - 'suite': 'dromaeojs', 10:07:16 INFO - 'system_bits': '32', 10:07:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:16 INFO - 'title': 'talos-linux64-ix-069', 10:07:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:16 INFO - 'use_talos_json': True, 10:07:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:16 INFO - 'work_dir': 'build'} 10:07:16 INFO - ##### 10:07:16 INFO - ##### Running clobber step. 10:07:16 INFO - ##### 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: clobber 10:07:16 INFO - rmtree: /builds/slave/test/build 10:07:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:16 INFO - Running post-action listener: _resource_record_post_action 10:07:16 INFO - ##### 10:07:16 INFO - ##### Running read-buildbot-config step. 10:07:16 INFO - ##### 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: read_buildbot_config 10:07:16 INFO - Using buildbot properties: 10:07:16 INFO - { 10:07:16 INFO - "project": "", 10:07:16 INFO - "product": "firefox", 10:07:16 INFO - "script_repo_revision": "production", 10:07:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:07:16 INFO - "repository": "", 10:07:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:07:16 INFO - "buildid": "20160416073335", 10:07:16 INFO - "pgo_build": "True", 10:07:16 INFO - "basedir": "/builds/slave/test", 10:07:16 INFO - "buildnumber": 1719, 10:07:16 INFO - "slavename": "talos-linux64-ix-069", 10:07:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:07:16 INFO - "platform": "ubuntu64_hw", 10:07:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:07:16 INFO - "branch": "mozilla-inbound", 10:07:16 INFO - "repo_path": "integration/mozilla-inbound", 10:07:16 INFO - "revision": "037893f93079315cf4dfaac7e6ae6691876abcc6", 10:07:16 INFO - "stage_platform": "linux64-pgo", 10:07:16 INFO - "builduid": "c5ea970218e54896a87139a1620fbfd5", 10:07:16 INFO - "slavebuilddir": "test" 10:07:16 INFO - } 10:07:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:07:16 INFO - Running post-action listener: _resource_record_post_action 10:07:16 INFO - ##### 10:07:16 INFO - ##### Running download-and-extract step. 10:07:16 INFO - ##### 10:07:16 INFO - Running pre-action listener: _resource_record_pre_action 10:07:16 INFO - Running main action method: download_and_extract 10:07:16 INFO - mkdir: /builds/slave/test/build/tests 10:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:16 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:07:17 INFO - Downloaded 1361 bytes. 10:07:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:07:17 INFO - Using the following test package requirements: 10:07:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'jsshell-linux-x86_64.zip'], 10:07:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:17 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:19 INFO - Downloaded 23777241 bytes. 10:07:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:20 INFO - Return code: 0 10:07:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:20 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:32 INFO - Downloaded 23777241 bytes. 10:07:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:33 INFO - Return code: 0 10:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:33 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:07:34 INFO - Downloaded 10845952 bytes. 10:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:07:35 INFO - Return code: 0 10:07: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')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:07:36 INFO - Downloaded 58240113 bytes. 10:07:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:36 INFO - mkdir: /builds/slave/test/properties 10:07:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:36 INFO - Contents: 10:07:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:07:37 INFO - Running post-action listener: _resource_record_post_action 10:07:37 INFO - Running post-action listener: set_extra_try_arguments 10:07:37 INFO - ##### 10:07:37 INFO - ##### Running populate-webroot step. 10:07:37 INFO - ##### 10:07:37 INFO - Running pre-action listener: _resource_record_pre_action 10:07:37 INFO - Running main action method: populate_webroot 10:07:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:37 INFO - '--tppagecycles', 10:07:37 INFO - '7'], 10:07:37 INFO - 'tests': ['tsvgm']}}, 10:07:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['damp', 'tps']}, 10:07:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'tests': ['damp', 'tps']}, 10:07:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['dromaeo_dom']}, 10:07:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['a11yr', 10:07:37 INFO - 'ts_paint', 10:07:37 INFO - 'tpaint', 10:07:37 INFO - 'sessionrestore', 10:07:37 INFO - 'sessionrestore_no_auto_restore', 10:07:37 INFO - 'tabpaint']}, 10:07:37 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:37 INFO - 'ts_paint', 10:07:37 INFO - 'tpaint', 10:07:37 INFO - 'sessionrestore', 10:07:37 INFO - 'sessionrestore_no_auto_restore', 10:07:37 INFO - 'tabpaint']}, 10:07:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:37 INFO - 'ts_paint', 10:07:37 INFO - 'tpaint', 10:07:37 INFO - 'sessionrestore', 10:07:37 INFO - 'sessionrestore_no_auto_restore', 10:07:37 INFO - 'tabpaint']}, 10:07:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:37 INFO - 'ts_paint', 10:07:37 INFO - 'tpaint', 10:07:37 INFO - 'sessionrestore', 10:07:37 INFO - 'sessionrestore_no_auto_restore', 10:07:37 INFO - 'tabpaint']}, 10:07:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['a11yr', 10:07:37 INFO - 'ts_paint', 10:07:37 INFO - 'tpaint', 10:07:37 INFO - 'sessionrestore', 10:07:37 INFO - 'sessionrestore_no_auto_restore', 10:07:37 INFO - 'tabpaint']}, 10:07:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['a11yr', 10:07:37 INFO - 'ts_paint', 10:07:37 INFO - 'tpaint', 10:07:37 INFO - 'sessionrestore', 10:07:37 INFO - 'sessionrestore_no_auto_restore', 10:07:37 INFO - 'tabpaint']}, 10:07:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['tsvgx', 10:07:37 INFO - 'tsvgr_opacity', 10:07:37 INFO - 'tart', 10:07:37 INFO - 'tscrollx', 10:07:37 INFO - 'cart']}, 10:07:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:37 INFO - 'tsvgr_opacity', 10:07:37 INFO - 'tart', 10:07:37 INFO - 'tscrollx', 10:07:37 INFO - 'cart']}, 10:07:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'talos_options': ['--disable-e10s'], 10:07:37 INFO - 'tests': ['tp5o']}, 10:07:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'tests': ['tp5o']}, 10:07:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'talos_options': ['--disable-e10s', 10:07:37 INFO - '--xperf_path', 10:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:37 INFO - 'tests': ['tp5n']}, 10:07:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:37 INFO - 'talos_options': ['--xperf_path', 10:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:37 INFO - 'tests': ['tp5n']}}, 10:07:37 INFO - 'talos.zip': {'path': '', 10:07:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:37 INFO - Running post-action listener: _resource_record_post_action 10:07:37 INFO - ##### 10:07:37 INFO - ##### Running create-virtualenv step. 10:07:37 INFO - ##### 10:07:37 INFO - Running pre-action listener: _resource_record_pre_action 10:07:37 INFO - Running main action method: create_virtualenv 10:07:37 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:07:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:37 INFO - Using real prefix '/usr' 10:07:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:39 INFO - Installing pip.................done. 10:07:39 INFO - Return code: 0 10:07:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:39 INFO - Using env: {'DISPLAY': ':0', 10:07:39 INFO - 'HOME': '/home/cltbld', 10:07:39 INFO - 'LANG': 'en_US.UTF-8', 10:07:39 INFO - 'LANGUAGE': 'en_US:en', 10:07:39 INFO - 'LOGNAME': 'cltbld', 10:07:39 INFO - 'MAIL': '/var/mail/cltbld', 10:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:39 INFO - 'MOZ_NO_REMOTE': '1', 10:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:39 INFO - 'NO_EM_RESTART': '1', 10:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:39 INFO - 'PWD': '/builds/slave/test', 10:07:39 INFO - 'SHELL': '/bin/bash', 10:07:39 INFO - 'SHLVL': '1', 10:07:39 INFO - 'TERM': 'linux', 10:07:39 INFO - 'TMOUT': '86400', 10:07:39 INFO - 'USER': 'cltbld', 10:07:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:39 INFO - '_': '/tools/buildbot/bin/python'} 10:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:07:40 INFO - Cleaning up... 10:07:40 INFO - Return code: 0 10:07:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:40 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:40 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>=0.7.1'] in /builds/slave/test/build 10:07:40 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>=0.7.1 10:07:40 INFO - Using env: {'DISPLAY': ':0', 10:07:40 INFO - 'HOME': '/home/cltbld', 10:07:40 INFO - 'LANG': 'en_US.UTF-8', 10:07:40 INFO - 'LANGUAGE': 'en_US:en', 10:07:40 INFO - 'LOGNAME': 'cltbld', 10:07:40 INFO - 'MAIL': '/var/mail/cltbld', 10:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:40 INFO - 'MOZ_NO_REMOTE': '1', 10:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:40 INFO - 'NO_EM_RESTART': '1', 10:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:40 INFO - 'PWD': '/builds/slave/test', 10:07:40 INFO - 'SHELL': '/bin/bash', 10:07:40 INFO - 'SHLVL': '1', 10:07:40 INFO - 'TERM': 'linux', 10:07:40 INFO - 'TMOUT': '86400', 10:07:40 INFO - 'USER': 'cltbld', 10:07:40 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:40 INFO - '_': '/tools/buildbot/bin/python'} 10:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:40 INFO - Downloading/unpacking psutil>=0.7.1 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:42 INFO - Installing collected packages: psutil 10:07:42 INFO - Running setup.py install for psutil 10:07:42 INFO - building 'psutil._psutil_linux' extension 10:07:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:07:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:07:42 INFO - building 'psutil._psutil_posix' extension 10:07:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:07:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:07:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:42 INFO - Successfully installed psutil 10:07:42 INFO - Cleaning up... 10:07:42 INFO - Return code: 0 10:07:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:07:42 INFO - Using env: {'DISPLAY': ':0', 10:07:42 INFO - 'HOME': '/home/cltbld', 10:07:42 INFO - 'LANG': 'en_US.UTF-8', 10:07:42 INFO - 'LANGUAGE': 'en_US:en', 10:07:42 INFO - 'LOGNAME': 'cltbld', 10:07:42 INFO - 'MAIL': '/var/mail/cltbld', 10:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:42 INFO - 'MOZ_NO_REMOTE': '1', 10:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:42 INFO - 'NO_EM_RESTART': '1', 10:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:42 INFO - 'PWD': '/builds/slave/test', 10:07:42 INFO - 'SHELL': '/bin/bash', 10:07:42 INFO - 'SHLVL': '1', 10:07:42 INFO - 'TERM': 'linux', 10:07:42 INFO - 'TMOUT': '86400', 10:07:42 INFO - 'USER': 'cltbld', 10:07:42 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:42 INFO - '_': '/tools/buildbot/bin/python'} 10:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:07:45 INFO - Installing collected packages: mozsystemmonitor 10:07:45 INFO - Running setup.py install for mozsystemmonitor 10:07:45 INFO - Successfully installed mozsystemmonitor 10:07:45 INFO - Cleaning up... 10:07:45 INFO - Return code: 0 10:07:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:45 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:48 INFO - Downloading docopt-0.6.1.tar.gz 10:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:48 INFO - Running setup.py install for blobuploader 10:07:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:48 INFO - Running setup.py install for requests 10:07:48 INFO - Running setup.py install for docopt 10:07:48 INFO - Successfully installed blobuploader requests docopt 10:07:48 INFO - Cleaning up... 10:07:48 INFO - Return code: 0 10:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:48 INFO - Using env: {'DISPLAY': ':0', 10:07:48 INFO - 'HOME': '/home/cltbld', 10:07:48 INFO - 'LANG': 'en_US.UTF-8', 10:07:48 INFO - 'LANGUAGE': 'en_US:en', 10:07:48 INFO - 'LOGNAME': 'cltbld', 10:07:48 INFO - 'MAIL': '/var/mail/cltbld', 10:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:48 INFO - 'MOZ_NO_REMOTE': '1', 10:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:48 INFO - 'NO_EM_RESTART': '1', 10:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:48 INFO - 'PWD': '/builds/slave/test', 10:07:48 INFO - 'SHELL': '/bin/bash', 10:07:48 INFO - 'SHLVL': '1', 10:07:48 INFO - 'TERM': 'linux', 10:07:48 INFO - 'TMOUT': '86400', 10:07:48 INFO - 'USER': 'cltbld', 10:07:48 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:48 INFO - '_': '/tools/buildbot/bin/python'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:49 INFO - Running setup.py (path:/tmp/pip-XtZ17K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:49 INFO - Running setup.py (path:/tmp/pip-QFrHYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:49 INFO - Running setup.py (path:/tmp/pip-SBrJ__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:49 INFO - Running setup.py (path:/tmp/pip-ozfR3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:49 INFO - Running setup.py (path:/tmp/pip-IKuXTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:49 INFO - Running setup.py (path:/tmp/pip-LDqJ9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:49 INFO - Running setup.py (path:/tmp/pip-nlr9cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:49 INFO - Running setup.py (path:/tmp/pip-qpGqLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:49 INFO - Running setup.py (path:/tmp/pip-sITYLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:49 INFO - Running setup.py (path:/tmp/pip-1Uv93G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:49 INFO - Running setup.py (path:/tmp/pip-_SQNoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:49 INFO - Running setup.py (path:/tmp/pip-kOZS6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:49 INFO - Running setup.py (path:/tmp/pip-m5Wvnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:50 INFO - Running setup.py (path:/tmp/pip-bud6ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:50 INFO - Running setup.py (path:/tmp/pip-EDznYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:50 INFO - Running setup.py (path:/tmp/pip-sJe_ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:50 INFO - Running setup.py (path:/tmp/pip-q1qegC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:50 INFO - Running setup.py install for manifestparser 10:07:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:50 INFO - Running setup.py install for mozcrash 10:07:50 INFO - Running setup.py install for mozdebug 10:07:50 INFO - Running setup.py install for mozdevice 10:07:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:50 INFO - Running setup.py install for mozfile 10:07:50 INFO - Running setup.py install for mozhttpd 10:07:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:50 INFO - Running setup.py install for mozinfo 10:07:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:50 INFO - Running setup.py install for mozInstall 10:07:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Running setup.py install for mozleak 10:07:51 INFO - Running setup.py install for mozlog 10:07:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Running setup.py install for moznetwork 10:07:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Running setup.py install for mozprocess 10:07:51 INFO - Running setup.py install for mozprofile 10:07:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Running setup.py install for mozrunner 10:07:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:51 INFO - Running setup.py install for mozscreenshot 10:07:51 INFO - Running setup.py install for moztest 10:07:51 INFO - Running setup.py install for mozversion 10:07:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:52 INFO - Running setup.py (path:/tmp/pip-bjHuaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:52 INFO - Running setup.py (path:/tmp/pip-s0vKyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:52 INFO - Running setup.py (path:/tmp/pip-sSAc2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:52 INFO - Running setup.py (path:/tmp/pip-iWVnZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:52 INFO - Running setup.py (path:/tmp/pip-Q3tOrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:52 INFO - Running setup.py (path:/tmp/pip-54cvFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:52 INFO - Running setup.py (path:/tmp/pip-xJw2j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:52 INFO - Running setup.py (path:/tmp/pip-iGNOC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:52 INFO - Running setup.py (path:/tmp/pip-OKfPgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:52 INFO - Running setup.py (path:/tmp/pip-zaRe37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:53 INFO - Running setup.py (path:/tmp/pip-kPUrQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:53 INFO - Running setup.py (path:/tmp/pip-mSxEMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:53 INFO - Running setup.py (path:/tmp/pip-YXASFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:53 INFO - Running setup.py (path:/tmp/pip-KY5W4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:53 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)) 10:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:53 INFO - Running setup.py (path:/tmp/pip-URO0CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:53 INFO - Running setup.py (path:/tmp/pip-U0iJW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:53 INFO - Running setup.py (path:/tmp/pip-bqgsSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:07:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:55 INFO - Downloading blessings-1.6.tar.gz 10:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:55 INFO - Installing collected packages: blessings 10:07:55 INFO - Running setup.py install for blessings 10:07:55 INFO - Successfully installed blessings 10:07:55 INFO - Cleaning up... 10:07:55 INFO - Return code: 0 10:07:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:55 INFO - Reading from file tmpfile_stdout 10:07:55 INFO - Current package versions: 10:07:55 INFO - argparse == 1.2.1 10:07:55 INFO - blessings == 1.6 10:07:55 INFO - blobuploader == 1.2.4 10:07:55 INFO - docopt == 0.6.1 10:07:55 INFO - manifestparser == 1.1 10:07:55 INFO - mozInstall == 1.12 10:07:55 INFO - mozcrash == 0.17 10:07:55 INFO - mozdebug == 0.1 10:07:55 INFO - mozdevice == 0.48 10:07:55 INFO - mozfile == 1.2 10:07:55 INFO - mozhttpd == 0.7 10:07:55 INFO - mozinfo == 0.9 10:07:55 INFO - mozleak == 0.1 10:07:55 INFO - mozlog == 3.1 10:07:55 INFO - moznetwork == 0.27 10:07:55 INFO - mozprocess == 0.22 10:07:55 INFO - mozprofile == 0.28 10:07:55 INFO - mozrunner == 6.11 10:07:55 INFO - mozscreenshot == 0.1 10:07:55 INFO - mozsystemmonitor == 0.0 10:07:55 INFO - moztest == 0.7 10:07:55 INFO - mozversion == 1.4 10:07:55 INFO - psutil == 3.1.1 10:07:55 INFO - requests == 1.2.3 10:07:55 INFO - wsgiref == 0.1.2 10:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 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 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:55 INFO - Using env: {'DISPLAY': ':0', 10:07:55 INFO - 'HOME': '/home/cltbld', 10:07:55 INFO - 'LANG': 'en_US.UTF-8', 10:07:55 INFO - 'LANGUAGE': 'en_US:en', 10:07:55 INFO - 'LOGNAME': 'cltbld', 10:07:55 INFO - 'MAIL': '/var/mail/cltbld', 10:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:55 INFO - 'MOZ_NO_REMOTE': '1', 10:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:55 INFO - 'NO_EM_RESTART': '1', 10:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:55 INFO - 'PWD': '/builds/slave/test', 10:07:55 INFO - 'SHELL': '/bin/bash', 10:07:55 INFO - 'SHLVL': '1', 10:07:55 INFO - 'TERM': 'linux', 10:07:55 INFO - 'TMOUT': '86400', 10:07:55 INFO - 'USER': 'cltbld', 10:07:55 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:55 INFO - '_': '/tools/buildbot/bin/python'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:07:56 INFO - Cleaning up... 10:07:56 INFO - Return code: 0 10:07:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:56 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 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:07:56 INFO - Using env: {'DISPLAY': ':0', 10:07:56 INFO - 'HOME': '/home/cltbld', 10:07:56 INFO - 'LANG': 'en_US.UTF-8', 10:07:56 INFO - 'LANGUAGE': 'en_US:en', 10:07:56 INFO - 'LOGNAME': 'cltbld', 10:07:56 INFO - 'MAIL': '/var/mail/cltbld', 10:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:56 INFO - 'MOZ_NO_REMOTE': '1', 10:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:56 INFO - 'NO_EM_RESTART': '1', 10:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:56 INFO - 'PWD': '/builds/slave/test', 10:07:56 INFO - 'SHELL': '/bin/bash', 10:07:56 INFO - 'SHLVL': '1', 10:07:56 INFO - 'TERM': 'linux', 10:07:56 INFO - 'TMOUT': '86400', 10:07:56 INFO - 'USER': 'cltbld', 10:07:56 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:56 INFO - '_': '/tools/buildbot/bin/python'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 INFO - Downloading/unpacking jsonschema 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:58 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:58 INFO - warning: no files found matching '*.txt' 10:07:58 INFO - no previously-included directories found matching 'build' 10:07:58 INFO - no previously-included directories found matching 'dist' 10:07:58 INFO - no previously-included directories found matching '.git*' 10:07:58 INFO - Installing collected packages: jsonschema, functools32 10:07:58 INFO - Running setup.py install for functools32 10:07:58 INFO - warning: no files found matching '*.txt' 10:07:58 INFO - no previously-included directories found matching 'build' 10:07:58 INFO - no previously-included directories found matching 'dist' 10:07:58 INFO - no previously-included directories found matching '.git*' 10:07:58 INFO - Successfully installed jsonschema functools32 10:07:58 INFO - Cleaning up... 10:07:58 INFO - Return code: 0 10:07:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:58 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 0x7f14e937cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, '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': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:58 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 10:07:58 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 10:07:58 INFO - Using env: {'DISPLAY': ':0', 10:07:58 INFO - 'HOME': '/home/cltbld', 10:07:58 INFO - 'LANG': 'en_US.UTF-8', 10:07:58 INFO - 'LANGUAGE': 'en_US:en', 10:07:58 INFO - 'LOGNAME': 'cltbld', 10:07:58 INFO - 'MAIL': '/var/mail/cltbld', 10:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:58 INFO - 'MOZ_NO_REMOTE': '1', 10:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:58 INFO - 'NO_EM_RESTART': '1', 10:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:58 INFO - 'PWD': '/builds/slave/test', 10:07:58 INFO - 'SHELL': '/bin/bash', 10:07:58 INFO - 'SHLVL': '1', 10:07:58 INFO - 'TERM': 'linux', 10:07:58 INFO - 'TMOUT': '86400', 10:07:58 INFO - 'USER': 'cltbld', 10:07:58 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:58 INFO - '_': '/tools/buildbot/bin/python'} 10:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:58 INFO - Downloading/unpacking flake8 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:08:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:08:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:01 INFO - no previously-included directories found matching 'docs/_build' 10:08:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:08:01 INFO - Running setup.py install for pep8 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:01 INFO - no previously-included directories found matching 'docs/_build' 10:08:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:08:01 INFO - Cleaning up... 10:08:01 INFO - Return code: 0 10:08:01 INFO - Running post-action listener: _resource_record_post_action 10:08:01 INFO - Running post-action listener: _start_resource_monitoring 10:08:01 INFO - Starting resource monitoring. 10:08:01 INFO - ##### 10:08:01 INFO - ##### Running install step. 10:08:01 INFO - ##### 10:08:01 INFO - Running pre-action listener: _resource_record_pre_action 10:08:01 INFO - Running main action method: install 10:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:01 INFO - Reading from file tmpfile_stdout 10:08:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:01 INFO - Reading from file tmpfile_stdout 10:08:01 INFO - Output received: 10:08:01 INFO - Usage: mozinstall [options] installer 10:08:01 INFO - Options: 10:08:01 INFO - -h, --help show this help message and exit 10:08:01 INFO - -d DEST, --destination=DEST 10:08:01 INFO - Directory to install application into. [default: 10:08:01 INFO - "/builds/slave/test"] 10:08:01 INFO - --app=APP Application being installed. [default: firefox] 10:08:01 INFO - mkdir: /builds/slave/test/build/application 10:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:08:18 INFO - Reading from file tmpfile_stdout 10:08:18 INFO - Output received: 10:08:18 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:18 INFO - Running post-action listener: _resource_record_post_action 10:08:18 INFO - ##### 10:08:18 INFO - ##### Running run-tests step. 10:08:18 INFO - ##### 10:08:18 INFO - Running pre-action listener: _resource_record_pre_action 10:08:18 INFO - Running main action method: run_tests 10:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:18 INFO - Python 2.7.3 10:08:18 INFO - Return code: 0 10:08:18 INFO - grabbing minidump binary from tooltool 10:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:18 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de410>, '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 0x21df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21df7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:08:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:08:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:18 INFO - Return code: 0 10:08:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:08:19 INFO - Return code: 0 10:08:19 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/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:08:19 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/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:08:19 INFO - Using env: {'DISPLAY': ':0', 10:08:19 INFO - 'HOME': '/home/cltbld', 10:08:19 INFO - 'LANG': 'en_US.UTF-8', 10:08:19 INFO - 'LANGUAGE': 'en_US:en', 10:08:19 INFO - 'LOGNAME': 'cltbld', 10:08:19 INFO - 'MAIL': '/var/mail/cltbld', 10:08:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:19 INFO - 'MOZ_NO_REMOTE': '1', 10:08:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:19 INFO - 'NO_EM_RESTART': '1', 10:08:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:19 INFO - 'PWD': '/builds/slave/test', 10:08:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:19 INFO - 'SHELL': '/bin/bash', 10:08:19 INFO - 'SHLVL': '1', 10:08:19 INFO - 'TERM': 'linux', 10:08:19 INFO - 'TMOUT': '86400', 10:08:19 INFO - 'USER': 'cltbld', 10:08:19 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1460825603.761688-782848961', 10:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:19 INFO - '_': '/tools/buildbot/bin/python'} 10:08:19 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/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:08:19 INFO - mozversion application_buildid: 20160416073335 10:08:19 INFO - mozversion application_changeset: 037893f93079315cf4dfaac7e6ae6691876abcc6 10:08:19 INFO - mozversion application_display_name: Nightly 10:08:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:19 INFO - mozversion application_name: Firefox 10:08:19 INFO - mozversion application_remotingname: firefox 10:08:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:19 INFO - mozversion application_vendor: Mozilla 10:08:19 INFO - mozversion application_version: 48.0a1 10:08:19 INFO - mozversion platform_buildid: 20160416073335 10:08:19 INFO - mozversion platform_changeset: 037893f93079315cf4dfaac7e6ae6691876abcc6 10:08:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:08:19 INFO - mozversion platform_version: 48.0a1 10:08:19 INFO - using testdate: 1460826499 10:08:19 INFO - actual date: 1460826499 10:08:19 INFO - starting webserver on 'localhost:43077' 10:08:19 INFO - SUITE-START | Running 2 tests 10:08:19 INFO - TEST-START | dromaeo_css 10:08:19 INFO - operating with platform_type : linux_ 10:08:19 INFO - Initialising browser for dromaeo_css test... 10:08:19 INFO - TEST-INFO | started process 4388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7faPvn/profile http://localhost:43077/getInfo.html) 10:08:24 INFO - PROCESS | 4388 | __metrics Screen width/height:1600/1200 10:08:24 INFO - PROCESS | 4388 | colorDepth:24 10:08:24 INFO - PROCESS | 4388 | Browser inner width/height: 1024/697 10:08:24 INFO - PROCESS | 4388 | __metrics 10:08:25 ERROR - PROCESS | 4388 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:08:26 INFO - TEST-INFO | 4388: exit 0 10:08:26 INFO - Browser initialized. 10:08:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:26 INFO - TEST-INFO | started process 4469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7faPvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:38 INFO - PROCESS | 4469 | RSS: Main: 153284608 10:08:38 INFO - PROCESS | 4469 | 10:09:29 INFO - PROCESS | 4469 | 1460826569283 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:11:37 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:43077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43077/tests/dromaeo/cssquery-ext.html) 10:11:38 INFO - PROCESS | 4469 | RSS: Main: 254410752 10:11:38 INFO - PROCESS | 4469 | 10:14:40 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:43077/tests/dromaeo/cssquery-ext.html (next: http://localhost:43077/tests/dromaeo/cssquery-jquery.html) 10:14:40 INFO - PROCESS | 4469 | RSS: Main: 231763968 10:14:40 INFO - PROCESS | 4469 | 10:17:42 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:43077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43077/tests/dromaeo/cssquery-mootools.html) 10:17:43 INFO - PROCESS | 4469 | RSS: Main: 228712448 10:17:43 INFO - PROCESS | 4469 | 10:20:45 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:43077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43077/tests/dromaeo/cssquery-prototype.html) 10:20:45 INFO - PROCESS | 4469 | RSS: Main: 228503552 10:20:45 INFO - PROCESS | 4469 | 10:23:48 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:43077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43077/tests/dromaeo/cssquery-yui.html) 10:23:48 INFO - PROCESS | 4469 | RSS: Main: 224174080 10:23:48 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:43077/tests/dromaeo/cssquery-yui.html (next: http://localhost:43077/tests/dromaeo/cssquery-dojo.html) 10:26:51 INFO - PROCESS | 4469 | RSS: Main: 266076160 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | __start_tp_report 10:26:51 INFO - PROCESS | 4469 | _x_x_mozilla_page_load 10:26:51 INFO - PROCESS | 4469 | _x_x_mozilla_page_load_details 10:26:51 INFO - PROCESS | 4469 | |i|pagename|runs| 10:26:51 INFO - PROCESS | 4469 | |0;dojo.html;3058.7552995760343;3089.860956256968;3120.4383211022023;3126.359096385241;3152.164676360764;5249.055170069386;5312.654677445968;5372.811951581695;5376.166694162402;5378.031954248234;5354.357477102753;5355.277037599923;5374.274472946151;5432.429594892538;5460.808871689492;4765.404324459442;4810.278458231267;4924.162892308298;4959.2313191455205;4983.227599722049;4758.714477131366;4922;4931.358923339979;4964;4982.9252561211615;4767.547083027107;4781.37842080529;4853.587445067156;4862.367892173995;4877.292792545061;4870.488598697121;4886.755662216875;4887.804487820483;4891.413030436335;4895.069936712013;4772.379590653228;4773.689710168828;4849.75751212438;4855.684380515255;4893.8776530586665;5262.473752624707;5277.683338999673;5283.181106928432;5297.602679798992;5305;5645.294338207724;5669.518090962273;5671.517920976722;5672.432756724335;5681.034224181899;5607.186957891124;5672;5688.60179787415;5734;5753.165790960329;5276;5286.233496143076;5288.286081379041;5290.39160496544;5337.599680023936;5776.566757493205;5785.537157027427;5786.594938354275;5787.131930210502;5790.218320526759;5529.447055294519;5561.833145005657;5598.412166722517;5614.943850561442;5636.4927156556105;5713.628614140068;5729.455701708331;5732.226149469851;5734.426557344315;5738.569607279471;5562.888742225214;5698.116791897262;5699.373068962411;5707.828765137053;5713.628614140068;5636.154576813429;5665.603407761417;5684.516816070598;5697.03150464422;5718.142278658152;4336.457942757155;4353.542877997828;4353.847615333448;4360.563943605614;4400.44994375703;3836.07934095815;3873.283442563135;3896.7272290939927;3912.980435097806;3928.685705143582;5274.498922602346;5373.623846330797;5399.4600539945695;5407.70257635826;5433.1850222466155;5699;5719.456651618089;5719.914201286984;5723.370429252779;5734.168545560954;5350.946490535045;5374.48942350476;5384.030874442638;5384.0847056000575;5426.077566813651;4860.8784780380065;4931.087748766489;4938.209886418156;4949.282354058713;4964.900701986012;5870.412958704095;5877.647341159544;5885.411458854166;5888.175655408247;5890.3815099414805;5526.447355264441;5682.744276507485;5701;5704.401037891128;5761.971190144022;5853.795117170878;5858.209141765978;5874.559408044328;5876.764929402776;5891.05743081105;5550.111982082847;5553.777848885999;5560.443955604407;5563.221149039056;5568.359638641446;5635.042042852643;5640.971795141162;5675.0636145035605;5677.403872593318;5704.828855134353;5610.214569960291;5612.354579223442;5613.887722245614;5629.605927585029;5645.491905728504;5547.057000310037;5589.496945274945;5592.3848376677715;5596.496315331639;5608.6073974823;5317.308749862493;5447.591430642638;5516.089845175501;5517.668939863621;5524.502794748331;5594.804181853616;5626.971865140648;5646.322441307069;5653.293338332708;5657.2079908811975;5517.310336207974;5535.446455354432;5538.307711536058;5541.944580554143;5547.140193270049 10:26:51 INFO - PROCESS | 4469 | |1;ext.html;593.5933885288578;628.4783629587441;633.4773811605427;645.8643684826188;662.2979641579925;30112.397752044973;30806.229844253903;30875.536866946986;30940.381192376168;36497.27005459889;39130;39879.80060099703;39890.601093989055;40011.19977600446;40024.599754002455;8661.87007194894;8890.333225008118;8891.866622000674;8893.911060889406;8894.066123057082;8748.650053997833;8856.8671469928;8881.644734210624;8898.510581917992;8903.910960890405;8889.73330800077;8962.910370896272;8985;8987.41581797181;8990.59542320594;8890.733278001639;8957.865632015524;8959.148880856374;8963.865542016874;8972;8762.34282428814;8856.468611883307;8865.157810008039;8868.334874884345;8870.86693699595;41249;41533.584664153575;41718.1656366874;41761.791191044154;41781.37327940083;3432.3306955143757;3473.9131521711906;3483.338165748525;3596.2088340565033;3964.801759911993;31443.37113257722;31669.52495712566;32004.839975800205;32377.352452951043;32715.836420817745;3489.3719130556487;3520.5951315598522;3530.3292374448774;3535.275268569937;3584.121890136933;294017;294572;296031;296084.5195774029;296284;55702.72148639231;56799;56812.57968550819;56863.71568142215;56864.71567642135;62245;63827.680861596324;63873.36126638767;63902.680486597266;64058;16788.6642267154;17007;17038.31846726117;17066.48800535986;17069.40257090996;12307;12349.135560510678;12391.566295179626;12392.442340094718;12444.688882778002;18644.440666780018;18738.40723538487;18761.624767504574;19669.21323147087;19696.70454943177;7136.857262854714;7170.2471240520035;7261.273872612696;7372.225916278713;7396.889046664304;1141.5662048421548;1159.7158696119504;1176.705823544114;1195.3664557784389;1254.021862946903;30782.230444239074;32854.34291314208;32951.1762205942;34408.41936854696;34968.82515587406;1124.9718757030976;1148.2249481599886;1185.211834130311;1216.1243904388825;1227.9799729445012;16600.83399166017;16636.251368688438;16714;16738.4141555045;16849.915750421416;447758;452274;454420;455063;455538;55600.72199638976;56554.7172264136;56566;56603.43396566064;56606.716966414904;1297.6236891301605;1388.0630574362265;1407.0783636717965;1420.6732451535997;1485.3612946433138;30291;31307.677694792397;32790.34419311648;32840.178995525304;33238;45329.546704532535;46306.7684661588;46380;46403.53596463992;46420;311383;318142;318513;318611;318988;27812.304692382044;27909.302267442665;28288.85855570709;28354.2911427216;28365.432691345646;45582;45800.770996144805;46019.3097103537;46438.76780616075;46913.296300556205;38399.232015360096;38764.6123538761;39483.21033579255;39575.60424395835;40019.79990100031;38054.61945380621;38232.426513601764;38450.230995379374;38731.6126838728;39134;32140.839295803373;35560.6416391718;35819.88071371826;38853;39322.41016384814;30932.22669433282;32305.51541726829;32489.837550812095;32493.18767030843;32513.512297315086;25179.622305665795;26922.865385672947;27131.86434067817;27367;27423.314417139733 10:26:51 INFO - PROCESS | 4469 | |2;jquery.html;368.18630825874817;394.44580364587756;403.9394090886367;404.6762589928058;407.6758976613592;15756.527304180878;17601.29594816209;17969;18021.99999999998;18083;18321.633567328678;18759.437216883514;19090.427287181374;19106.61786764264;19188.328408505706;5645.887082258363;5713.628614140089;5793.71031448428;5840.182374467578;5842;5478.91781623276;5654.491095801377;5656.773729050833;5659.915101273484;5677.347105082927;5423.945760542403;5599.524040456546;5622.578306626999;5625.493705566499;5633.042382794934;5576.609637325389;5586.385497595261;5630.577706671996;5632;5637.238972738689;4948.826791062295;5024.773885175176;5027.019731152427;5216.713080780555;5519.558435325164;12070.215435996632;12180.147389682726;12182.573609923698;12197.45111469986;15351.539453816404;2125.861818981761;2207.7792220777956;2255.2444930948154;2309.4919117794057;2442.670239517678;9734.561944712505;10601.204909631808;11364.659060228207;13953;14506.202158881257;1851.5648822526696;1899.705545640428;1966.9803301967083;1969.5962327722925;2010.2160157538572;78435;79141.20858791396;79681;79943.20056799415;80338.59830700868;10422.21833362501;10513.9474302628;10520.789584208273;10533.315334503233;10540.262181647211;14348.713025739427;14404.207768572829;14433.711325773425;14457.132572045712;14548.345324460424;7802;7934.841303173905;7939.9753062968575;8064.879026814602;8099.109097999215;7781.144074151839;7830.8433831323055;7853.803654908673;7931.603419828985;7970.362371010306;4212.620864122244;4395.824167033346;4441.644668426518;4505.031418245093;4538.750368729686;1838.6874231380698;1903.6287923854993;1912.5792325688606;1922.826945574905;1936.390037138297;929.8744669469535;1033.7622346860114;1051.952662130206;1078.336822853939;1125.0012411752434;18210.544736381697;18722.625547488973;19033.859413196667;19087.61824763497;19125.904370478336;997.850322451638;1032.2825636182781;1053.7681710023783;1072.3137192197;1078.8705355357251;10135.69592912199;10449.738756530995;10591.152707783358;10612.681619551426;10615.787684246427;481171;488367;499915;503075;504216;61407.6929615358;79383;86967;92846.53576732073;93148.06851931529;977.5161295158941;977.7702239973601;1006.335818359879;1017.7760892603616;1034.5965073621294;16484.67030659356;16629.417970370978;16701.49895503137;16835.915820420818;17105;28026;35998;36232.63767362293;36280.274394511434;38029.809850950565;51002.23496647479;51739.74130129325;52779;53418.198727018345;53631.19553206627;8327.292180164754;8493.957530212308;8637.611307491303;8669.869951950599;8783.780405489913;13100.410481528164;13183.274919879499;13472.191668499921;13508.932455338054;13684.452621895012;11812.645620631394;11976.700582485508;12026.518939242333;12117.212381195546;12292.323922184009;11116.49975751077;11448.255863369188;11771.823422648838;11857.940710296738;11906.880931190577;11414.885851141382;11938.28370297785;12115.636530904087;12502.909784304571;12616.55842045524;8000.95999520022;8392.4544904581;8417.494950303002;8712.477251364939;8776.736697899074;8780.034196238536;10938.890611094106;12074.45664945097;12235.388230588613;12314.692132696755 10:26:51 INFO - PROCESS | 4469 | |3;mootools.html;1335.3189873164683;1417.5605562275696;1504.7517159668653;1694.7796786417764;1860.3116846766698;7954.2443467870535;8247.257746802787;8257.421980461362;8261.380396470273;8295.460795048317;8088.069871964726;8181.304589109933;8216.137305582917;8236.958815205915;8242.423030387876;2008.7790343062252;2212.214663794354;2217.700610417597;2247.910083596654;2276.248837883503;2280.532490839374;2285.874276914769;2298.367948814081;2306.688597039395;2307.3539408965435;2182.0289970962926;2225.4547635829244;2228.186711850179;2232.062533735827;2232.408411770874;1972.9112189951416;2176.55380646967;2236.2508559632543;2240.092762431218;2240.809531189851;2212.5243072739277;2216.1024784962115;2224.27710993926;2226.76618955009;2255.2670382125875;8182.959085204596;8199.42604017719;8235.21765432283;8277.668893244263;8283.37874659397;4893.7063776173545;5001.549860512535;5017.724025178613;5033.295338652591;5038.269450929594;3164.161497203243;3176.9841150794327;3214.035789263212;3236.0777178504013;3253.9511907321407;1061.0980666433547;1081.1891081688734;1083.918706097046;1092.3118435385736;1105.8230683090667;11215.38315392653;11224.102071834233;11238.887611123866;11278.436078196139;11297.49161287744;4208.137331847025;4252.574742525722;4372.781360931941;4420.248557745191;4420.58004489573;9616.9038309616;9659.227261819178;9684.56419461126;9699.903000970042;9710.563024663907;4553.612942899825;4969.751512424365;4993;5008.499150085036;5023.6985780853265;4559.749213793207;4593.655475839326;4622.4684161321875;4638.141943740419;4655.255159174516;3788.204477059793;3827.598102199229;3884.533855937249;3908.785016824045;3940.4680368150507;1148.3626587243994;1151.7581307925261;1151.7696460707725;1165.3124656452565;1201.0991756182864;763.7250589787672;861.8276344731079;911.7720569857536;983.3952119446632;1009.9597414662909;5378.19327100938;5408.594355423359;5453.972730136324;5474.863128421821;5523.7790488380015;424.69422016148326;429.05607663141217;430.2019753357477;434.5133450535357;436.27795997623986;3834.2906562286066;3872.5546562145714;3905.6484916357663;3931.66580840626;3960.34654282046;10031.448270345201;10102.09081182697;10465.476726163814;10509.737256568495;10581;10181.18550515957;10406.635767748092;10430.16558675304;10434.68695939123;10440.947795261127;7860.174681658458;7880.881786773203;7883.7240696575345;8044.718434854869;8065.112837587978;5733.541316694738;5838.562107842014;5871.4715675589405;6040.335563088145;6055.727492262947;9159.22146617545;9282.21101206405;9297.256219502287;9349.579268932779;9395.107464790834;9348.906510935076;9451.669191578261;9611.471369074488;9723.270754693567;9725;7365.7790266292095;7373.446991475554;7382.483226174331;7415.443841712001;7578.696852125853;7970.1631328709655;7992.5204487730925;7994.800129996796;7998.600069996593;8074.111847696631;6946.895796562954;7206.135263768381;7338.449616278694;7411.1477180124975;7520.924790752022;7175.641217938978;7299.890501642373;7391.260873912565;7421.2207718190975;7514.812129696583;6745.730170793114;6808.353206445379;6837.726490940307;6856.382925536725;6856.691448884912;5075.568576671024;5091.643584949018;5208.348956380452;5221.530062294411;5238.659487133325;5020.297158397754;5026.271190677405;5084.440711521804;5123.359580052494;5194.246834209094 10:26:51 INFO - PROCESS | 4469 | |4;prototype.html;312.86077695425547;324.71262932304904;328.2876158735544;334.01132647363806;337.6994474917324;5714.485696287334;5812.302523697157;5813.273340832396;5829.912551311729;5837.357890632038;5606.887862242753;5722.771089156428;5727.484526392624;5732.5987180897355;5734.956855416932;4052.837886484537;4192.7484350938885;4236.173946080516;4319.157764235975;4355.324924636687;4411.602955733983;4416.580424859633;4429.557044295577;4430.800613972379;4446.444194475691;4354.129174165179;4367.410399596061;4386.495553011397;4387.341898715186;4399.736015839044;4178.582141785828;4234.6823988201;4347.239233134189;4393.384926110347;4399.890002749941;3852.768833869977;3853.499045124116;3854.730168888179;3856.8842934711724;3886.4454218312617;5482.780688772445;5501.752421141058;5505.550030236546;5526.098798130974;5527.806526771544;4726.503717109688;4923.483034281385;4998.850034498971;5059.519345662156;5059.747012649353;5878.764849406019;5912.556558258105;5914.674692891889;5920.674362910038;5926.466618004357;4159.897627128813;4176.206520761046;4180.7909604519655;4201.1807697499;4204.5375008749015;5934.1692163097205;6052.334243233241;6053.818385448443;6182.196314479134;6184.628922264678;4228.85199018039;4266.509351424564;4283.935740963826;4288.5711428857485;4304.935425968613;4335.804888780012;4345.630621397217;4354.085642015149;4355.564443555619;4371.978140109279;4868.391451068616;4946.826861059918;4991.950080499221;4994.325766021613;5009.0983622948215;5888.49738860991;5966.194563733927;5975.342712301644;6028.608140470856;6060.181875446759;1479.179055624139;1496.7530357490891;1500.1449173970732;1506.1113942773816;1507.4196434372845;940.5532372123323;965.290511474066;968.6270785747538;975.3660120921317;977.032737589781;5753.223314852525;5778.653280803165;5805.796797112081;5814.622049566765;5833.50415214703;6201.596896201732;6212.596181248205;6215.378462153749;6220.844478887973;6226.813195604139;5629.971850140723;5806.761064422994;5824.417558244142;5848.707564621752;5849;3298.802071875695;3308.17295676081;3318.5022246663193;3320.6181289151573;3328.267781088157;6145.539084568675;6396.712147953353;6402.103705481236;6413.807585772434;6467.838304042437;6434.292227854932;6439.291677915426;6448.161738973903;6450.580712253689;6459.677016149174;6268.185135932391;6478.898587240181;6493.642849643315;6496.7726129585235;6502.739890404426;6228.657423841551;6283.3402492737605;6290.559660823698;6291.245050593958;6299.874002520016;6100.176476175837;6143.416375444325;6178.41305076017;6212.968935155295;6221.4089661482085;5875.73559189846;6177.1969643945995;6392.712327945161;6421.775237866652;6438.29178790342;4289.721168124062;4311.461067366579;4321.286987647129;4325.84859529915;4342.109867477223;6003.339632640494;6230.470410015018;6240.563160578898;6257.687115644108;6267.153934219004;6003.8198854034445;6025.457708806053;6029.60807547508;6039.184710064261;6068.362821903636;6021.711749535149;6027.2520968918525;6032.366601506954;6043.425874541911;6046.727897244723;5819.883602327845;5902;5937.495312898452;5939.227900372924;5951.345352011362;5984.222051133324;6045.697715114139;6083.726232319645;6106.2061931948565;6115.003648212433;5881.794137205177;5947.464728174485;6004.849878753066;6006.129111278928;6011.368806275278 10:26:51 INFO - PROCESS | 4469 | |5;yui.html;723.5586292361659;776.8329809091044;779.6062988190963;839.1817977471961;842.8019415437375;12596.559120430788;13621.7956730649;13730.862691373084;13873.999999999987;13890.861091389083;11610.767784644324;13882.79175812361;13899.513517026906;13930.442782288696;13954.302284885765;817.9386546009058;847.6609356257485;848.4442690038004;849.796048948251;849.8597731374347;832.5629044751494;836.7573403712915;837.2924878477677;839.8194388206534;840.3823189955378;722.8590424867153;844.6283635200523;880.9427387219843;883.8232353529288;886.4592598514901;861.1044513705739;862.9050804411478;863.6977058029639;864.0452300208274;865.1867244789909;624.7469774741237;624.8562830548954;627.7991042866284;628.0077477585404;628.8239292997922;13987.860121398757;14000.92999535006;14038.85961140396;14044.438222471088;14047.64880877976;13689.31553422325;14455.927720361437;14485.493007744784;14505.41978320866;14533;11674.649760507198;11708.473118709679;11756.647300580997;11810.527578896834;11979.580714675032;3882.2235552889533;3906.628870257321;3923.9215215695813;3968.1666849961543;4029.073313137965;48472.75763621194;49319.260211096866;49685.751571242276;49762.502374976146;54607.18089228665;11186.32882027081;11199.160062995308;11363.318200907972;11385.14611404148;11421.885781142082;19066.61866762657;19194.904025479784;19250.903745481184;19317.61364772725;19321.710174347398;8273.917260827435;8324.125966773401;8324.791880203044;8392.118827523143;8472.915270847336;4956.653034287565;4976.5023497649945;4998.600111991032;5041.420236672756;5070.974645126751;3255.4953982132806;3258.902232933016;3273.2471531547403;3280.2947366316357;3288.967110328914;639.8144538083903;642.3448082955359;650.6519012328382;659.1628631637889;670.0284587348267;617.4103730936945;688.2635579929428;706.5831159615851;727.945404094695;736.3262614707589;8562.315014798802;8960.103989600988;8969.50667713269;8970.910290897138;9235.815283694423;643.2152773616181;670.8624731929942;734.6510407556475;735.0848193998506;752.4807882561015;4164.75011499311;4191.580841915784;4198.832046718097;4212.925703945474;4298.613124818781;60127.17875460062;60584.394156058755;60742.69628651829;61354.69322653358;61418.38581614216;52510.73744631329;52807.207891881655;53460;54232.45767542274;55271.17093243605;49113.75443122833;49242.75378623156;49589.50410495849;49753.751231243616;50280;8014.19858014194;8173.18268173178;8199.180081991753;8226.465279756796;8249.381296402673;31650.208744781565;31766.52350214795;31837;32104.197395065312;32193.35613287768;41131.1208215422;44114.33828492511;44568.77715611401;44647.77676111599;44747.32879006882;11072.11423086135;11078.390688512209;11202.327860328407;11427.542898283975;11621.535138594361;11650.242734222249;11990.580329688419;12766.489340426278;12793.232406055666;12797.168184068378;12483.875161248272;12544.498220071095;12698.936505317415;12729.363531823186;13164.210147391188;12755.17091389094;12799.744005119659;13075.215487070805;13233.867661323264;13527.256000920044;12469.75060498803;12640.178388404724;12733.426995785398;12971.805422918475;13429.664258393228;9603.9039609603;10564.84152737725;10665.9466702666;10803.081738052353;10880.347179169275;10350.792984140124;10785.245032847939;10789;10920.890791091988;10980.945095274472 10:26:51 INFO - PROCESS | 4469 | __end_tp_report 10:26:51 INFO - PROCESS | 4469 | __start_cc_report 10:26:51 INFO - PROCESS | 4469 | _x_x_mozilla_cycle_collect,845 10:26:51 INFO - PROCESS | 4469 | __end_cc_report 10:26:51 INFO - PROCESS | 4469 | __startTimestamp1460827611711__endTimestamp 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | ------- Summary: start ------- 10:26:51 INFO - PROCESS | 4469 | Number of tests: 6 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | [#0] dojo.html Cycles:165 Average:5295.35 Median:5529.45 stddev:591.14 (10.7%) stddev-sans-first:566.32 10:26:51 INFO - PROCESS | 4469 | Values: 3058.8 3089.9 3120.4 3126.4 3152.2 5249.1 5312.7 5372.8 5376.2 5378.0 5354.4 5355.3 5374.3 5432.4 5460.8 4765.4 4810.3 4924.2 4959.2 4983.2 4758.7 4922.0 4931.4 4964.0 4982.9 4767.5 4781.4 4853.6 4862.4 4877.3 4870.5 4886.8 4887.8 4891.4 4895.1 4772.4 4773.7 4849.8 4855.7 4893.9 5262.5 5277.7 5283.2 5297.6 5305.0 5645.3 5669.5 5671.5 5672.4 5681.0 5607.2 5672.0 5688.6 5734.0 5753.2 5276.0 5286.2 5288.3 5290.4 5337.6 5776.6 5785.5 5786.6 5787.1 5790.2 5529.4 5561.8 5598.4 5614.9 5636.5 5713.6 5729.5 5732.2 5734.4 5738.6 5562.9 5698.1 5699.4 5707.8 5713.6 5636.2 5665.6 5684.5 5697.0 5718.1 4336.5 4353.5 4353.8 4360.6 4400.4 3836.1 3873.3 3896.7 3913.0 3928.7 5274.5 5373.6 5399.5 5407.7 5433.2 5699.0 5719.5 5719.9 5723.4 5734.2 5350.9 5374.5 5384.0 5384.1 5426.1 4860.9 4931.1 4938.2 4949.3 4964.9 5870.4 5877.6 5885.4 5888.2 5890.4 5526.4 5682.7 5701.0 5704.4 5762.0 5853.8 5858.2 5874.6 5876.8 5891.1 5550.1 5553.8 5560.4 5563.2 5568.4 5635.0 5641.0 5675.1 5677.4 5704.8 5610.2 5612.4 5613.9 5629.6 5645.5 5547.1 5589.5 5592.4 5596.5 5608.6 5317.3 5447.6 5516.1 5517.7 5524.5 5594.8 5627.0 5646.3 5653.3 5657.2 5517.3 5535.4 5538.3 5541.9 5547.1 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | [#1] ext.html Cycles:180 Average:52073.27 Median:20046.74 stddev:95439.98 (476.1%) stddev-sans-first:95629.45 10:26:51 INFO - PROCESS | 4469 | Values: 593.6 628.5 633.5 645.9 662.3 30112.4 30806.2 30875.5 30940.4 36497.3 39130.0 39879.8 39890.6 40011.2 40024.6 8661.9 8890.3 8891.9 8893.9 8894.1 8748.7 8856.9 8881.6 8898.5 8903.9 8889.7 8962.9 8985.0 8987.4 8990.6 8890.7 8957.9 8959.1 8963.9 8972.0 8762.3 8856.5 8865.2 8868.3 8870.9 41249.0 41533.6 41718.2 41761.8 41781.4 3432.3 3473.9 3483.3 3596.2 3964.8 31443.4 31669.5 32004.8 32377.4 32715.8 3489.4 3520.6 3530.3 3535.3 3584.1 294017.0 294572.0 296031.0 296084.5 296284.0 55702.7 56799.0 56812.6 56863.7 56864.7 62245.0 63827.7 63873.4 63902.7 64058.0 16788.7 17007.0 17038.3 17066.5 17069.4 12307.0 12349.1 12391.6 12392.4 12444.7 18644.4 18738.4 18761.6 19669.2 19696.7 7136.9 7170.2 7261.3 7372.2 7396.9 1141.6 1159.7 1176.7 1195.4 1254.0 30782.2 32854.3 32951.2 34408.4 34968.8 1125.0 1148.2 1185.2 1216.1 1228.0 16600.8 16636.3 16714.0 16738.4 16849.9 447758.0 452274.0 454420.0 455063.0 455538.0 55600.7 56554.7 56566.0 56603.4 56606.7 1297.6 1388.1 1407.1 1420.7 1485.4 30291.0 31307.7 32790.3 32840.2 33238.0 45329.5 46306.8 46380.0 46403.5 46420.0 311383.0 318142.0 318513.0 318611.0 318988.0 27812.3 27909.3 28288.9 28354.3 28365.4 45582.0 45800.8 46019.3 46438.8 46913.3 38399.2 38764.6 39483.2 39575.6 40019.8 38054.6 38232.4 38450.2 38731.6 39134.0 32140.8 35560.6 35819.9 38853.0 39322.4 30932.2 32305.5 32489.8 32493.2 32513.5 25179.6 26922.9 27131.9 27367.0 27423.3 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | [#2] jquery.html Cycles:180 Average:28120.37 Median:2231.51 stddev:81453.44 (3650.1%) stddev-sans-first:81655.28 10:26:51 INFO - PROCESS | 4469 | Values: 368.2 394.4 403.9 404.7 407.7 15756.5 17601.3 17969.0 18022.0 18083.0 18321.6 18759.4 19090.4 19106.6 19188.3 5645.9 5713.6 5793.7 5840.2 5842.0 5478.9 5654.5 5656.8 5659.9 5677.3 5423.9 5599.5 5622.6 5625.5 5633.0 5576.6 5586.4 5630.6 5632.0 5637.2 4948.8 5024.8 5027.0 5216.7 5519.6 12070.2 12180.1 12182.6 12197.5 15351.5 2125.9 2207.8 2255.2 2309.5 2442.7 9734.6 10601.2 11364.7 13953.0 14506.2 1851.6 1899.7 1967.0 1969.6 2010.2 78435.0 79141.2 79681.0 79943.2 80338.6 10422.2 10513.9 10520.8 10533.3 10540.3 14348.7 14404.2 14433.7 14457.1 14548.3 7802.0 7934.8 7940.0 8064.9 8099.1 7781.1 7830.8 7853.8 7931.6 7970.4 4212.6 4395.8 4441.6 4505.0 4538.8 1838.7 1903.6 1912.6 1922.8 1936.4 929.9 1033.8 1052.0 1078.3 1125.0 18210.5 18722.6 19033.9 19087.6 19125.9 997.9 1032.3 1053.8 1072.3 1078.9 10135.7 10449.7 10591.2 10612.7 10615.8 481171.0 488367.0 499915.0 503075.0 504216.0 61407.7 79383.0 86967.0 92846.5 93148.1 977.5 977.8 1006.3 1017.8 1034.6 16484.7 16629.4 16701.5 16835.9 17105.0 28026.0 35998.0 36232.6 36280.3 38029.8 51002.2 51739.7 52779.0 53418.2 53631.2 8327.3 8494.0 8637.6 8669.9 8783.8 13100.4 13183.3 13472.2 13508.9 13684.5 11812.6 11976.7 12026.5 12117.2 12292.3 11116.5 11448.3 11771.8 11857.9 11906.9 11414.9 11938.3 12115.6 12502.9 12616.6 8001.0 8392.5 8417.5 8712.5 8776.7 8780.0 10938.9 12074.5 12235.4 12314.7 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | [#3] mootools.html Cycles:180 Average:5491.37 Median:5005.02 stddev:3097.22 (61.9%) stddev-sans-first:3090.16 10:26:51 INFO - PROCESS | 4469 | Values: 1335.3 1417.6 1504.8 1694.8 1860.3 7954.2 8247.3 8257.4 8261.4 8295.5 8088.1 8181.3 8216.1 8237.0 8242.4 2008.8 2212.2 2217.7 2247.9 2276.2 2280.5 2285.9 2298.4 2306.7 2307.4 2182.0 2225.5 2228.2 2232.1 2232.4 1972.9 2176.6 2236.3 2240.1 2240.8 2212.5 2216.1 2224.3 2226.8 2255.3 8183.0 8199.4 8235.2 8277.7 8283.4 4893.7 5001.5 5017.7 5033.3 5038.3 3164.2 3177.0 3214.0 3236.1 3254.0 1061.1 1081.2 1083.9 1092.3 1105.8 11215.4 11224.1 11238.9 11278.4 11297.5 4208.1 4252.6 4372.8 4420.2 4420.6 9616.9 9659.2 9684.6 9699.9 9710.6 4553.6 4969.8 4993.0 5008.5 5023.7 4559.7 4593.7 4622.5 4638.1 4655.3 3788.2 3827.6 3884.5 3908.8 3940.5 1148.4 1151.8 1151.8 1165.3 1201.1 763.7 861.8 911.8 983.4 1010.0 5378.2 5408.6 5454.0 5474.9 5523.8 424.7 429.1 430.2 434.5 436.3 3834.3 3872.6 3905.6 3931.7 3960.3 10031.4 10102.1 10465.5 10509.7 10581.0 10181.2 10406.6 10430.2 10434.7 10440.9 7860.2 7880.9 7883.7 8044.7 8065.1 5733.5 5838.6 5871.5 6040.3 6055.7 9159.2 9282.2 9297.3 9349.6 9395.1 9348.9 9451.7 9611.5 9723.3 9725.0 7365.8 7373.4 7382.5 7415.4 7578.7 7970.2 7992.5 7994.8 7998.6 8074.1 6946.9 7206.1 7338.4 7411.1 7520.9 7175.6 7299.9 7391.3 7421.2 7514.8 6745.7 6808.4 6837.7 6856.4 6856.7 5075.6 5091.6 5208.3 5221.5 5238.7 5020.3 5026.3 5084.4 5123.4 5194.2 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | [#4] prototype.html Cycles:180 Average:5037.25 Median:5827.17 stddev:1520.00 (26.1%) stddev-sans-first:1482.33 10:26:51 INFO - PROCESS | 4469 | Values: 312.9 324.7 328.3 334.0 337.7 5714.5 5812.3 5813.3 5829.9 5837.4 5606.9 5722.8 5727.5 5732.6 5735.0 4052.8 4192.7 4236.2 4319.2 4355.3 4411.6 4416.6 4429.6 4430.8 4446.4 4354.1 4367.4 4386.5 4387.3 4399.7 4178.6 4234.7 4347.2 4393.4 4399.9 3852.8 3853.5 3854.7 3856.9 3886.4 5482.8 5501.8 5505.6 5526.1 5527.8 4726.5 4923.5 4998.9 5059.5 5059.7 5878.8 5912.6 5914.7 5920.7 5926.5 4159.9 4176.2 4180.8 4201.2 4204.5 5934.2 6052.3 6053.8 6182.2 6184.6 4228.9 4266.5 4283.9 4288.6 4304.9 4335.8 4345.6 4354.1 4355.6 4372.0 4868.4 4946.8 4992.0 4994.3 5009.1 5888.5 5966.2 5975.3 6028.6 6060.2 1479.2 1496.8 1500.1 1506.1 1507.4 940.6 965.3 968.6 975.4 977.0 5753.2 5778.7 5805.8 5814.6 5833.5 6201.6 6212.6 6215.4 6220.8 6226.8 5630.0 5806.8 5824.4 5848.7 5849.0 3298.8 3308.2 3318.5 3320.6 3328.3 6145.5 6396.7 6402.1 6413.8 6467.8 6434.3 6439.3 6448.2 6450.6 6459.7 6268.2 6478.9 6493.6 6496.8 6502.7 6228.7 6283.3 6290.6 6291.2 6299.9 6100.2 6143.4 6178.4 6213.0 6221.4 5875.7 6177.2 6392.7 6421.8 6438.3 4289.7 4311.5 4321.3 4325.8 4342.1 6003.3 6230.5 6240.6 6257.7 6267.2 6003.8 6025.5 6029.6 6039.2 6068.4 6021.7 6027.3 6032.4 6043.4 6046.7 5819.9 5902.0 5937.5 5939.2 5951.3 5984.2 6045.7 6083.7 6106.2 6115.0 5881.8 5947.5 6004.8 6006.1 6011.4 10:26:51 INFO - PROCESS | 4469 | 10:26:51 INFO - PROCESS | 4469 | [#5] yui.html Cycles:180 Average:14451.95 Median:44341.56 stddev:16468.22 (37.1%) stddev-sans-first:16482.14 10:26:51 INFO - PROCESS | 4469 | Values: 723.6 776.8 779.6 839.2 842.8 12596.6 13621.8 13730.9 13874.0 13890.9 11610.8 13882.8 13899.5 13930.4 13954.3 817.9 847.7 848.4 849.8 849.9 832.6 836.8 837.3 839.8 840.4 722.9 844.6 880.9 883.8 886.5 861.1 862.9 863.7 864.0 865.2 624.7 624.9 627.8 628.0 628.8 13987.9 14000.9 14038.9 14044.4 14047.6 13689.3 14455.9 14485.5 14505.4 14533.0 11674.6 11708.5 11756.6 11810.5 11979.6 3882.2 3906.6 3923.9 3968.2 4029.1 48472.8 49319.3 49685.8 49762.5 54607.2 11186.3 11199.2 11363.3 11385.1 11421.9 19066.6 19194.9 19250.9 19317.6 19321.7 8273.9 8324.1 8324.8 8392.1 8472.9 4956.7 4976.5 4998.6 5041.4 5071.0 3255.5 3258.9 3273.2 3280.3 3289.0 639.8 642.3 650.7 659.2 670.0 617.4 688.3 706.6 727.9 736.3 8562.3 8960.1 8969.5 8970.9 9235.8 643.2 670.9 734.7 735.1 752.5 4164.8 4191.6 4198.8 4212.9 4298.6 60127.2 60584.4 60742.7 61354.7 61418.4 52510.7 52807.2 53460.0 54232.5 55271.2 49113.8 49242.8 49589.5 49753.8 50280.0 8014.2 8173.2 8199.2 8226.5 8249.4 31650.2 31766.5 31837.0 32104.2 32193.4 41131.1 44114.3 44568.8 44647.8 44747.3 11072.1 11078.4 11202.3 11427.5 11621.5 11650.2 11990.6 12766.5 12793.2 12797.2 12483.9 12544.5 12698.9 12729.4 13164.2 12755.2 12799.7 13075.2 13233.9 13527.3 12469.8 12640.2 12733.4 12971.8 13429.7 9603.9 10564.8 10665.9 10803.1 10880.3 10350.8 10785.2 10789.0 10920.9 10980.9 10:26:51 INFO - PROCESS | 4469 | -------- Summary: end -------- 10:26:51 INFO - PROCESS | 4469 | 10:26:52 INFO - TEST-INFO | 4469: exit 0 10:26:52 INFO - TEST-OK | dromaeo_css | took 1112715ms 10:26:52 INFO - TEST-START | kraken 10:26:52 INFO - operating with platform_type : linux_ 10:26:52 INFO - Initialising browser for kraken test... 10:26:52 INFO - TEST-INFO | started process 4646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC1ipaV/profile http://localhost:43077/getInfo.html) 10:26:56 INFO - PROCESS | 4646 | __metrics Screen width/height:1600/1200 10:26:56 INFO - PROCESS | 4646 | colorDepth:24 10:26:56 INFO - PROCESS | 4646 | Browser inner width/height: 1024/697 10:26:56 INFO - PROCESS | 4646 | __metrics 10:26:58 ERROR - PROCESS | 4646 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:26:59 INFO - TEST-INFO | 4646: exit 0 10:26:59 INFO - Browser initialized. 10:26:59 INFO - Running cycle 1/1 for kraken test... 10:26:59 INFO - TEST-INFO | started process 4729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC1ipaV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:10 INFO - PROCESS | 4729 | RSS: Main: 153055232 10:27:10 INFO - PROCESS | 4729 | 10:27:13 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43077/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:14 INFO - PROCESS | 4729 | RSS: Main: 208388096 10:27:14 INFO - PROCESS | 4729 | 10:27:17 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43077/tests/kraken/driver.html?testName=audio-dft) 10:27:17 INFO - PROCESS | 4729 | RSS: Main: 193372160 10:27:17 INFO - PROCESS | 4729 | 10:27:20 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43077/tests/kraken/driver.html?testName=audio-fft) 10:27:21 INFO - PROCESS | 4729 | RSS: Main: 264523776 10:27:21 INFO - PROCESS | 4729 | 10:27:23 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43077/tests/kraken/driver.html?testName=audio-oscillator) 10:27:23 INFO - PROCESS | 4729 | RSS: Main: 172548096 10:27:23 INFO - PROCESS | 4729 | 10:27:26 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:26 INFO - PROCESS | 4729 | RSS: Main: 176775168 10:27:26 INFO - PROCESS | 4729 | 10:27:29 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43077/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:30 INFO - PROCESS | 4729 | RSS: Main: 213135360 10:27:30 INFO - PROCESS | 4729 | 10:27:33 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43077/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:34 INFO - PROCESS | 4729 | RSS: Main: 213962752 10:27:34 INFO - PROCESS | 4729 | 10:27:37 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43077/tests/kraken/driver.html?testName=json-parse-financial) 10:27:37 INFO - PROCESS | 4729 | RSS: Main: 213868544 10:27:37 INFO - PROCESS | 4729 | 10:27:39 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:39 INFO - PROCESS | 4729 | RSS: Main: 204570624 10:27:39 INFO - PROCESS | 4729 | 10:27:41 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:42 INFO - PROCESS | 4729 | RSS: Main: 205328384 10:27:42 INFO - PROCESS | 4729 | 10:27:44 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:44 INFO - PROCESS | 4729 | RSS: Main: 218955776 10:27:44 INFO - PROCESS | 4729 | 10:27:47 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:48 INFO - PROCESS | 4729 | RSS: Main: 223117312 10:27:48 INFO - PROCESS | 4729 | 10:27:50 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:51 INFO - PROCESS | 4729 | RSS: Main: 217645056 10:27:51 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:43077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43077/tests/kraken/driver.html?testName=ai-astar) 10:27:53 INFO - PROCESS | 4729 | RSS: Main: 282169344 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | __start_tp_report 10:27:53 INFO - PROCESS | 4729 | _x_x_mozilla_page_load 10:27:53 INFO - PROCESS | 4729 | _x_x_mozilla_page_load_details 10:27:53 INFO - PROCESS | 4729 | |i|pagename|runs| 10:27:53 INFO - PROCESS | 4729 | |0;ai-astar;112;111;108;111;112;111;99;109;110;110 10:27:53 INFO - PROCESS | 4729 | |1;audio-beat-detection;150;138;150;196;128;161;171;129;180;134 10:27:53 INFO - PROCESS | 4729 | |2;audio-dft;164;160;161;161;162;162;164;163;161;160 10:27:53 INFO - PROCESS | 4729 | |3;audio-fft;75;76;98;110;73;73;77;108;100;74 10:27:53 INFO - PROCESS | 4729 | |4;audio-oscillator;92;93;148;93;93;93;151;93;93;146 10:27:53 INFO - PROCESS | 4729 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 10:27:53 INFO - PROCESS | 4729 | |6;imaging-darkroom;144;146;146;146;145;146;146;145;146;147 10:27:53 INFO - PROCESS | 4729 | |7;imaging-desaturate;95;95;94;95;103;95;95;95;95;95 10:27:53 INFO - PROCESS | 4729 | |8;json-parse-financial;57;56;56;57;56;57;65;74;56;53 10:27:53 INFO - PROCESS | 4729 | |9;json-stringify-tinderbox;61;62;61;62;61;61;62;62;61;62 10:27:53 INFO - PROCESS | 4729 | |10;stanford-crypto-aes;85;77;76;81;75;84;76;77;78;77 10:27:53 INFO - PROCESS | 4729 | |11;stanford-crypto-ccm;129;130;125;133;132;146;127;136;164;137 10:27:53 INFO - PROCESS | 4729 | |12;stanford-crypto-pbkdf2;172;167;170;165;170;172;167;172;171;174 10:27:53 INFO - PROCESS | 4729 | |13;stanford-crypto-sha256-iterative;68;70;69;68;68;67;68;66;68;67 10:27:53 INFO - PROCESS | 4729 | __end_tp_report 10:27:53 INFO - PROCESS | 4729 | __start_cc_report 10:27:53 INFO - PROCESS | 4729 | _x_x_mozilla_cycle_collect,1611 10:27:53 INFO - PROCESS | 4729 | __end_cc_report 10:27:53 INFO - PROCESS | 4729 | __startTimestamp1460827673437__endTimestamp 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | ------- Summary: start ------- 10:27:53 INFO - PROCESS | 4729 | Number of tests: 14 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.83 (3.5%) stddev-sans-first:3.94 10:27:53 INFO - PROCESS | 4729 | Values: 112.0 111.0 108.0 111.0 112.0 111.0 99.0 109.0 110.0 110.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:155.50 stddev:23.01 (14.8%) stddev-sans-first:24.37 10:27:53 INFO - PROCESS | 4729 | Values: 150.0 138.0 150.0 196.0 128.0 161.0 171.0 129.0 180.0 134.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.33 10:27:53 INFO - PROCESS | 4729 | Values: 164.0 160.0 161.0 161.0 162.0 162.0 164.0 163.0 161.0 160.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#3] audio-fft Cycles:10 Average:86.40 Median:74.50 stddev:15.57 (20.9%) stddev-sans-first:15.96 10:27:53 INFO - PROCESS | 4729 | Values: 75.0 76.0 98.0 110.0 73.0 73.0 77.0 108.0 100.0 74.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:26.83 (28.8%) stddev-sans-first:27.70 10:27:53 INFO - PROCESS | 4729 | Values: 92.0 93.0 148.0 93.0 93.0 93.0 151.0 93.0 93.0 146.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:27:53 INFO - PROCESS | 4729 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 10:27:53 INFO - PROCESS | 4729 | Values: 144.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 147.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.58 (2.7%) stddev-sans-first:2.73 10:27:53 INFO - PROCESS | 4729 | Values: 95.0 95.0 94.0 95.0 103.0 95.0 95.0 95.0 95.0 95.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:6.18 (10.8%) stddev-sans-first:6.53 10:27:53 INFO - PROCESS | 4729 | Values: 57.0 56.0 56.0 57.0 56.0 57.0 65.0 74.0 56.0 53.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:27:53 INFO - PROCESS | 4729 | Values: 61.0 62.0 61.0 62.0 61.0 61.0 62.0 62.0 61.0 62.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:3.50 (4.5%) stddev-sans-first:2.85 10:27:53 INFO - PROCESS | 4729 | Values: 85.0 77.0 76.0 81.0 75.0 84.0 76.0 77.0 78.0 77.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:134.50 stddev:11.53 (8.6%) stddev-sans-first:11.96 10:27:53 INFO - PROCESS | 4729 | Values: 129.0 130.0 125.0 133.0 132.0 146.0 127.0 136.0 164.0 137.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.50 stddev:2.83 (1.6%) stddev-sans-first:2.91 10:27:53 INFO - PROCESS | 4729 | Values: 172.0 167.0 170.0 165.0 170.0 172.0 167.0 172.0 171.0 174.0 10:27:53 INFO - PROCESS | 4729 | 10:27:53 INFO - PROCESS | 4729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 10:27:53 INFO - PROCESS | 4729 | Values: 68.0 70.0 69.0 68.0 68.0 67.0 68.0 66.0 68.0 67.0 10:27:53 INFO - PROCESS | 4729 | -------- Summary: end -------- 10:27:53 INFO - PROCESS | 4729 | 10:27:54 INFO - TEST-INFO | 4729: exit 0 10:27:54 INFO - TEST-OK | kraken | took 61932ms 10:27:54 INFO - SUITE-END | took 1174s 10:27:54 INFO - Completed test suite (00:19:34) 10:27:54 INFO - javascript benchmark 10:27:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.7552995760343, 3089.860956256968, 3120.4383211022023, 3126.359096385241, 3152.164676360764, 5249.055170069386, 5312.654677445968, 5372.811951581695, 5376.166694162402, 5378.031954248234, 5354.357477102753, 5355.277037599923, 5374.274472946151, 5432.429594892538, 5460.808871689492, 4765.404324459442, 4810.278458231267, 4924.162892308298, 4959.2313191455205, 4983.227599722049, 4758.714477131366, 4922.0, 4931.358923339979, 4964.0, 4982.9252561211615, 4767.547083027107, 4781.37842080529, 4853.587445067156, 4862.367892173995, 4877.292792545061, 4870.488598697121, 4886.755662216875, 4887.804487820483, 4891.413030436335, 4895.069936712013, 4772.379590653228, 4773.689710168828, 4849.75751212438, 4855.684380515255, 4893.8776530586665, 5262.473752624707, 5277.683338999673, 5283.181106928432, 5297.602679798992, 5305.0, 5645.294338207724, 5669.518090962273, 5671.517920976722, 5672.432756724335, 5681.034224181899, 5607.186957891124, 5672.0, 5688.60179787415, 5734.0, 5753.165790960329, 5276.0, 5286.233496143076, 5288.286081379041, 5290.39160496544, 5337.599680023936, 5776.566757493205, 5785.537157027427, 5786.594938354275, 5787.131930210502, 5790.218320526759, 5529.447055294519, 5561.833145005657, 5598.412166722517, 5614.943850561442, 5636.4927156556105, 5713.628614140068, 5729.455701708331, 5732.226149469851, 5734.426557344315, 5738.569607279471, 5562.888742225214, 5698.116791897262, 5699.373068962411, 5707.828765137053, 5713.628614140068, 5636.154576813429, 5665.603407761417, 5684.516816070598, 5697.03150464422, 5718.142278658152, 4336.457942757155, 4353.542877997828, 4353.847615333448, 4360.563943605614, 4400.44994375703, 3836.07934095815, 3873.283442563135, 3896.7272290939927, 3912.980435097806, 3928.685705143582, 5274.498922602346, 5373.623846330797, 5399.4600539945695, 5407.70257635826, 5433.1850222466155, 5699.0, 5719.456651618089, 5719.914201286984, 5723.370429252779, 5734.168545560954, 5350.946490535045, 5374.48942350476, 5384.030874442638, 5384.0847056000575, 5426.077566813651, 4860.8784780380065, 4931.087748766489, 4938.209886418156, 4949.282354058713, 4964.900701986012, 5870.412958704095, 5877.647341159544, 5885.411458854166, 5888.175655408247, 5890.3815099414805, 5526.447355264441, 5682.744276507485, 5701.0, 5704.401037891128, 5761.971190144022, 5853.795117170878, 5858.209141765978, 5874.559408044328, 5876.764929402776, 5891.05743081105, 5550.111982082847, 5553.777848885999, 5560.443955604407, 5563.221149039056, 5568.359638641446, 5635.042042852643, 5640.971795141162, 5675.0636145035605, 5677.403872593318, 5704.828855134353, 5610.214569960291, 5612.354579223442, 5613.887722245614, 5629.605927585029, 5645.491905728504, 5547.057000310037, 5589.496945274945, 5592.3848376677715, 5596.496315331639, 5608.6073974823, 5317.308749862493, 5447.591430642638, 5516.089845175501, 5517.668939863621, 5524.502794748331, 5594.804181853616, 5626.971865140648, 5646.322441307069, 5653.293338332708, 5657.2079908811975, 5517.310336207974, 5535.446455354432, 5538.307711536058, 5541.944580554143, 5547.140193270049], "value": 5255.975632475703, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.5933885288578, 628.4783629587441, 633.4773811605427, 645.8643684826188, 662.2979641579925, 30112.397752044973, 30806.229844253903, 30875.536866946986, 30940.381192376168, 36497.27005459889, 39130.0, 39879.80060099703, 39890.601093989055, 40011.19977600446, 40024.599754002455, 8661.87007194894, 8890.333225008118, 8891.866622000674, 8893.911060889406, 8894.066123057082, 8748.650053997833, 8856.8671469928, 8881.644734210624, 8898.510581917992, 8903.910960890405, 8889.73330800077, 8962.910370896272, 8985.0, 8987.41581797181, 8990.59542320594, 8890.733278001639, 8957.865632015524, 8959.148880856374, 8963.865542016874, 8972.0, 8762.34282428814, 8856.468611883307, 8865.157810008039, 8868.334874884345, 8870.86693699595, 41249.0, 41533.584664153575, 41718.1656366874, 41761.791191044154, 41781.37327940083, 3432.3306955143757, 3473.9131521711906, 3483.338165748525, 3596.2088340565033, 3964.801759911993, 31443.37113257722, 31669.52495712566, 32004.839975800205, 32377.352452951043, 32715.836420817745, 3489.3719130556487, 3520.5951315598522, 3530.3292374448774, 3535.275268569937, 3584.121890136933, 294017.0, 294572.0, 296031.0, 296084.5195774029, 296284.0, 55702.72148639231, 56799.0, 56812.57968550819, 56863.71568142215, 56864.71567642135, 62245.0, 63827.680861596324, 63873.36126638767, 63902.680486597266, 64058.0, 16788.6642267154, 17007.0, 17038.31846726117, 17066.48800535986, 17069.40257090996, 12307.0, 12349.135560510678, 12391.566295179626, 12392.442340094718, 12444.688882778002, 18644.440666780018, 18738.40723538487, 18761.624767504574, 19669.21323147087, 19696.70454943177, 7136.857262854714, 7170.2471240520035, 7261.273872612696, 7372.225916278713, 7396.889046664304, 1141.5662048421548, 1159.7158696119504, 1176.705823544114, 1195.3664557784389, 1254.021862946903, 30782.230444239074, 32854.34291314208, 32951.1762205942, 34408.41936854696, 34968.82515587406, 1124.9718757030976, 1148.2249481599886, 1185.211834130311, 1216.1243904388825, 1227.9799729445012, 16600.83399166017, 16636.251368688438, 16714.0, 16738.4141555045, 16849.915750421416, 447758.0, 452274.0, 454420.0, 455063.0, 455538.0, 55600.72199638976, 56554.7172264136, 56566.0, 56603.43396566064, 56606.716966414904, 1297.6236891301605, 1388.0630574362265, 1407.0783636717965, 1420.6732451535997, 1485.3612946433138, 30291.0, 31307.677694792397, 32790.34419311648, 32840.178995525304, 33238.0, 45329.546704532535, 46306.7684661588, 46380.0, 46403.53596463992, 46420.0, 311383.0, 318142.0, 318513.0, 318611.0, 318988.0, 27812.304692382044, 27909.302267442665, 28288.85855570709, 28354.2911427216, 28365.432691345646, 45582.0, 45800.770996144805, 46019.3097103537, 46438.76780616075, 46913.296300556205, 38399.232015360096, 38764.6123538761, 39483.21033579255, 39575.60424395835, 40019.79990100031, 38054.61945380621, 38232.426513601764, 38450.230995379374, 38731.6126838728, 39134.0, 32140.839295803373, 35560.6416391718, 35819.88071371826, 38853.0, 39322.41016384814, 30932.22669433282, 32305.51541726829, 32489.837550812095, 32493.18767030843, 32513.512297315086, 25179.622305665795, 26922.865385672947, 27131.86434067817, 27367.0, 27423.314417139733], "value": 19293.658952589412, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.18630825874817, 394.44580364587756, 403.9394090886367, 404.6762589928058, 407.6758976613592, 15756.527304180878, 17601.29594816209, 17969.0, 18021.99999999998, 18083.0, 18321.633567328678, 18759.437216883514, 19090.427287181374, 19106.61786764264, 19188.328408505706, 5645.887082258363, 5713.628614140089, 5793.71031448428, 5840.182374467578, 5842.0, 5478.91781623276, 5654.491095801377, 5656.773729050833, 5659.915101273484, 5677.347105082927, 5423.945760542403, 5599.524040456546, 5622.578306626999, 5625.493705566499, 5633.042382794934, 5576.609637325389, 5586.385497595261, 5630.577706671996, 5632.0, 5637.238972738689, 4948.826791062295, 5024.773885175176, 5027.019731152427, 5216.713080780555, 5519.558435325164, 12070.215435996632, 12180.147389682726, 12182.573609923698, 12197.45111469986, 15351.539453816404, 2125.861818981761, 2207.7792220777956, 2255.2444930948154, 2309.4919117794057, 2442.670239517678, 9734.561944712505, 10601.204909631808, 11364.659060228207, 13953.0, 14506.202158881257, 1851.5648822526696, 1899.705545640428, 1966.9803301967083, 1969.5962327722925, 2010.2160157538572, 78435.0, 79141.20858791396, 79681.0, 79943.20056799415, 80338.59830700868, 10422.21833362501, 10513.9474302628, 10520.789584208273, 10533.315334503233, 10540.262181647211, 14348.713025739427, 14404.207768572829, 14433.711325773425, 14457.132572045712, 14548.345324460424, 7802.0, 7934.841303173905, 7939.9753062968575, 8064.879026814602, 8099.109097999215, 7781.144074151839, 7830.8433831323055, 7853.803654908673, 7931.603419828985, 7970.362371010306, 4212.620864122244, 4395.824167033346, 4441.644668426518, 4505.031418245093, 4538.750368729686, 1838.6874231380698, 1903.6287923854993, 1912.5792325688606, 1922.826945574905, 1936.390037138297, 929.8744669469535, 1033.7622346860114, 1051.952662130206, 1078.336822853939, 1125.0012411752434, 18210.544736381697, 18722.625547488973, 19033.859413196667, 19087.61824763497, 19125.904370478336, 997.850322451638, 1032.2825636182781, 1053.7681710023783, 1072.3137192197, 1078.8705355357251, 10135.69592912199, 10449.738756530995, 10591.152707783358, 10612.681619551426, 10615.787684246427, 481171.0, 488367.0, 499915.0, 503075.0, 504216.0, 61407.6929615358, 79383.0, 86967.0, 92846.53576732073, 93148.06851931529, 977.5161295158941, 977.7702239973601, 1006.335818359879, 1017.7760892603616, 1034.5965073621294, 16484.67030659356, 16629.417970370978, 16701.49895503137, 16835.915820420818, 17105.0, 28026.0, 35998.0, 36232.63767362293, 36280.274394511434, 38029.809850950565, 51002.23496647479, 51739.74130129325, 52779.0, 53418.198727018345, 53631.19553206627, 8327.292180164754, 8493.957530212308, 8637.611307491303, 8669.869951950599, 8783.780405489913, 13100.410481528164, 13183.274919879499, 13472.191668499921, 13508.932455338054, 13684.452621895012, 11812.645620631394, 11976.700582485508, 12026.518939242333, 12117.212381195546, 12292.323922184009, 11116.49975751077, 11448.255863369188, 11771.823422648838, 11857.940710296738, 11906.880931190577, 11414.885851141382, 11938.28370297785, 12115.636530904087, 12502.909784304571, 12616.55842045524, 8000.95999520022, 8392.4544904581, 8417.494950303002, 8712.477251364939, 8776.736697899074, 8780.034196238536, 10938.890611094106, 12074.45664945097, 12235.388230588613, 12314.692132696755], "value": 8898.921988019163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.3189873164683, 1417.5605562275696, 1504.7517159668653, 1694.7796786417764, 1860.3116846766698, 7954.2443467870535, 8247.257746802787, 8257.421980461362, 8261.380396470273, 8295.460795048317, 8088.069871964726, 8181.304589109933, 8216.137305582917, 8236.958815205915, 8242.423030387876, 2008.7790343062252, 2212.214663794354, 2217.700610417597, 2247.910083596654, 2276.248837883503, 2280.532490839374, 2285.874276914769, 2298.367948814081, 2306.688597039395, 2307.3539408965435, 2182.0289970962926, 2225.4547635829244, 2228.186711850179, 2232.062533735827, 2232.408411770874, 1972.9112189951416, 2176.55380646967, 2236.2508559632543, 2240.092762431218, 2240.809531189851, 2212.5243072739277, 2216.1024784962115, 2224.27710993926, 2226.76618955009, 2255.2670382125875, 8182.959085204596, 8199.42604017719, 8235.21765432283, 8277.668893244263, 8283.37874659397, 4893.7063776173545, 5001.549860512535, 5017.724025178613, 5033.295338652591, 5038.269450929594, 3164.161497203243, 3176.9841150794327, 3214.035789263212, 3236.0777178504013, 3253.9511907321407, 1061.0980666433547, 1081.1891081688734, 1083.918706097046, 1092.3118435385736, 1105.8230683090667, 11215.38315392653, 11224.102071834233, 11238.887611123866, 11278.436078196139, 11297.49161287744, 4208.137331847025, 4252.574742525722, 4372.781360931941, 4420.248557745191, 4420.58004489573, 9616.9038309616, 9659.227261819178, 9684.56419461126, 9699.903000970042, 9710.563024663907, 4553.612942899825, 4969.751512424365, 4993.0, 5008.499150085036, 5023.6985780853265, 4559.749213793207, 4593.655475839326, 4622.4684161321875, 4638.141943740419, 4655.255159174516, 3788.204477059793, 3827.598102199229, 3884.533855937249, 3908.785016824045, 3940.4680368150507, 1148.3626587243994, 1151.7581307925261, 1151.7696460707725, 1165.3124656452565, 1201.0991756182864, 763.7250589787672, 861.8276344731079, 911.7720569857536, 983.3952119446632, 1009.9597414662909, 5378.19327100938, 5408.594355423359, 5453.972730136324, 5474.863128421821, 5523.7790488380015, 424.69422016148326, 429.05607663141217, 430.2019753357477, 434.5133450535357, 436.27795997623986, 3834.2906562286066, 3872.5546562145714, 3905.6484916357663, 3931.66580840626, 3960.34654282046, 10031.448270345201, 10102.09081182697, 10465.476726163814, 10509.737256568495, 10581.0, 10181.18550515957, 10406.635767748092, 10430.16558675304, 10434.68695939123, 10440.947795261127, 7860.174681658458, 7880.881786773203, 7883.7240696575345, 8044.718434854869, 8065.112837587978, 5733.541316694738, 5838.562107842014, 5871.4715675589405, 6040.335563088145, 6055.727492262947, 9159.22146617545, 9282.21101206405, 9297.256219502287, 9349.579268932779, 9395.107464790834, 9348.906510935076, 9451.669191578261, 9611.471369074488, 9723.270754693567, 9725.0, 7365.7790266292095, 7373.446991475554, 7382.483226174331, 7415.443841712001, 7578.696852125853, 7970.1631328709655, 7992.5204487730925, 7994.800129996796, 7998.600069996593, 8074.111847696631, 6946.895796562954, 7206.135263768381, 7338.449616278694, 7411.1477180124975, 7520.924790752022, 7175.641217938978, 7299.890501642373, 7391.260873912565, 7421.2207718190975, 7514.812129696583, 6745.730170793114, 6808.353206445379, 6837.726490940307, 6856.382925536725, 6856.691448884912, 5075.568576671024, 5091.643584949018, 5208.348956380452, 5221.530062294411, 5238.659487133325, 5020.297158397754, 5026.271190677405, 5084.440711521804, 5123.359580052494, 5194.246834209094], "value": 4332.426227336413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.86077695425547, 324.71262932304904, 328.2876158735544, 334.01132647363806, 337.6994474917324, 5714.485696287334, 5812.302523697157, 5813.273340832396, 5829.912551311729, 5837.357890632038, 5606.887862242753, 5722.771089156428, 5727.484526392624, 5732.5987180897355, 5734.956855416932, 4052.837886484537, 4192.7484350938885, 4236.173946080516, 4319.157764235975, 4355.324924636687, 4411.602955733983, 4416.580424859633, 4429.557044295577, 4430.800613972379, 4446.444194475691, 4354.129174165179, 4367.410399596061, 4386.495553011397, 4387.341898715186, 4399.736015839044, 4178.582141785828, 4234.6823988201, 4347.239233134189, 4393.384926110347, 4399.890002749941, 3852.768833869977, 3853.499045124116, 3854.730168888179, 3856.8842934711724, 3886.4454218312617, 5482.780688772445, 5501.752421141058, 5505.550030236546, 5526.098798130974, 5527.806526771544, 4726.503717109688, 4923.483034281385, 4998.850034498971, 5059.519345662156, 5059.747012649353, 5878.764849406019, 5912.556558258105, 5914.674692891889, 5920.674362910038, 5926.466618004357, 4159.897627128813, 4176.206520761046, 4180.7909604519655, 4201.1807697499, 4204.5375008749015, 5934.1692163097205, 6052.334243233241, 6053.818385448443, 6182.196314479134, 6184.628922264678, 4228.85199018039, 4266.509351424564, 4283.935740963826, 4288.5711428857485, 4304.935425968613, 4335.804888780012, 4345.630621397217, 4354.085642015149, 4355.564443555619, 4371.978140109279, 4868.391451068616, 4946.826861059918, 4991.950080499221, 4994.325766021613, 5009.0983622948215, 5888.49738860991, 5966.194563733927, 5975.342712301644, 6028.608140470856, 6060.181875446759, 1479.179055624139, 1496.7530357490891, 1500.1449173970732, 1506.1113942773816, 1507.4196434372845, 940.5532372123323, 965.290511474066, 968.6270785747538, 975.3660120921317, 977.032737589781, 5753.223314852525, 5778.653280803165, 5805.796797112081, 5814.622049566765, 5833.50415214703, 6201.596896201732, 6212.596181248205, 6215.378462153749, 6220.844478887973, 6226.813195604139, 5629.971850140723, 5806.761064422994, 5824.417558244142, 5848.707564621752, 5849.0, 3298.802071875695, 3308.17295676081, 3318.5022246663193, 3320.6181289151573, 3328.267781088157, 6145.539084568675, 6396.712147953353, 6402.103705481236, 6413.807585772434, 6467.838304042437, 6434.292227854932, 6439.291677915426, 6448.161738973903, 6450.580712253689, 6459.677016149174, 6268.185135932391, 6478.898587240181, 6493.642849643315, 6496.7726129585235, 6502.739890404426, 6228.657423841551, 6283.3402492737605, 6290.559660823698, 6291.245050593958, 6299.874002520016, 6100.176476175837, 6143.416375444325, 6178.41305076017, 6212.968935155295, 6221.4089661482085, 5875.73559189846, 6177.1969643945995, 6392.712327945161, 6421.775237866652, 6438.29178790342, 4289.721168124062, 4311.461067366579, 4321.286987647129, 4325.84859529915, 4342.109867477223, 6003.339632640494, 6230.470410015018, 6240.563160578898, 6257.687115644108, 6267.153934219004, 6003.8198854034445, 6025.457708806053, 6029.60807547508, 6039.184710064261, 6068.362821903636, 6021.711749535149, 6027.2520968918525, 6032.366601506954, 6043.425874541911, 6046.727897244723, 5819.883602327845, 5902.0, 5937.495312898452, 5939.227900372924, 5951.345352011362, 5984.222051133324, 6045.697715114139, 6083.726232319645, 6106.2061931948565, 6115.003648212433, 5881.794137205177, 5947.464728174485, 6004.849878753066, 6006.129111278928, 6011.368806275278], "value": 4540.035723069242, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.5586292361659, 776.8329809091044, 779.6062988190963, 839.1817977471961, 842.8019415437375, 12596.559120430788, 13621.7956730649, 13730.862691373084, 13873.999999999987, 13890.861091389083, 11610.767784644324, 13882.79175812361, 13899.513517026906, 13930.442782288696, 13954.302284885765, 817.9386546009058, 847.6609356257485, 848.4442690038004, 849.796048948251, 849.8597731374347, 832.5629044751494, 836.7573403712915, 837.2924878477677, 839.8194388206534, 840.3823189955378, 722.8590424867153, 844.6283635200523, 880.9427387219843, 883.8232353529288, 886.4592598514901, 861.1044513705739, 862.9050804411478, 863.6977058029639, 864.0452300208274, 865.1867244789909, 624.7469774741237, 624.8562830548954, 627.7991042866284, 628.0077477585404, 628.8239292997922, 13987.860121398757, 14000.92999535006, 14038.85961140396, 14044.438222471088, 14047.64880877976, 13689.31553422325, 14455.927720361437, 14485.493007744784, 14505.41978320866, 14533.0, 11674.649760507198, 11708.473118709679, 11756.647300580997, 11810.527578896834, 11979.580714675032, 3882.2235552889533, 3906.628870257321, 3923.9215215695813, 3968.1666849961543, 4029.073313137965, 48472.75763621194, 49319.260211096866, 49685.751571242276, 49762.502374976146, 54607.18089228665, 11186.32882027081, 11199.160062995308, 11363.318200907972, 11385.14611404148, 11421.885781142082, 19066.61866762657, 19194.904025479784, 19250.903745481184, 19317.61364772725, 19321.710174347398, 8273.917260827435, 8324.125966773401, 8324.791880203044, 8392.118827523143, 8472.915270847336, 4956.653034287565, 4976.5023497649945, 4998.600111991032, 5041.420236672756, 5070.974645126751, 3255.4953982132806, 3258.902232933016, 3273.2471531547403, 3280.2947366316357, 3288.967110328914, 639.8144538083903, 642.3448082955359, 650.6519012328382, 659.1628631637889, 670.0284587348267, 617.4103730936945, 688.2635579929428, 706.5831159615851, 727.945404094695, 736.3262614707589, 8562.315014798802, 8960.103989600988, 8969.50667713269, 8970.910290897138, 9235.815283694423, 643.2152773616181, 670.8624731929942, 734.6510407556475, 735.0848193998506, 752.4807882561015, 4164.75011499311, 4191.580841915784, 4198.832046718097, 4212.925703945474, 4298.613124818781, 60127.17875460062, 60584.394156058755, 60742.69628651829, 61354.69322653358, 61418.38581614216, 52510.73744631329, 52807.207891881655, 53460.0, 54232.45767542274, 55271.17093243605, 49113.75443122833, 49242.75378623156, 49589.50410495849, 49753.751231243616, 50280.0, 8014.19858014194, 8173.18268173178, 8199.180081991753, 8226.465279756796, 8249.381296402673, 31650.208744781565, 31766.52350214795, 31837.0, 32104.197395065312, 32193.35613287768, 41131.1208215422, 44114.33828492511, 44568.77715611401, 44647.77676111599, 44747.32879006882, 11072.11423086135, 11078.390688512209, 11202.327860328407, 11427.542898283975, 11621.535138594361, 11650.242734222249, 11990.580329688419, 12766.489340426278, 12793.232406055666, 12797.168184068378, 12483.875161248272, 12544.498220071095, 12698.936505317415, 12729.363531823186, 13164.210147391188, 12755.17091389094, 12799.744005119659, 13075.215487070805, 13233.867661323264, 13527.256000920044, 12469.75060498803, 12640.178388404724, 12733.426995785398, 12971.805422918475, 13429.664258393228, 9603.9039609603, 10564.84152737725, 10665.9466702666, 10803.081738052353, 10880.347179169275, 10350.792984140124, 10785.245032847939, 10789.0, 10920.890791091988, 10980.945095274472], "value": 6682.187786762317, "unit": "score"}], "name": "dromaeo_css", "value": 7009.594967246143, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 108.0, 111.0, 112.0, 111.0, 99.0, 109.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 138.0, 150.0, 196.0, 128.0, 161.0, 171.0, 129.0, 180.0, 134.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 161.0, 161.0, 162.0, 162.0, 164.0, 163.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 98.0, 110.0, 73.0, 73.0, 77.0, 108.0, 100.0, 74.0], "value": 86.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 93.0, 93.0, 93.0, 151.0, 93.0, 93.0, 146.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 103.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 56.0, 57.0, 65.0, 74.0, 56.0, 53.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 76.0, 81.0, 75.0, 84.0, 76.0, 77.0, 78.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 125.0, 133.0, 132.0, 146.0, 127.0, 136.0, 164.0, 137.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 170.0, 165.0, 170.0, 172.0, 167.0, 172.0, 171.0, 174.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 68.0, 68.0, 67.0, 68.0, 66.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1551.5000000000002, "alertThreshold": 2.0}]} 10:27:54 INFO - Return code: 0 10:27:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:27:54 ERROR - # TBPL SUCCESS # 10:27:54 INFO - Running post-action listener: _resource_record_post_action 10:27:54 INFO - Running post-run listener: _resource_record_post_run 10:27:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532852736; Read time: 12; Write time: 730216 10:27:55 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244154368; Read time: 0; Write time: 421184 10:27:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288698368; Read time: 12; Write time: 309032 10:27:55 INFO - Running post-run listener: _upload_blobber_files 10:27:55 INFO - Blob upload gear active. 10:27:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:27:55 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'] 10:27:55 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 10:27:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:57 INFO - (blobuploader) - INFO - Done attempting. 10:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:57 INFO - (blobuploader) - INFO - Done attempting. 10:27:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:58 INFO - Return code: 0 10:27:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/006874d6efb80331a9ef50427856b6b18880fb8ef12e94deeb82718f8e0c990679f1d175c32dffd22754f90ac3afabcd729d569765894912bbd91005efb29a54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4ef5d098fbd7034d9b79d064d7d479e53782ba39676c5673f36340c44b3943834e28e82877f5950aac83dd2458391a85bd56b7d6de1f69c3683f1d791654b4f"} 10:27:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:58 INFO - Contents: 10:27:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/006874d6efb80331a9ef50427856b6b18880fb8ef12e94deeb82718f8e0c990679f1d175c32dffd22754f90ac3afabcd729d569765894912bbd91005efb29a54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4ef5d098fbd7034d9b79d064d7d479e53782ba39676c5673f36340c44b3943834e28e82877f5950aac83dd2458391a85bd56b7d6de1f69c3683f1d791654b4f"} 10:27:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:58 INFO - Copying logs to upload dir... 10:27:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.164933 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-16 10:27:56.387039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:56.390482) ========= 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=1861a34ebfea852630dec091000001fa-1460825603.761688-782848961 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/006874d6efb80331a9ef50427856b6b18880fb8ef12e94deeb82718f8e0c990679f1d175c32dffd22754f90ac3afabcd729d569765894912bbd91005efb29a54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4ef5d098fbd7034d9b79d064d7d479e53782ba39676c5673f36340c44b3943834e28e82877f5950aac83dd2458391a85bd56b7d6de1f69c3683f1d791654b4f"} build_url:https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/GWbKdYT1Rm6Lmu4Dv2KsfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/006874d6efb80331a9ef50427856b6b18880fb8ef12e94deeb82718f8e0c990679f1d175c32dffd22754f90ac3afabcd729d569765894912bbd91005efb29a54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4ef5d098fbd7034d9b79d064d7d479e53782ba39676c5673f36340c44b3943834e28e82877f5950aac83dd2458391a85bd56b7d6de1f69c3683f1d791654b4f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:56.415444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:56.415802) ========= 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=1861a34ebfea852630dec091000001fa-1460825603.761688-782848961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:56.501330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:27:56.501659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:27:56.501963) ========= ========= Total master_lag: 0.18 =========