builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1460735904.83 results: success (0) buildid: 20160415063651 builduid: c4cac0753b6f431b80a8170ee4887662 revision: 5ff5f2178682a3888ada94fa29409d54b8d4716a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:24.833941) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:24.834426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:24.834714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:24.900874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:24.901433) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 08:58:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-15 08:58:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.060826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.061165) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.110849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.111228) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5ff5f2178682a3888ada94fa29409d54b8d4716a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5ff5f2178682a3888ada94fa29409d54b8d4716a --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=97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 08:58:25,550 truncating revision to first 12 chars 2016-04-15 08:58:25,550 Setting DEBUG logging. 2016-04-15 08:58:25,550 attempt 1/10 2016-04-15 08:58:25,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5ff5f2178682?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 08:58:26,118 unpacking tar archive at: mozilla-aurora-5ff5f2178682/testing/mozharness/ program finished with exit code 0 elapsedTime=0.831292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.955810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.956180) ========= script_repo_revision: 5ff5f2178682a3888ada94fa29409d54b8d4716a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.956591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.956895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 08:58:25.964844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-15 08:58:25.965211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:58:26 INFO - MultiFileLogger online at 20160415 08:58:26 in /builds/slave/test 08:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:58:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:26 INFO - {'append_to_log': False, 08:58:26 INFO - 'base_work_dir': '/builds/slave/test', 08:58:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:26 INFO - 'branch': 'Mozilla-Aurora', 08:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:26 INFO - 'config_files': ('talos/linux_config.py',), 08:58:26 INFO - 'default_actions': ('clobber', 08:58:26 INFO - 'read-buildbot-config', 08:58:26 INFO - 'download-and-extract', 08:58:26 INFO - 'populate-webroot', 08:58:26 INFO - 'create-virtualenv', 08:58:26 INFO - 'install', 08:58:26 INFO - 'run-tests'), 08:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:26 INFO - 'download_minidump_stackwalk': True, 08:58:26 INFO - 'download_symbols': 'ondemand', 08:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:26 INFO - 'installer_path': 'installer.exe', 08:58:26 INFO - 'log_level': 'info', 08:58:26 INFO - 'log_name': 'talos', 08:58:26 INFO - 'log_to_console': True, 08:58:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:58:26 INFO - 'opt_config_files': (), 08:58:26 INFO - 'pip_index': False, 08:58:26 INFO - 'sps_profile': False, 08:58:26 INFO - 'sps_profile_interval': 0, 08:58:26 INFO - 'suite': 'dromaeojs', 08:58:26 INFO - 'system_bits': '32', 08:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:26 INFO - 'title': 'talos-linux64-ix-068', 08:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:26 INFO - 'use_talos_json': True, 08:58:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:26 INFO - 'work_dir': 'build'} 08:58:26 INFO - ##### 08:58:26 INFO - ##### Running clobber step. 08:58:26 INFO - ##### 08:58:26 INFO - Running pre-action listener: _resource_record_pre_action 08:58:26 INFO - Running main action method: clobber 08:58:26 INFO - rmtree: /builds/slave/test/build 08:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:27 INFO - Running post-action listener: _resource_record_post_action 08:58:27 INFO - ##### 08:58:27 INFO - ##### Running read-buildbot-config step. 08:58:27 INFO - ##### 08:58:27 INFO - Running pre-action listener: _resource_record_pre_action 08:58:27 INFO - Running main action method: read_buildbot_config 08:58:27 INFO - Using buildbot properties: 08:58:27 INFO - { 08:58:27 INFO - "project": "", 08:58:27 INFO - "product": "firefox", 08:58:27 INFO - "script_repo_revision": "production", 08:58:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:58:27 INFO - "repository": "", 08:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:58:27 INFO - "buildid": "20160415063651", 08:58:27 INFO - "pgo_build": "True", 08:58:27 INFO - "basedir": "/builds/slave/test", 08:58:27 INFO - "buildnumber": 435, 08:58:27 INFO - "slavename": "talos-linux64-ix-068", 08:58:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:58:27 INFO - "platform": "ubuntu64_hw", 08:58:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:58:27 INFO - "branch": "mozilla-aurora", 08:58:27 INFO - "repo_path": "releases/mozilla-aurora", 08:58:27 INFO - "revision": "5ff5f2178682a3888ada94fa29409d54b8d4716a", 08:58:27 INFO - "stage_platform": "linux64-pgo", 08:58:27 INFO - "builduid": "c4cac0753b6f431b80a8170ee4887662", 08:58:27 INFO - "slavebuilddir": "test" 08:58:27 INFO - } 08:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 08:58:27 INFO - Running post-action listener: _resource_record_post_action 08:58:27 INFO - ##### 08:58:27 INFO - ##### Running download-and-extract step. 08:58:27 INFO - ##### 08:58:27 INFO - Running pre-action listener: _resource_record_pre_action 08:58:27 INFO - Running main action method: download_and_extract 08:58:27 INFO - mkdir: /builds/slave/test/build/tests 08:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:27 INFO - https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 08:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 08:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 08:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:58:29 INFO - Downloaded 1448 bytes. 08:58:29 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 08:58:29 INFO - Using the following test package requirements: 08:58:29 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 08:58:29 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:58:29 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:58:29 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'jsshell-linux-x86_64.zip'], 08:58:29 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:58:29 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 08:58:29 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:58:29 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:58:29 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:58:29 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 08:58:29 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 08:58:29 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:58:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:29 INFO - https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 08:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 08:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 08:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:58:30 INFO - Downloaded 23352099 bytes. 08:58:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:58:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:58:32 INFO - Return code: 0 08:58:32 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:32 INFO - https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 08:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 08:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 08:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:58:45 INFO - Downloaded 23352099 bytes. 08:58:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:58:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:58:46 INFO - Return code: 0 08:58:46 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')]} 08:58:46 INFO - https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 08:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 08:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 08:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:58:47 INFO - Downloaded 10845168 bytes. 08:58:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:58:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:58:47 INFO - Return code: 0 08:58:47 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')]} 08:58:47 INFO - https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:58:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 08:58:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 08:58:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 08:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:58:49 INFO - Downloaded 60573963 bytes. 08:58:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 08:58:49 INFO - mkdir: /builds/slave/test/properties 08:58:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:58:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:58:49 INFO - Contents: 08:58:49 INFO - build_url:https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 08:58:50 INFO - Running post-action listener: _resource_record_post_action 08:58:50 INFO - Running post-action listener: set_extra_try_arguments 08:58:50 INFO - ##### 08:58:50 INFO - ##### Running populate-webroot step. 08:58:50 INFO - ##### 08:58:50 INFO - Running pre-action listener: _resource_record_pre_action 08:58:50 INFO - Running main action method: populate_webroot 08:58:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:58:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:58:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:58:50 INFO - '--tppagecycles', 08:58:50 INFO - '7'], 08:58:50 INFO - 'tests': ['tsvgm']}}, 08:58:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:58:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:58:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:58:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:58:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'tests': ['damp', 'tps']}, 08:58:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['damp', 'tps']}, 08:58:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:58:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:58:50 INFO - 'other': {'tests': ['a11yr', 08:58:50 INFO - 'ts_paint', 08:58:50 INFO - 'tpaint', 08:58:50 INFO - 'sessionrestore', 08:58:50 INFO - 'sessionrestore_no_auto_restore', 08:58:50 INFO - 'tabpaint']}, 08:58:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['a11yr', 08:58:50 INFO - 'ts_paint', 08:58:50 INFO - 'tpaint', 08:58:50 INFO - 'sessionrestore', 08:58:50 INFO - 'sessionrestore_no_auto_restore', 08:58:50 INFO - 'tabpaint']}, 08:58:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['a11yr', 08:58:50 INFO - 'ts_paint', 08:58:50 INFO - 'tpaint', 08:58:50 INFO - 'sessionrestore', 08:58:50 INFO - 'sessionrestore_no_auto_restore', 08:58:50 INFO - 'tabpaint']}, 08:58:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['a11yr', 08:58:50 INFO - 'ts_paint', 08:58:50 INFO - 'tpaint', 08:58:50 INFO - 'sessionrestore', 08:58:50 INFO - 'sessionrestore_no_auto_restore', 08:58:50 INFO - 'tabpaint']}, 08:58:50 INFO - 'other_l64': {'tests': ['a11yr', 08:58:50 INFO - 'ts_paint', 08:58:50 INFO - 'tpaint', 08:58:50 INFO - 'sessionrestore', 08:58:50 INFO - 'sessionrestore_no_auto_restore', 08:58:50 INFO - 'tabpaint']}, 08:58:50 INFO - 'other_nol64': {'tests': ['a11yr', 08:58:50 INFO - 'ts_paint', 08:58:50 INFO - 'tpaint', 08:58:50 INFO - 'sessionrestore', 08:58:50 INFO - 'sessionrestore_no_auto_restore', 08:58:50 INFO - 'tabpaint']}, 08:58:50 INFO - 'svgr': {'tests': ['tsvgx', 08:58:50 INFO - 'tsvgr_opacity', 08:58:50 INFO - 'tart', 08:58:50 INFO - 'tscrollx', 08:58:50 INFO - 'cart']}, 08:58:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['tsvgx', 08:58:50 INFO - 'tsvgr_opacity', 08:58:50 INFO - 'tart', 08:58:50 INFO - 'tscrollx', 08:58:50 INFO - 'cart']}, 08:58:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'tests': ['tp5o']}, 08:58:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'talos_options': ['--e10s'], 08:58:50 INFO - 'tests': ['tp5o']}, 08:58:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'talos_options': ['--xperf_path', 08:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:50 INFO - 'tests': ['tp5n']}, 08:58:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:50 INFO - 'talos_options': ['--e10s', 08:58:50 INFO - '--xperf_path', 08:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:50 INFO - 'tests': ['tp5n']}}, 08:58:50 INFO - 'talos.zip': {'path': '', 08:58:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:58:50 INFO - Running post-action listener: _resource_record_post_action 08:58:50 INFO - ##### 08:58:50 INFO - ##### Running create-virtualenv step. 08:58:50 INFO - ##### 08:58:50 INFO - Running pre-action listener: _resource_record_pre_action 08:58:50 INFO - Running main action method: create_virtualenv 08:58:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:58:50 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 08:58:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:58:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:58:50 INFO - Using real prefix '/usr' 08:58:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:58:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:58:52 INFO - Installing pip.................done. 08:58:52 INFO - Return code: 0 08:58:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:58:52 INFO - Using env: {'DISPLAY': ':0', 08:58:52 INFO - 'HOME': '/home/cltbld', 08:58:52 INFO - 'LANG': 'en_US.UTF-8', 08:58:52 INFO - 'LANGUAGE': 'en_US:en', 08:58:52 INFO - 'LOGNAME': 'cltbld', 08:58:52 INFO - 'MAIL': '/var/mail/cltbld', 08:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:52 INFO - 'MOZ_NO_REMOTE': '1', 08:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:52 INFO - 'NO_EM_RESTART': '1', 08:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:52 INFO - 'PWD': '/builds/slave/test', 08:58:52 INFO - 'SHELL': '/bin/bash', 08:58:52 INFO - 'SHLVL': '1', 08:58:52 INFO - 'TERM': 'linux', 08:58:52 INFO - 'TMOUT': '86400', 08:58:52 INFO - 'USER': 'cltbld', 08:58:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:52 INFO - '_': '/tools/buildbot/bin/python'} 08:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:53 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 08:58:53 INFO - Cleaning up... 08:58:53 INFO - Return code: 0 08:58:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:58:53 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')]} 08:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:53 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')]} 08:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:53 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:58:53 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 08:58:53 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 08:58:53 INFO - Using env: {'DISPLAY': ':0', 08:58:53 INFO - 'HOME': '/home/cltbld', 08:58:53 INFO - 'LANG': 'en_US.UTF-8', 08:58:53 INFO - 'LANGUAGE': 'en_US:en', 08:58:53 INFO - 'LOGNAME': 'cltbld', 08:58:53 INFO - 'MAIL': '/var/mail/cltbld', 08:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:53 INFO - 'MOZ_NO_REMOTE': '1', 08:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:53 INFO - 'NO_EM_RESTART': '1', 08:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:53 INFO - 'PWD': '/builds/slave/test', 08:58:53 INFO - 'SHELL': '/bin/bash', 08:58:53 INFO - 'SHLVL': '1', 08:58:53 INFO - 'TERM': 'linux', 08:58:53 INFO - 'TMOUT': '86400', 08:58:53 INFO - 'USER': 'cltbld', 08:58:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:53 INFO - '_': '/tools/buildbot/bin/python'} 08:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:53 INFO - Downloading/unpacking psutil>=0.7.1 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:55 INFO - Installing collected packages: psutil 08:58:55 INFO - Running setup.py install for psutil 08:58:55 INFO - building 'psutil._psutil_linux' extension 08:58:55 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 08:58:55 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 08:58:55 INFO - building 'psutil._psutil_posix' extension 08:58:55 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 08:58:55 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 08:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:55 INFO - Successfully installed psutil 08:58:55 INFO - Cleaning up... 08:58:55 INFO - Return code: 0 08:58:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:55 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:58:55 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 08:58:55 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 08:58:55 INFO - Using env: {'DISPLAY': ':0', 08:58:55 INFO - 'HOME': '/home/cltbld', 08:58:55 INFO - 'LANG': 'en_US.UTF-8', 08:58:55 INFO - 'LANGUAGE': 'en_US:en', 08:58:55 INFO - 'LOGNAME': 'cltbld', 08:58:55 INFO - 'MAIL': '/var/mail/cltbld', 08:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:55 INFO - 'MOZ_NO_REMOTE': '1', 08:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:55 INFO - 'NO_EM_RESTART': '1', 08:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:55 INFO - 'PWD': '/builds/slave/test', 08:58:55 INFO - 'SHELL': '/bin/bash', 08:58:55 INFO - 'SHLVL': '1', 08:58:55 INFO - 'TERM': 'linux', 08:58:55 INFO - 'TMOUT': '86400', 08:58:55 INFO - 'USER': 'cltbld', 08:58:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:55 INFO - '_': '/tools/buildbot/bin/python'} 08:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:58:55 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 08:58:55 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 08:58:55 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 08:58:55 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 08:58:55 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 08:58:55 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 08:58:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:58:57 INFO - Installing collected packages: mozsystemmonitor 08:58:57 INFO - Running setup.py install for mozsystemmonitor 08:58:58 INFO - Successfully installed mozsystemmonitor 08:58:58 INFO - Cleaning up... 08:58:58 INFO - Return code: 0 08:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', '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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:58: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 blobuploader==1.2.4 08:58:58 INFO - Using env: {'DISPLAY': ':0', 08:58:58 INFO - 'HOME': '/home/cltbld', 08:58:58 INFO - 'LANG': 'en_US.UTF-8', 08:58:58 INFO - 'LANGUAGE': 'en_US:en', 08:58:58 INFO - 'LOGNAME': 'cltbld', 08:58:58 INFO - 'MAIL': '/var/mail/cltbld', 08:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:58 INFO - 'MOZ_NO_REMOTE': '1', 08:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:58 INFO - 'NO_EM_RESTART': '1', 08:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:58 INFO - 'PWD': '/builds/slave/test', 08:58:58 INFO - 'SHELL': '/bin/bash', 08:58:58 INFO - 'SHLVL': '1', 08:58:58 INFO - 'TERM': 'linux', 08:58:58 INFO - 'TMOUT': '86400', 08:58:58 INFO - 'USER': 'cltbld', 08:58:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:58 INFO - '_': '/tools/buildbot/bin/python'} 08:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:59:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:00 INFO - Downloading docopt-0.6.1.tar.gz 08:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:00 INFO - Running setup.py install for blobuploader 08:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:01 INFO - Running setup.py install for requests 08:59:01 INFO - Running setup.py install for docopt 08:59:01 INFO - Successfully installed blobuploader requests docopt 08:59:01 INFO - Cleaning up... 08:59:01 INFO - Return code: 0 08:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:01 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')]} 08:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:01 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')]} 08:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:01 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:59:01 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 08:59:01 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 08:59:01 INFO - Using env: {'DISPLAY': ':0', 08:59:01 INFO - 'HOME': '/home/cltbld', 08:59:01 INFO - 'LANG': 'en_US.UTF-8', 08:59:01 INFO - 'LANGUAGE': 'en_US:en', 08:59:01 INFO - 'LOGNAME': 'cltbld', 08:59:01 INFO - 'MAIL': '/var/mail/cltbld', 08:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:01 INFO - 'MOZ_NO_REMOTE': '1', 08:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:01 INFO - 'NO_EM_RESTART': '1', 08:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:01 INFO - 'PWD': '/builds/slave/test', 08:59:01 INFO - 'SHELL': '/bin/bash', 08:59:01 INFO - 'SHLVL': '1', 08:59:01 INFO - 'TERM': 'linux', 08:59:01 INFO - 'TMOUT': '86400', 08:59:01 INFO - 'USER': 'cltbld', 08:59:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:01 INFO - '_': '/tools/buildbot/bin/python'} 08:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:01 INFO - Running setup.py (path:/tmp/pip-eUJLp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:01 INFO - Running setup.py (path:/tmp/pip-4OsoKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:01 INFO - Running setup.py (path:/tmp/pip-N7NKXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:01 INFO - Running setup.py (path:/tmp/pip-i9smwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:02 INFO - Running setup.py (path:/tmp/pip-ffvVuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:02 INFO - Running setup.py (path:/tmp/pip-VLpP4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:02 INFO - Running setup.py (path:/tmp/pip-MOz3mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:02 INFO - Running setup.py (path:/tmp/pip-bcz7L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:02 INFO - Running setup.py (path:/tmp/pip-HGIt9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:02 INFO - Running setup.py (path:/tmp/pip-N8ZMOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:02 INFO - Running setup.py (path:/tmp/pip-P9Rx0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:02 INFO - Running setup.py (path:/tmp/pip-0yj2Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:02 INFO - Running setup.py (path:/tmp/pip-PMgeoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:02 INFO - Running setup.py (path:/tmp/pip-ahVLvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:02 INFO - Running setup.py (path:/tmp/pip-JKtOyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:02 INFO - Running setup.py (path:/tmp/pip-qtXnOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:02 INFO - Running setup.py (path:/tmp/pip-hEHVht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:02 INFO - Running setup.py install for manifestparser 08:59:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozcrash 08:59:03 INFO - Running setup.py install for mozdebug 08:59:03 INFO - Running setup.py install for mozdevice 08:59:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozfile 08:59:03 INFO - Running setup.py install for mozhttpd 08:59:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozinfo 08:59:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozInstall 08:59:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozleak 08:59:03 INFO - Running setup.py install for mozlog 08:59:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for moznetwork 08:59:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:04 INFO - Running setup.py install for mozprocess 08:59:04 INFO - Running setup.py install for mozprofile 08:59:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:04 INFO - Running setup.py install for mozrunner 08:59:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:04 INFO - Running setup.py install for mozscreenshot 08:59:04 INFO - Running setup.py install for moztest 08:59:04 INFO - Running setup.py install for mozversion 08:59:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:04 INFO - Cleaning up... 08:59:04 INFO - Return code: 0 08:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:04 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')]} 08:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:04 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')]} 08:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:04 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:59:04 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 08:59:04 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 08:59:04 INFO - Using env: {'DISPLAY': ':0', 08:59:04 INFO - 'HOME': '/home/cltbld', 08:59:04 INFO - 'LANG': 'en_US.UTF-8', 08:59:04 INFO - 'LANGUAGE': 'en_US:en', 08:59:04 INFO - 'LOGNAME': 'cltbld', 08:59:04 INFO - 'MAIL': '/var/mail/cltbld', 08:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:04 INFO - 'MOZ_NO_REMOTE': '1', 08:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:04 INFO - 'NO_EM_RESTART': '1', 08:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:04 INFO - 'PWD': '/builds/slave/test', 08:59:04 INFO - 'SHELL': '/bin/bash', 08:59:04 INFO - 'SHLVL': '1', 08:59:04 INFO - 'TERM': 'linux', 08:59:04 INFO - 'TMOUT': '86400', 08:59:04 INFO - 'USER': 'cltbld', 08:59:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:04 INFO - '_': '/tools/buildbot/bin/python'} 08:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:04 INFO - Running setup.py (path:/tmp/pip-pBJFYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:04 INFO - Running setup.py (path:/tmp/pip-INeaCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:05 INFO - Running setup.py (path:/tmp/pip-xEPunv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:05 INFO - Running setup.py (path:/tmp/pip-g_oc2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:05 INFO - Running setup.py (path:/tmp/pip-Piz8Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:05 INFO - Running setup.py (path:/tmp/pip-hzzEoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:05 INFO - Running setup.py (path:/tmp/pip-j8Z4QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:05 INFO - Running setup.py (path:/tmp/pip-XB1k1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:05 INFO - Running setup.py (path:/tmp/pip-VPgWj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:05 INFO - Running setup.py (path:/tmp/pip-9vi3Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:05 INFO - Running setup.py (path:/tmp/pip-TxbQhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:05 INFO - Running setup.py (path:/tmp/pip-BKIice-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:05 INFO - Running setup.py (path:/tmp/pip-3SRnY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:05 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)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:05 INFO - Running setup.py (path:/tmp/pip-EAVPJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:06 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)) 08:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:06 INFO - Running setup.py (path:/tmp/pip-3iHPL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:06 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)) 08:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:06 INFO - Running setup.py (path:/tmp/pip-5cnIUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:06 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)) 08:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:06 INFO - Running setup.py (path:/tmp/pip-z2o3Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:06 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)) 08:59:06 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)) 08:59:06 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)) 08:59:06 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)) 08:59:06 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)) 08:59:06 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)) 08:59:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:06 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 08:59:06 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 08:59:06 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 08:59:06 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 08:59:06 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 08:59:06 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 08:59:08 INFO - Downloading blessings-1.6.tar.gz 08:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:08 INFO - Installing collected packages: blessings 08:59:08 INFO - Running setup.py install for blessings 08:59:08 INFO - Successfully installed blessings 08:59:08 INFO - Cleaning up... 08:59:08 INFO - Return code: 0 08:59:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:08 INFO - Reading from file tmpfile_stdout 08:59:08 INFO - Current package versions: 08:59:08 INFO - argparse == 1.2.1 08:59:08 INFO - blessings == 1.6 08:59:08 INFO - blobuploader == 1.2.4 08:59:08 INFO - docopt == 0.6.1 08:59:08 INFO - manifestparser == 1.1 08:59:08 INFO - mozInstall == 1.12 08:59:08 INFO - mozcrash == 0.17 08:59:08 INFO - mozdebug == 0.1 08:59:08 INFO - mozdevice == 0.48 08:59:08 INFO - mozfile == 1.2 08:59:08 INFO - mozhttpd == 0.7 08:59:08 INFO - mozinfo == 0.9 08:59:08 INFO - mozleak == 0.1 08:59:08 INFO - mozlog == 3.1 08:59:08 INFO - moznetwork == 0.27 08:59:08 INFO - mozprocess == 0.22 08:59:08 INFO - mozprofile == 0.28 08:59:08 INFO - mozrunner == 6.11 08:59:08 INFO - mozscreenshot == 0.1 08:59:08 INFO - mozsystemmonitor == 0.0 08:59:08 INFO - moztest == 0.7 08:59:08 INFO - mozversion == 1.4 08:59:08 INFO - psutil == 3.1.1 08:59:08 INFO - requests == 1.2.3 08:59:08 INFO - wsgiref == 0.1.2 08:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:59:08 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 08:59:08 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 08:59:08 INFO - Using env: {'DISPLAY': ':0', 08:59:08 INFO - 'HOME': '/home/cltbld', 08:59:08 INFO - 'LANG': 'en_US.UTF-8', 08:59:08 INFO - 'LANGUAGE': 'en_US:en', 08:59:08 INFO - 'LOGNAME': 'cltbld', 08:59:08 INFO - 'MAIL': '/var/mail/cltbld', 08:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:08 INFO - 'MOZ_NO_REMOTE': '1', 08:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:08 INFO - 'NO_EM_RESTART': '1', 08:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:08 INFO - 'PWD': '/builds/slave/test', 08:59:08 INFO - 'SHELL': '/bin/bash', 08:59:08 INFO - 'SHLVL': '1', 08:59:08 INFO - 'TERM': 'linux', 08:59:08 INFO - 'TMOUT': '86400', 08:59:08 INFO - 'USER': 'cltbld', 08:59:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:08 INFO - '_': '/tools/buildbot/bin/python'} 08:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 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)) 08:59:08 INFO - Cleaning up... 08:59:08 INFO - Return code: 0 08:59:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:59:08 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 08:59:08 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 08:59:08 INFO - Using env: {'DISPLAY': ':0', 08:59:08 INFO - 'HOME': '/home/cltbld', 08:59:08 INFO - 'LANG': 'en_US.UTF-8', 08:59:08 INFO - 'LANGUAGE': 'en_US:en', 08:59:08 INFO - 'LOGNAME': 'cltbld', 08:59:08 INFO - 'MAIL': '/var/mail/cltbld', 08:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:08 INFO - 'MOZ_NO_REMOTE': '1', 08:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:08 INFO - 'NO_EM_RESTART': '1', 08:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:08 INFO - 'PWD': '/builds/slave/test', 08:59:08 INFO - 'SHELL': '/bin/bash', 08:59:08 INFO - 'SHLVL': '1', 08:59:08 INFO - 'TERM': 'linux', 08:59:08 INFO - 'TMOUT': '86400', 08:59:08 INFO - 'USER': 'cltbld', 08:59:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:08 INFO - '_': '/tools/buildbot/bin/python'} 08:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:09 INFO - Downloading/unpacking jsonschema 08:59:09 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 08:59:09 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 08:59:09 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 08:59:09 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 08:59:09 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 08:59:09 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 08:59:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:10 INFO - Downloading/unpacking functools32 (from jsonschema) 08:59:10 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 08:59:10 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 08:59:10 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 08:59:10 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 08:59:10 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 08:59:10 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 08:59:11 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:11 INFO - warning: no files found matching '*.txt' 08:59:11 INFO - no previously-included directories found matching 'build' 08:59:11 INFO - no previously-included directories found matching 'dist' 08:59:11 INFO - no previously-included directories found matching '.git*' 08:59:11 INFO - Installing collected packages: jsonschema, functools32 08:59:11 INFO - Running setup.py install for functools32 08:59:11 INFO - warning: no files found matching '*.txt' 08:59:11 INFO - no previously-included directories found matching 'build' 08:59:11 INFO - no previously-included directories found matching 'dist' 08:59:11 INFO - no previously-included directories found matching '.git*' 08:59:11 INFO - Successfully installed jsonschema functools32 08:59:11 INFO - Cleaning up... 08:59:11 INFO - Return code: 0 08:59:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:11 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 0x7fdafe362f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', '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 08:59:11 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 08:59:11 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 08:59:11 INFO - Using env: {'DISPLAY': ':0', 08:59:11 INFO - 'HOME': '/home/cltbld', 08:59:11 INFO - 'LANG': 'en_US.UTF-8', 08:59:11 INFO - 'LANGUAGE': 'en_US:en', 08:59:11 INFO - 'LOGNAME': 'cltbld', 08:59:11 INFO - 'MAIL': '/var/mail/cltbld', 08:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:11 INFO - 'MOZ_NO_REMOTE': '1', 08:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:11 INFO - 'NO_EM_RESTART': '1', 08:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:11 INFO - 'PWD': '/builds/slave/test', 08:59:11 INFO - 'SHELL': '/bin/bash', 08:59:11 INFO - 'SHLVL': '1', 08:59:11 INFO - 'TERM': 'linux', 08:59:11 INFO - 'TMOUT': '86400', 08:59:11 INFO - 'USER': 'cltbld', 08:59:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:11 INFO - '_': '/tools/buildbot/bin/python'} 08:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:11 INFO - Downloading/unpacking flake8 08:59:11 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 08:59:11 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 08:59:11 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 08:59:11 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 08:59:11 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 08:59:11 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 08:59:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:59:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:59:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:13 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 08:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:14 INFO - no previously-included directories found matching 'docs/_build' 08:59:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:59:14 INFO - Running setup.py install for pep8 08:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:14 INFO - no previously-included directories found matching 'docs/_build' 08:59:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:59:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:59:14 INFO - Cleaning up... 08:59:14 INFO - Return code: 0 08:59:14 INFO - Running post-action listener: _resource_record_post_action 08:59:14 INFO - Running post-action listener: _start_resource_monitoring 08:59:14 INFO - Starting resource monitoring. 08:59:14 INFO - ##### 08:59:14 INFO - ##### Running install step. 08:59:14 INFO - ##### 08:59:14 INFO - Running pre-action listener: _resource_record_pre_action 08:59:14 INFO - Running main action method: install 08:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:14 INFO - Reading from file tmpfile_stdout 08:59:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:14 INFO - Reading from file tmpfile_stdout 08:59:14 INFO - Output received: 08:59:14 INFO - Usage: mozinstall [options] installer 08:59:14 INFO - Options: 08:59:14 INFO - -h, --help show this help message and exit 08:59:14 INFO - -d DEST, --destination=DEST 08:59:14 INFO - Directory to install application into. [default: 08:59:14 INFO - "/builds/slave/test"] 08:59:14 INFO - --app=APP Application being installed. [default: firefox] 08:59:14 INFO - mkdir: /builds/slave/test/build/application 08:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:59:30 INFO - Reading from file tmpfile_stdout 08:59:30 INFO - Output received: 08:59:30 INFO - /builds/slave/test/build/application/firefox/firefox 08:59:30 INFO - Running post-action listener: _resource_record_post_action 08:59:30 INFO - ##### 08:59:30 INFO - ##### Running run-tests step. 08:59:30 INFO - ##### 08:59:30 INFO - Running pre-action listener: _resource_record_pre_action 08:59:30 INFO - Running main action method: run_tests 08:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:59:30 INFO - Python 2.7.3 08:59:30 INFO - Return code: 0 08:59:30 INFO - grabbing minidump binary from tooltool 08:59:30 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')]} 08:59:30 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 0x24f5160>, '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 0x24f6060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f64f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:59:30 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 08:59:30 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 08:59:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:30 INFO - Return code: 0 08:59:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:59:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:59:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:59:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:59:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:59:31 INFO - Return code: 0 08:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 08:59:31 INFO - Using env: {'DISPLAY': ':0', 08:59:31 INFO - 'HOME': '/home/cltbld', 08:59:31 INFO - 'LANG': 'en_US.UTF-8', 08:59:31 INFO - 'LANGUAGE': 'en_US:en', 08:59:31 INFO - 'LOGNAME': 'cltbld', 08:59:31 INFO - 'MAIL': '/var/mail/cltbld', 08:59:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:31 INFO - 'MOZ_NO_REMOTE': '1', 08:59:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:31 INFO - 'NO_EM_RESTART': '1', 08:59:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:31 INFO - 'PWD': '/builds/slave/test', 08:59:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:31 INFO - 'SHELL': '/bin/bash', 08:59:31 INFO - 'SHLVL': '1', 08:59:31 INFO - 'TERM': 'linux', 08:59:31 INFO - 'TMOUT': '86400', 08:59:31 INFO - 'USER': 'cltbld', 08:59:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222', 08:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:31 INFO - '_': '/tools/buildbot/bin/python'} 08:59:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:59:31 INFO - mozversion application_buildid: 20160415063651 08:59:31 INFO - mozversion application_changeset: 5ff5f2178682a3888ada94fa29409d54b8d4716a 08:59:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:59:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:31 INFO - mozversion application_name: Firefox 08:59:31 INFO - mozversion application_remotingname: firefox-dev 08:59:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:59:31 INFO - mozversion application_vendor: Mozilla 08:59:31 INFO - mozversion application_version: 47.0a2 08:59:31 INFO - mozversion platform_buildid: 20160415063651 08:59:31 INFO - mozversion platform_changeset: 5ff5f2178682a3888ada94fa29409d54b8d4716a 08:59:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:59:31 INFO - mozversion platform_version: 47.0a2 08:59:31 INFO - using testdate: 1460735971 08:59:31 INFO - actual date: 1460735971 08:59:31 INFO - starting webserver on 'localhost:59587' 08:59:31 INFO - SUITE-START | Running 2 tests 08:59:31 INFO - TEST-START | dromaeo_css 08:59:31 INFO - operating with platform_type : linux_ 08:59:31 INFO - Initialising browser for dromaeo_css test... 08:59:31 INFO - TEST-INFO | started process 15344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkJ2jCV/profile http://localhost:59587/getInfo.html) 08:59:35 INFO - PROCESS | 15344 | __metrics Screen width/height:1600/1200 08:59:35 INFO - PROCESS | 15344 | colorDepth:24 08:59:35 INFO - PROCESS | 15344 | Browser inner width/height: 1024/697 08:59:35 INFO - PROCESS | 15344 | __metrics 08:59:36 INFO - PROCESS | 15344 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:37 INFO - TEST-INFO | 15344: exit 0 08:59:37 INFO - Browser initialized. 08:59:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:37 INFO - TEST-INFO | started process 15434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkJ2jCV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:49 INFO - PROCESS | 15434 | RSS: Main: 141950976 08:59:49 INFO - PROCESS | 15434 | 09:00:40 INFO - PROCESS | 15434 | 1460736040797 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] 09:02:48 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:59587/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59587/tests/dromaeo/cssquery-ext.html) 09:02:49 INFO - PROCESS | 15434 | RSS: Main: 250720256 09:02:49 INFO - PROCESS | 15434 | 09:05:51 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:59587/tests/dromaeo/cssquery-ext.html (next: http://localhost:59587/tests/dromaeo/cssquery-jquery.html) 09:05:51 INFO - PROCESS | 15434 | RSS: Main: 222363648 09:05:51 INFO - PROCESS | 15434 | 09:08:53 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:59587/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59587/tests/dromaeo/cssquery-mootools.html) 09:08:54 INFO - PROCESS | 15434 | RSS: Main: 217260032 09:08:54 INFO - PROCESS | 15434 | 09:11:56 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:59587/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59587/tests/dromaeo/cssquery-prototype.html) 09:11:56 INFO - PROCESS | 15434 | RSS: Main: 202797056 09:11:56 INFO - PROCESS | 15434 | 09:14:59 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:59587/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59587/tests/dromaeo/cssquery-yui.html) 09:14:59 INFO - PROCESS | 15434 | RSS: Main: 205991936 09:14:59 INFO - PROCESS | 15434 | 09:18:01 INFO - PROCESS | 15434 | Cycle 1(1): loaded http://localhost:59587/tests/dromaeo/cssquery-yui.html (next: http://localhost:59587/tests/dromaeo/cssquery-dojo.html) 09:18:02 INFO - PROCESS | 15434 | RSS: Main: 250732544 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | __start_tp_report 09:18:02 INFO - PROCESS | 15434 | _x_x_mozilla_page_load 09:18:02 INFO - PROCESS | 15434 | _x_x_mozilla_page_load_details 09:18:02 INFO - PROCESS | 15434 | |i|pagename|runs| 09:18:02 INFO - PROCESS | 15434 | |0;dojo.html;3263.314703912178;3291.9835400822994;3311.5694959655243;3312.8012319260847;3345.98327008365;5327.334083239595;5328.094223981922;5352.304200453936;5375.4355792641745;5388.892222155555;5314.973425132869;5331.893362132765;5366.436524164965;5372.382176049746;5380.865478363043;4772.379590653228;4902.607791376699;4907.779149938261;4958.479359667237;4990.750462476862;4880.536349046835;4952.851414457572;4960.6527543072;4961.355023846895;4973.850784476472;4884.951150488485;4931;5014.623903207255;5030.82392116276;5035.068512325213;4968.205087186033;4978.6514943953935;4989.426215985171;4993.076280888047;5018.824341148061;4846.539578740014;4858.538438848339;4957.058158949788;4959.603231741452;4987.62592805541;5217.165253559412;5225.137852254374;5239.16173412256;5249.658772179796;5275.446078161776;5629.971850140764;5690.9146362804595;5732.054211055212;5736.168255602956;5739.7991070312755;5786.623869448473;5836.503897168745;5854.151148083504;5855.677937713424;5859.2090067841145;5421.457854214586;5421.945780542144;5423.159410291371;5425.294711687456;5466.180072989044;5789.507891829157;5904;5907.940920590825;5944.256967879015;5996.280446346466;5780.855478612984;5812.215350927655;5815.912761308584;5819.883602328015;5855.59010869235;5857.121431785266;5894.764209431574;5895.941040589625;5896.439838215363;5898.911516327258;5690.4025077367105;5708.514776244066;5810.389909059572;5841.824745257649;5886.205362276123;5795.246617939725;5796.913046304308;5800.854978625568;5811.331696854916;5823.970880145572;4422.358757980075;4433.955660443419;4456.509783923766;4468.642508599304;4477.686561940698;3967.742096763759;3972.6226008529143;4015.77913214776;4021.8994525136522;4061.614146656063;5509.944900550943;5521.282233309644;5535.667859928417;5538.169274608841;5544.390117087117;5838.649681019152;5854.531637468992;5855.063189889597;5867.237259156368;5885.970570147122;5418.566514678816;5497.340319161646;5549.944500555023;5557.527610153102;5604.355499117653;5009.89980200394;5014.721246082226;5035.874103147377;5039.5212454817465;5046.091703493406;5750;6039.124326972565;6053.122297266872;6063;6071.848203794852;5805.216295800097;5878.94121058801;5883.146943693226;5887.646741195542;5899.292084949833;5991.940080599138;5995.61028533144;5995.670238136944;5996.1005849122985;6055.303640081447;5578.442155784389;5700.144978253295;5712.714364281686;5714.942850571441;5716;5813.505852002627;5846.94153058464;5848.122781582627;5852.678102704393;5882.441168089024;5645.463680950304;5664.122061080539;5690.317161940594;5694.914576281276;5697.202391665087;5492.780288788404;5532.834014979557;5605.103183490785;5679.6876171810945;5714.3714191438075;5599.300087489064;5616.85957851057;5617.831465056055;5621.8594535136945;5635.408282130317;5704.344000440003;5732.684702341411;5738.741756620879;5739.2252045973255;5740.0815869460685;5421.810236641699;5507.173923911285;5539.335279766454;5596.860078497907;5602.85992850182 09:18:02 INFO - PROCESS | 15434 | |1;ext.html;551.2585572405113;562.3810777645849;574.4485294117646;610.0026456743225;621.9657918814465;40090.198196036064;40453.393199102036;40476.59523404765;40511.392329115086;40540.18919621606;43172.78413607935;43926.34110488337;43957.56042439575;43984;43996.56003439973;8815.779605509866;9087.954560227223;9096.135867092615;9097.363184577081;9097.54512274387;8540.914590854074;8658.87011694825;8669.133086691343;8670.609822557968;8674.34942379321;9147.268218542535;9196.862047069299;9198.908010919871;9201.72394828153;9202.401843880127;8827.249683776887;8855.645774169025;8856.114388561125;8859.202671759573;8860.8670869937;9150.130737579919;9272.072792720674;9272.258219342437;9275.58259878307;9291.535423228812;43894.34158487625;44509.77745111254;44582.777086114365;44621.77689111566;44788.55211447876;3708;3796.620337966209;3819.770813751156;3872.283627528916;3875.476810630557;33610;33995.32009359824;34058.31883362319;34654;34917.825410872785;4193.454850869398;4263.5736426357425;4328.50222224445;4441.511433742286;4444.577765112309;236054;239626;239821;240085;240297;62663.373366266664;63268.36731632717;63593.36406635967;63600;63726.68136659287;72848.63575682088;73795;73867;73937.6303118481;74022.6298868513;14525.128492290496;14544.345504452325;14548.709025819637;14570.05294655844;14570.41718331255;11375.886241137483;11377.88622113785;11393.829092563617;11402.885971140347;11411;22028.669569956463;22513;22607.208747693752;22654.546909061726;23362.76637233606;8204.794880128045;8521.403501754818;8552.57237138153;8748.562571871382;8808.92990147315;1041.8124737547162;1047.558352585034;1108.9600397120873;1112.3548341961643;1119.3899324867966;30427;30541.23646908845;30831.537526937114;31084.378312433626;31253.37493250122;1084.7993121272589;1188.1742189178437;1191.4578866615668;1198.1433275208267;1261.4575732434957;16274.75587866183;16326.265318060716;16445.506634800975;16521.752173717403;16676.916615416845;327758;329554;332505;332529;334680;58603.41396586065;59022.11466828001;59071;59127.408725913054;59139.70430147822;1395.8325000999946;1486.3831509923477;1499.4676889704217;1519.3998370643756;1527.0990115831712;28324.575131372632;28344.007959722137;28896.2775930595;29569.556456652736;30927.536086959164;46310.30534541917;46397.304040440096;46557.76721116373;46880.29679554878;46889;225147;225911;226267;226340;226763;30044.849775750983;34816.82591587026;35537.466937995436;35581.82209088938;35801.28397432089;51916.221256681936;52094.47905521048;52644.410169659575;52687;53510.464895350546;40094.799526002185;40640.98397540085;40816.1836763269;41342.58657413387;41764.1647167061;38780.80609596934;39706.80146599249;39716.20567588574;40329.596704032585;40714.59285407108;39570.40644390394;40367.79816100901;40812.79593602013;41359;41374.172516550105;35849.283014340086;36756.713515027914;37154.25691486209;37367.62632373641;37548.812255938545;27826.443471130868;27948.580771288853;28031.859840700665;28049.579256310764;28145.859270703517 09:18:02 INFO - PROCESS | 15434 | |2;jquery.html;368.1110119062464;381.72706514841883;389.8947284233259;394.06409776780146;396.6430212808472;17606;18893.33873314434;19492.02539873008;19637.509062273413;19706.80293197066;18109.90945045273;18390.1724422401;18444.893306401624;18868.43394698158;18875.244990200375;5575.219469274295;5761.423857614247;5768.278965129359;5802.448767367094;5803.042497987848;4223.683223758215;5993.820185394445;6235.095911092889;6256.593321434115;6268.561200715952;6062.4543791058795;6124.938750612504;6143.32423433422;6154.384561543855;6222.62664240147;6305.905411418832;6326.177596912395;6329.651869147195;6332.90500642493;6334.366563343675;3876.205377897524;5308.70802105884;5494.890102197974;5496.203050557687;5499.120140777456;20774.688379674317;21265.57468850614;21306.934653267428;21583.460413489633;21590.352289431186;2334.3580515358244;2345.2495201535344;2431.8784060797066;2640.1419538650016;2726.6319046928807;9995.100440960348;10092.495375231283;10223.488825558692;10295.433751143684;10367.63713270032;1862.9161687724086;1944.9805501945082;1987.930422435208;2014.9798502015085;2018.5760990192077;64386.3561364385;66333.66833165851;66377.33622663759;68796.6560167201;69262;9600.66397676078;9639.855402168972;9645.228381729445;9721.805563888824;9793;13281.667958300926;13377.130486518345;13393.73212535744;13395.397207125703;13400.06199566021;7328;7329.743458979016;7419.59192244421;7448.366888814511;7461.5523068614975;7229.530080544748;7238.23998480152;7246.478239569644;7265.346118849329;7274.345308922222;4154.252234597741;4230.661547076226;4261;4502.257127573914;4734.857954261378;1707.9146042697816;1771.792713718889;1878.2017642501883;1939.4666466721483;2012.7383440152687;1009.4902074452501;1015.1979935850743;1065.8774240962234;1083.4907593431076;1139.8233273842568;17602.38391656286;17603.647927041387;17655.205515751823;17829;17919.73120403195;944.6457578408097;963.2775418436173;1001.5292812378316;1045.3153184664056;1085.6851513061124;10014.74963125913;10352.896471035343;10353.585856565653;10354.378737275787;10409.9479502602;439623;448907;450063;455753;466797;73605.26394736092;75176.62411687906;75664;76430.6178469104;76874.61562692151;1004.1364426593124;1017.3844823881593;1022.0239671114068;1025.4001409175567;1034.2294990232326;15686.215689215722;15931.36274549005;15968.520944371687;15990.96058756177;16131.274092666094;34136.82931585326;34730.82634586811;35411.645883540834;35442.8227858859;36108.458373123896;49331;49542;49682.75158624184;49687;50254.49745502498;8377.204165604258;8437.95781021091;8596.871046934177;8621.353398495012;8658.264047556027;10410.947945260528;12266.509339626315;12589.181703189264;12817.102802804087;13006.154599950973;10830;11114.777704445703;11251.156163287622;11295.435228238719;11322.60370887015;11121.721956951142;11551.768964620493;11614.883851161718;11689.532418703157;11732.472038758448;11094.44527773592;11198.21612487118;11304;11329.433528323387;11596.130290228435;8602.139786021347;8664.306855451674;8670.523121228392;8705.216530512283;8864.290856731317;10734.892651073702;10955.123590112931;11055.336679799238;11437.256578322715;11749.647510574696 09:18:02 INFO - PROCESS | 15434 | |3;mootools.html;1490.1580606957061;1607.4936395035566;1629.0958518022496;1875.3530032138908;1974.7334109895169;7298.197198308182;8203.589820508972;8279.296259817907;8280.171982801725;8280.83438331233;8186.140455252202;8350.206730360605;8376.49741015538;8378.832423351545;8382.664693412271;2083.479130217446;2131.435169680028;2396.376941995081;2403.7596240375997;2431.513697260546;2443.059422122487;2452.901883924641;2453.595156799126;2455.7175924768612;2456.091246238885;2340.8946597403074;2359.9764002360016;2372.8694921779297;2383.2373640435067;2386.343755467252;2396;2412.8069754419694;2414.8671823049635;2418.5283869645427;2448.43685952232;2384.594618914771;2386.72552656445;2399.748026457214;2401.6037353836596;2404.3748625357357;8565.828683426358;8620;8632.179942905414;8637.52493612851;8637.654493820302;5222.2427747976335;5337.199420087018;5342.332208473941;5348.090824559834;5349.170878513836;3264.2165880188822;3295.8516866741056;3296.917577060569;3337.2824842658947;3416;1083.5557421457165;1113.3375641493299;1126.6225814352201;1169.4912712969885;1179.8702142764375;11938.164328497009;11997.580084696994;12025;12030.278183308941;12036.879631203576;4532.9546704533195;4635.096156249499;4643.674942754043;4742.407199100113;4752.310914917318;10186.592536298613;10189.184865210766;10191.745206369751;10205.234607404474;10216.182705383551;5244.737763111829;5257.894842103136;5296.841094767163;5301.893962120736;5312.043832110257;4268.59448352406;4665.6967297125575;4677.836275730333;4755.785989630405;4825.4933232010835;3928.2143571285856;3965.861194858166;3974.463447434617;3995.06116062725;4058.4723985882238;1267.7084270617809;1273.1724379153625;1294.2816736711216;1311.6917524381763;1318.1168617026424;1123.8314252862135;1129.1474936423112;1239.7396546725108;1393.9372728227254;1401.0402874031322;8096.8380632387025;8255.504669719836;8260.669573217125;8262.049864265686;8267.917320826835;1157.1610582327912;1190.970225744346;1223.4616768621777;1229.1150371732517;1231.3289257354763;6324.936750632527;6346.524010699216;6376.394242547043;6421;6430.871382572416;10318.690439286833;10689.83965240522;10724.624638137628;10732.731681707864;10740.194485413625;10298;10472.581096756045;10550.630727924487;10562.630307939338;10569.9958503942;8084.191580841986;8159.143289954588;8228.588570571448;8273.627686754111;8280.875786863202;7686.3082322591235;7743.690252389842;7747.535147891144;7768.572728499987;7790.415718821225;9217.907820921973;9238.30712696564;9483;9519.52402379892;9542.093501117382;8754.737357879274;8858.512781797062;8959.238464730572;9588.76028099303;9674.08096230857;6602.306757790363;7076.433885289061;7168.354848063699;7369.37360324357;7560.6219689016425;7811.687532498637;7867.52794832289;7883.172266911892;7904.881426778488;7947.920520794718;7186.353228209487;7264.527805692613;7331.816704582215;7428.220036896264;7522.623868806647;7160.8925866113095;7172.820679483055;7180.60506672138;7247.891281630675;7250.347468727839;7295.4528410368375;7325.230850760593;7352.191258961617;7355.485116041826;7374.631268436664;6909.1018167637885;6926.168859736864;6954.3393377629045;6964.059851919926;6974.511784175262;7078.504504684829;7135.357817796215;7149.7140114396925;7155.713771449292;7155.962385454184 09:18:02 INFO - PROCESS | 15434 | |4;prototype.html;353.35336334507855;355.03784743345534;356.5365025466894;369.2909613541999;373.7402505258845;6029.884471372794;6032.366601506839;6116.908246376297;6125.448709616134;6133.11069894865;6020.488258498022;6031.668258245794;6036.2152920120325;6037.305709843369;6041.486473649734;4488.7531185784765;4604.355390245369;4645.581897629213;4707.90584188316;4727.220008698578;4709.199436095855;4741.217699079648;4756.548127927841;4769.046190761844;4776.092542416947;4709.646776491777;4714.929276060861;4724.811007559693;4727.030958653485;4735.147673418801;4432.711873728197;4579.335996280537;4645.535446455361;4655.02244528646;4660.603848672867;4149.460570125894;4151.12826306476;4151.958480415187;4153.709240353177;4161.97919010403;5626.437356264381;5672.8865422691315;5707.714614269312;5723.656580605177;5736.942630573682;5522.22688823565;5530.861728456821;5533.170024496318;5533.972330138364;5544.251526043973;6388.488920886318;6399.456046236076;6403.679816009181;6403.711832967528;6404.711787969506;4400.405945197389;4506.662000349987;4519.932201016954;4576.771161441915;4669.112868554964;6588.505862060317;6627.701753421059;6629.535932484776;6636.435902948255;6645.66771661415;4627.930581041287;4637.930431043537;4638.8608341749805;4640.280756482751;4646.651501137429;4728.338032675429;4730.597899178609;4737.28940658897;4739.099571081483;4748.145333839873;5396.028714831289;5412.161115027177;5419.295491586068;5421.132618781055;5437.646552974044;6287.49700023997;6395.168628078413;6421.325760795143;6431.453326467209;6439.22729272481;1633.216056292986;1656.2960741684735;1661.8699284486424;1662.659154873248;1664.7669326294329;1034.2139973620103;1062.3785085724937;1083.2958576925062;1084.1706094837455;1086.0334302470808;6084.482818960438;6178.876422471525;6181.165542651775;6186.628802271878;6189.8452538686;6555.246146693096;6558.409743123142;6567.638779867153;6568.080468734381;6577.243616984012;6146.170267013986;6160.630362178284;6164;6170.784022559189;6174.104754810617;3515.9121021974142;3553.271579326232;3555.8933232003083;3556.78659280444;3558.3061303045656;6578.473722102316;6756.324367563205;6759.087523184406;6770.796876093725;6789.898151527731;6681.164854393201;6686.197656281277;6696.799096027127;6703.530752847351;6708.262091169968;6735.764248251287;6740.157480314961;6745.8650826983185;6775.9497277922;6778.593284402951;6529.151210342815;6532.379423954717;6544.083828263952;6546.18172728409;6563.146790917151;6303.590266632654;6446.0975463434215;6457.3865482779065;6476.222853257639;6484.157059582224;6737.494687898329;6739.5619284746335;6747.595144291358;6752.5948443093575;6755.966220168868;4607.539246075366;4614.907701846011;4619.445666520039;4620.745858977789;4623.214053610962;6554.770583029571;6561;6562.50781191403;6564.540482166202;6565.244996825235;6198.504119670325;6362.204724409449;6378.90431643535;6379.457746091449;6387.233531976192;6360.618362898241;6370.948793449029;6374.458171055512;6378.521610879296;6378.776742814165;6195.473384762346;6197.783077592263;6226.782062627967;6238.532110091852;6267.62394256346;6404.71178796946;6405.679716014274;6406.167198264196;6407.167068281094;6418.069379939976;6047.48596369296;6186.288576813544;6186.597871138361;6208.937910620836;6227.844303892439 09:18:02 INFO - PROCESS | 15434 | |5;yui.html;831.980823491223;842.6966292134832;862.9223369896716;888.5379602606645;942.9292803039772;14456.20490873003;14523.273836308168;14674.046186997837;14694.11835289882;14699.926500367497;13785.793213101811;13925.93037034816;13954.720905581908;13955.232462214573;13959;757.3751654884715;909.3134683314122;919.6827094652334;938.6198589571235;942.9575669094872;927.837628415028;933.4212788071405;937;937.5827756648295;938.4463166731626;956.5408603870146;959.9616015359377;961.1925982174971;962.3600305796637;962.8026254617787;802.1617409806765;957.2150836314225;959.4435227568028;969.60730903984;980.764616492044;714.6819665248967;721.5598484924192;724.0731863215093;725.5320318394658;726.3535453446436;13988.720225595533;14082.366293516816;14085.577432677037;14089.85910140906;14101.942354323364;13871.237081960488;14736.189509576969;14769.113853168845;14850.702985940221;14875.181864997421;11740.88259117415;11769.764604707943;11881.881181188164;11929.403529823561;11968.222065565797;3975.741576797499;3980.7810570418615;3987;3990.880273591797;4063.3092374296143;50463.74768126136;50698;50767.74616126933;51052.48947510515;51089.74455127738;10567.15462762977;10928.945355273172;11373.366017134122;11515.884841151648;11745.647630571097;20896.37310880676;20921;20934.16263349449;20945.37163885086;20965.056572454276;7995.960020199978;8091.150429204967;8178.959105204436;8214.644583643632;8402.579871006548;4207.200631879933;4350.869473915787;4391.560843915583;4428.269335559661;4498.302763071663;3433.656634336546;3450.6204317525053;3464.168599536093;3468.2196505785996;3468.959312206328;563.8984982703153;619.8264485943943;623.7068577768441;642.2678146912524;642.3415998601471;545.4490964126261;596.83885350955;610.6946526736632;693.5630552751835;695.5027155583681;8178.550179740052;8206;8410.32717382608;8462.61918213682;8510.36172287081;602.7860109661007;606.2482521673094;620.0606081786098;623.9282482514478;627.5356236385043;3780.9432858507143;3895.8052097395016;4011.839526418969;4127.4015267786;4192.287311157111;55581.72209138928;60075.62783975571;60700.69649651812;60971;61146.694266528386;51436;51514;51858;52241;53262.46737532575;48272.27591586129;48443.27335089976;48465.5153448461;48901.266481002815;49116.263256051185;7878.448508604342;8113.1886811320755;8123.837523249384;8413.663453462037;8471.534065626449;35575.46636800502;36114.27771444609;36193;36684.81657591695;37217.6278237225;42776.35835462533;43569;44225.33661995008;44353.55646443494;45655.543444565126;10049.447280399649;10055.798884022424;10072.446015469219;10167.237457190888;10194.337368071052;10984.670459886216;11051.557937682403;11119.83320250213;11356.148288878201;11379.203455758017;9345.719628411158;10071.34536255141;11488.138389620979;11698.18658662426;11806.173567850512;11251.662450126509;11452.656420307405;11458.598949036743;11493.82759258595;11539.307641541534;11195.776084478102;11367.204295699552;11367.602133925604;11529.250598711056;11703.473343699383;9415.576299066695;9519.904800951901;9574.186194173295;9673.854892176763;10093.949530252301;9694.321397502106;9766.218702503924;9859.654912078044;9941.453220072965;9983.251256155672 09:18:02 INFO - PROCESS | 15434 | __end_tp_report 09:18:02 INFO - PROCESS | 15434 | __start_cc_report 09:18:02 INFO - PROCESS | 15434 | _x_x_mozilla_cycle_collect,876 09:18:02 INFO - PROCESS | 15434 | __end_cc_report 09:18:02 INFO - PROCESS | 15434 | __startTimestamp1460737082087__endTimestamp 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | ------- Summary: start ------- 09:18:02 INFO - PROCESS | 15434 | Number of tests: 6 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | [#0] dojo.html Cycles:165 Average:5398.71 Median:5602.86 stddev:592.73 (10.6%) stddev-sans-first:570.39 09:18:02 INFO - PROCESS | 15434 | Values: 3263.3 3292.0 3311.6 3312.8 3346.0 5327.3 5328.1 5352.3 5375.4 5388.9 5315.0 5331.9 5366.4 5372.4 5380.9 4772.4 4902.6 4907.8 4958.5 4990.8 4880.5 4952.9 4960.7 4961.4 4973.9 4885.0 4931.0 5014.6 5030.8 5035.1 4968.2 4978.7 4989.4 4993.1 5018.8 4846.5 4858.5 4957.1 4959.6 4987.6 5217.2 5225.1 5239.2 5249.7 5275.4 5630.0 5690.9 5732.1 5736.2 5739.8 5786.6 5836.5 5854.2 5855.7 5859.2 5421.5 5421.9 5423.2 5425.3 5466.2 5789.5 5904.0 5907.9 5944.3 5996.3 5780.9 5812.2 5815.9 5819.9 5855.6 5857.1 5894.8 5895.9 5896.4 5898.9 5690.4 5708.5 5810.4 5841.8 5886.2 5795.2 5796.9 5800.9 5811.3 5824.0 4422.4 4434.0 4456.5 4468.6 4477.7 3967.7 3972.6 4015.8 4021.9 4061.6 5509.9 5521.3 5535.7 5538.2 5544.4 5838.6 5854.5 5855.1 5867.2 5886.0 5418.6 5497.3 5549.9 5557.5 5604.4 5009.9 5014.7 5035.9 5039.5 5046.1 5750.0 6039.1 6053.1 6063.0 6071.8 5805.2 5878.9 5883.1 5887.6 5899.3 5991.9 5995.6 5995.7 5996.1 6055.3 5578.4 5700.1 5712.7 5714.9 5716.0 5813.5 5846.9 5848.1 5852.7 5882.4 5645.5 5664.1 5690.3 5694.9 5697.2 5492.8 5532.8 5605.1 5679.7 5714.4 5599.3 5616.9 5617.8 5621.9 5635.4 5704.3 5732.7 5738.7 5739.2 5740.1 5421.8 5507.2 5539.3 5596.9 5602.9 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | [#1] ext.html Cycles:180 Average:46297.75 Median:40212.20 stddev:70366.40 (175.0%) stddev-sans-first:70479.96 09:18:02 INFO - PROCESS | 15434 | Values: 551.3 562.4 574.4 610.0 622.0 40090.2 40453.4 40476.6 40511.4 40540.2 43172.8 43926.3 43957.6 43984.0 43996.6 8815.8 9088.0 9096.1 9097.4 9097.5 8540.9 8658.9 8669.1 8670.6 8674.3 9147.3 9196.9 9198.9 9201.7 9202.4 8827.2 8855.6 8856.1 8859.2 8860.9 9150.1 9272.1 9272.3 9275.6 9291.5 43894.3 44509.8 44582.8 44621.8 44788.6 3708.0 3796.6 3819.8 3872.3 3875.5 33610.0 33995.3 34058.3 34654.0 34917.8 4193.5 4263.6 4328.5 4441.5 4444.6 236054.0 239626.0 239821.0 240085.0 240297.0 62663.4 63268.4 63593.4 63600.0 63726.7 72848.6 73795.0 73867.0 73937.6 74022.6 14525.1 14544.3 14548.7 14570.1 14570.4 11375.9 11377.9 11393.8 11402.9 11411.0 22028.7 22513.0 22607.2 22654.5 23362.8 8204.8 8521.4 8552.6 8748.6 8808.9 1041.8 1047.6 1109.0 1112.4 1119.4 30427.0 30541.2 30831.5 31084.4 31253.4 1084.8 1188.2 1191.5 1198.1 1261.5 16274.8 16326.3 16445.5 16521.8 16676.9 327758.0 329554.0 332505.0 332529.0 334680.0 58603.4 59022.1 59071.0 59127.4 59139.7 1395.8 1486.4 1499.5 1519.4 1527.1 28324.6 28344.0 28896.3 29569.6 30927.5 46310.3 46397.3 46557.8 46880.3 46889.0 225147.0 225911.0 226267.0 226340.0 226763.0 30044.8 34816.8 35537.5 35581.8 35801.3 51916.2 52094.5 52644.4 52687.0 53510.5 40094.8 40641.0 40816.2 41342.6 41764.2 38780.8 39706.8 39716.2 40329.6 40714.6 39570.4 40367.8 40812.8 41359.0 41374.2 35849.3 36756.7 37154.3 37367.6 37548.8 27826.4 27948.6 28031.9 28049.6 28145.9 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | [#2] jquery.html Cycles:180 Average:26344.70 Median:2683.39 stddev:74153.56 (2763.4%) stddev-sans-first:74335.93 09:18:02 INFO - PROCESS | 15434 | Values: 368.1 381.7 389.9 394.1 396.6 17606.0 18893.3 19492.0 19637.5 19706.8 18109.9 18390.2 18444.9 18868.4 18875.2 5575.2 5761.4 5768.3 5802.4 5803.0 4223.7 5993.8 6235.1 6256.6 6268.6 6062.5 6124.9 6143.3 6154.4 6222.6 6305.9 6326.2 6329.7 6332.9 6334.4 3876.2 5308.7 5494.9 5496.2 5499.1 20774.7 21265.6 21306.9 21583.5 21590.4 2334.4 2345.2 2431.9 2640.1 2726.6 9995.1 10092.5 10223.5 10295.4 10367.6 1862.9 1945.0 1987.9 2015.0 2018.6 64386.4 66333.7 66377.3 68796.7 69262.0 9600.7 9639.9 9645.2 9721.8 9793.0 13281.7 13377.1 13393.7 13395.4 13400.1 7328.0 7329.7 7419.6 7448.4 7461.6 7229.5 7238.2 7246.5 7265.3 7274.3 4154.3 4230.7 4261.0 4502.3 4734.9 1707.9 1771.8 1878.2 1939.5 2012.7 1009.5 1015.2 1065.9 1083.5 1139.8 17602.4 17603.6 17655.2 17829.0 17919.7 944.6 963.3 1001.5 1045.3 1085.7 10014.7 10352.9 10353.6 10354.4 10409.9 439623.0 448907.0 450063.0 455753.0 466797.0 73605.3 75176.6 75664.0 76430.6 76874.6 1004.1 1017.4 1022.0 1025.4 1034.2 15686.2 15931.4 15968.5 15991.0 16131.3 34136.8 34730.8 35411.6 35442.8 36108.5 49331.0 49542.0 49682.8 49687.0 50254.5 8377.2 8438.0 8596.9 8621.4 8658.3 10410.9 12266.5 12589.2 12817.1 13006.2 10830.0 11114.8 11251.2 11295.4 11322.6 11121.7 11551.8 11614.9 11689.5 11732.5 11094.4 11198.2 11304.0 11329.4 11596.1 8602.1 8664.3 8670.5 8705.2 8864.3 10734.9 10955.1 11055.3 11437.3 11749.6 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | [#3] mootools.html Cycles:180 Average:5950.95 Median:5233.49 stddev:3127.36 (59.8%) stddev-sans-first:3118.16 09:18:02 INFO - PROCESS | 15434 | Values: 1490.2 1607.5 1629.1 1875.4 1974.7 7298.2 8203.6 8279.3 8280.2 8280.8 8186.1 8350.2 8376.5 8378.8 8382.7 2083.5 2131.4 2396.4 2403.8 2431.5 2443.1 2452.9 2453.6 2455.7 2456.1 2340.9 2360.0 2372.9 2383.2 2386.3 2396.0 2412.8 2414.9 2418.5 2448.4 2384.6 2386.7 2399.7 2401.6 2404.4 8565.8 8620.0 8632.2 8637.5 8637.7 5222.2 5337.2 5342.3 5348.1 5349.2 3264.2 3295.9 3296.9 3337.3 3416.0 1083.6 1113.3 1126.6 1169.5 1179.9 11938.2 11997.6 12025.0 12030.3 12036.9 4533.0 4635.1 4643.7 4742.4 4752.3 10186.6 10189.2 10191.7 10205.2 10216.2 5244.7 5257.9 5296.8 5301.9 5312.0 4268.6 4665.7 4677.8 4755.8 4825.5 3928.2 3965.9 3974.5 3995.1 4058.5 1267.7 1273.2 1294.3 1311.7 1318.1 1123.8 1129.1 1239.7 1393.9 1401.0 8096.8 8255.5 8260.7 8262.0 8267.9 1157.2 1191.0 1223.5 1229.1 1231.3 6324.9 6346.5 6376.4 6421.0 6430.9 10318.7 10689.8 10724.6 10732.7 10740.2 10298.0 10472.6 10550.6 10562.6 10570.0 8084.2 8159.1 8228.6 8273.6 8280.9 7686.3 7743.7 7747.5 7768.6 7790.4 9217.9 9238.3 9483.0 9519.5 9542.1 8754.7 8858.5 8959.2 9588.8 9674.1 6602.3 7076.4 7168.4 7369.4 7560.6 7811.7 7867.5 7883.2 7904.9 7947.9 7186.4 7264.5 7331.8 7428.2 7522.6 7160.9 7172.8 7180.6 7247.9 7250.3 7295.5 7325.2 7352.2 7355.5 7374.6 6909.1 6926.2 6954.3 6964.1 6974.5 7078.5 7135.4 7149.7 7155.7 7156.0 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | [#4] prototype.html Cycles:180 Average:5363.36 Median:6129.28 stddev:1581.87 (25.8%) stddev-sans-first:1540.96 09:18:02 INFO - PROCESS | 15434 | Values: 353.4 355.0 356.5 369.3 373.7 6029.9 6032.4 6116.9 6125.4 6133.1 6020.5 6031.7 6036.2 6037.3 6041.5 4488.8 4604.4 4645.6 4707.9 4727.2 4709.2 4741.2 4756.5 4769.0 4776.1 4709.6 4714.9 4724.8 4727.0 4735.1 4432.7 4579.3 4645.5 4655.0 4660.6 4149.5 4151.1 4152.0 4153.7 4162.0 5626.4 5672.9 5707.7 5723.7 5736.9 5522.2 5530.9 5533.2 5534.0 5544.3 6388.5 6399.5 6403.7 6403.7 6404.7 4400.4 4506.7 4519.9 4576.8 4669.1 6588.5 6627.7 6629.5 6636.4 6645.7 4627.9 4637.9 4638.9 4640.3 4646.7 4728.3 4730.6 4737.3 4739.1 4748.1 5396.0 5412.2 5419.3 5421.1 5437.6 6287.5 6395.2 6421.3 6431.5 6439.2 1633.2 1656.3 1661.9 1662.7 1664.8 1034.2 1062.4 1083.3 1084.2 1086.0 6084.5 6178.9 6181.2 6186.6 6189.8 6555.2 6558.4 6567.6 6568.1 6577.2 6146.2 6160.6 6164.0 6170.8 6174.1 3515.9 3553.3 3555.9 3556.8 3558.3 6578.5 6756.3 6759.1 6770.8 6789.9 6681.2 6686.2 6696.8 6703.5 6708.3 6735.8 6740.2 6745.9 6775.9 6778.6 6529.2 6532.4 6544.1 6546.2 6563.1 6303.6 6446.1 6457.4 6476.2 6484.2 6737.5 6739.6 6747.6 6752.6 6756.0 4607.5 4614.9 4619.4 4620.7 4623.2 6554.8 6561.0 6562.5 6564.5 6565.2 6198.5 6362.2 6378.9 6379.5 6387.2 6360.6 6370.9 6374.5 6378.5 6378.8 6195.5 6197.8 6226.8 6238.5 6267.6 6404.7 6405.7 6406.2 6407.2 6418.1 6047.5 6186.3 6186.6 6208.9 6227.8 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - PROCESS | 15434 | [#5] yui.html Cycles:180 Average:14311.31 Median:48357.77 stddev:16476.06 (34.1%) stddev-sans-first:16491.18 09:18:02 INFO - PROCESS | 15434 | Values: 832.0 842.7 862.9 888.5 942.9 14456.2 14523.3 14674.0 14694.1 14699.9 13785.8 13925.9 13954.7 13955.2 13959.0 757.4 909.3 919.7 938.6 943.0 927.8 933.4 937.0 937.6 938.4 956.5 960.0 961.2 962.4 962.8 802.2 957.2 959.4 969.6 980.8 714.7 721.6 724.1 725.5 726.4 13988.7 14082.4 14085.6 14089.9 14101.9 13871.2 14736.2 14769.1 14850.7 14875.2 11740.9 11769.8 11881.9 11929.4 11968.2 3975.7 3980.8 3987.0 3990.9 4063.3 50463.7 50698.0 50767.7 51052.5 51089.7 10567.2 10928.9 11373.4 11515.9 11745.6 20896.4 20921.0 20934.2 20945.4 20965.1 7996.0 8091.2 8179.0 8214.6 8402.6 4207.2 4350.9 4391.6 4428.3 4498.3 3433.7 3450.6 3464.2 3468.2 3469.0 563.9 619.8 623.7 642.3 642.3 545.4 596.8 610.7 693.6 695.5 8178.6 8206.0 8410.3 8462.6 8510.4 602.8 606.2 620.1 623.9 627.5 3780.9 3895.8 4011.8 4127.4 4192.3 55581.7 60075.6 60700.7 60971.0 61146.7 51436.0 51514.0 51858.0 52241.0 53262.5 48272.3 48443.3 48465.5 48901.3 49116.3 7878.4 8113.2 8123.8 8413.7 8471.5 35575.5 36114.3 36193.0 36684.8 37217.6 42776.4 43569.0 44225.3 44353.6 45655.5 10049.4 10055.8 10072.4 10167.2 10194.3 10984.7 11051.6 11119.8 11356.1 11379.2 9345.7 10071.3 11488.1 11698.2 11806.2 11251.7 11452.7 11458.6 11493.8 11539.3 11195.8 11367.2 11367.6 11529.3 11703.5 9415.6 9519.9 9574.2 9673.9 10093.9 9694.3 9766.2 9859.7 9941.5 9983.3 09:18:02 INFO - PROCESS | 15434 | -------- Summary: end -------- 09:18:02 INFO - PROCESS | 15434 | 09:18:02 INFO - TEST-INFO | 15434: exit 0 09:18:02 INFO - TEST-OK | dromaeo_css | took 1111311ms 09:18:02 INFO - TEST-START | kraken 09:18:02 INFO - operating with platform_type : linux_ 09:18:02 INFO - Initialising browser for kraken test... 09:18:02 INFO - TEST-INFO | started process 15629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSuX8v/profile http://localhost:59587/getInfo.html) 09:18:06 INFO - PROCESS | 15629 | __metrics Screen width/height:1600/1200 09:18:06 INFO - PROCESS | 15629 | colorDepth:24 09:18:06 INFO - PROCESS | 15629 | Browser inner width/height: 1024/697 09:18:06 INFO - PROCESS | 15629 | __metrics 09:18:08 INFO - PROCESS | 15629 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:08 INFO - TEST-INFO | 15629: exit 0 09:18:08 INFO - Browser initialized. 09:18:08 INFO - Running cycle 1/1 for kraken test... 09:18:08 INFO - TEST-INFO | started process 15717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSuX8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:20 INFO - PROCESS | 15717 | RSS: Main: 141471744 09:18:20 INFO - PROCESS | 15717 | 09:18:23 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59587/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:23 INFO - PROCESS | 15717 | RSS: Main: 177745920 09:18:23 INFO - PROCESS | 15717 | 09:18:26 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59587/tests/kraken/driver.html?testName=audio-dft) 09:18:27 INFO - PROCESS | 15717 | RSS: Main: 176373760 09:18:27 INFO - PROCESS | 15717 | 09:18:29 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59587/tests/kraken/driver.html?testName=audio-fft) 09:18:30 INFO - PROCESS | 15717 | RSS: Main: 173662208 09:18:30 INFO - PROCESS | 15717 | 09:18:32 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59587/tests/kraken/driver.html?testName=audio-oscillator) 09:18:33 INFO - PROCESS | 15717 | RSS: Main: 173355008 09:18:33 INFO - PROCESS | 15717 | 09:18:35 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59587/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:35 INFO - PROCESS | 15717 | RSS: Main: 171323392 09:18:35 INFO - PROCESS | 15717 | 09:18:38 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59587/tests/kraken/driver.html?testName=imaging-darkroom) 09:18:39 INFO - PROCESS | 15717 | RSS: Main: 171487232 09:18:39 INFO - PROCESS | 15717 | 09:18:42 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59587/tests/kraken/driver.html?testName=imaging-desaturate) 09:18:43 INFO - PROCESS | 15717 | RSS: Main: 171286528 09:18:43 INFO - PROCESS | 15717 | 09:18:46 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59587/tests/kraken/driver.html?testName=json-parse-financial) 09:18:46 INFO - PROCESS | 15717 | RSS: Main: 171421696 09:18:46 INFO - PROCESS | 15717 | 09:18:48 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59587/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:18:48 INFO - PROCESS | 15717 | RSS: Main: 175284224 09:18:48 INFO - PROCESS | 15717 | 09:18:50 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:18:51 INFO - PROCESS | 15717 | RSS: Main: 173375488 09:18:51 INFO - PROCESS | 15717 | 09:18:53 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:18:53 INFO - PROCESS | 15717 | RSS: Main: 179826688 09:18:53 INFO - PROCESS | 15717 | 09:18:56 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:18:56 INFO - PROCESS | 15717 | RSS: Main: 188477440 09:18:56 INFO - PROCESS | 15717 | 09:18:59 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:18:59 INFO - PROCESS | 15717 | RSS: Main: 187314176 09:18:59 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | Cycle 1(1): loaded http://localhost:59587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59587/tests/kraken/driver.html?testName=ai-astar) 09:19:01 INFO - PROCESS | 15717 | RSS: Main: 249466880 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | __start_tp_report 09:19:01 INFO - PROCESS | 15717 | _x_x_mozilla_page_load 09:19:01 INFO - PROCESS | 15717 | _x_x_mozilla_page_load_details 09:19:01 INFO - PROCESS | 15717 | |i|pagename|runs| 09:19:01 INFO - PROCESS | 15717 | |0;ai-astar;109;111;104;109;110;111;99;109;110;111 09:19:01 INFO - PROCESS | 15717 | |1;audio-beat-detection;154;129;155;174;129;160;158;131;176;127 09:19:01 INFO - PROCESS | 15717 | |2;audio-dft;162;161;162;163;161;163;160;164;162;161 09:19:01 INFO - PROCESS | 15717 | |3;audio-fft;76;77;76;166;76;77;76;75;165;73 09:19:01 INFO - PROCESS | 15717 | |4;audio-oscillator;94;93;140;92;93;94;150;94;94;146 09:19:01 INFO - PROCESS | 15717 | |5;imaging-gaussian-blur;117;118;118;118;117;116;117;117;117;117 09:19:01 INFO - PROCESS | 15717 | |6;imaging-darkroom;147;146;149;149;149;149;149;148;148;146 09:19:01 INFO - PROCESS | 15717 | |7;imaging-desaturate;96;97;96;95;96;96;95;96;95;95 09:19:01 INFO - PROCESS | 15717 | |8;json-parse-financial;54;56;54;54;54;56;55;63;53;53 09:19:01 INFO - PROCESS | 15717 | |9;json-stringify-tinderbox;64;65;65;65;74;64;64;65;65;65 09:19:01 INFO - PROCESS | 15717 | |10;stanford-crypto-aes;78;79;78;85;78;78;78;79;78;77 09:19:01 INFO - PROCESS | 15717 | |11;stanford-crypto-ccm;112;127;128;117;118;114;113;118;121;114 09:19:01 INFO - PROCESS | 15717 | |12;stanford-crypto-pbkdf2;149;144;145;143;144;134;150;144;144;146 09:19:01 INFO - PROCESS | 15717 | |13;stanford-crypto-sha256-iterative;67;66;68;65;65;65;66;67;66;64 09:19:01 INFO - PROCESS | 15717 | __end_tp_report 09:19:01 INFO - PROCESS | 15717 | __start_cc_report 09:19:01 INFO - PROCESS | 15717 | _x_x_mozilla_cycle_collect,1096 09:19:01 INFO - PROCESS | 15717 | __end_cc_report 09:19:01 INFO - PROCESS | 15717 | __startTimestamp1460737141864__endTimestamp 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | ------- Summary: start ------- 09:19:01 INFO - PROCESS | 15717 | Number of tests: 14 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.50 stddev:3.86 (3.5%) stddev-sans-first:4.09 09:19:01 INFO - PROCESS | 15717 | Values: 109.0 111.0 104.0 109.0 110.0 111.0 99.0 109.0 110.0 111.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:156.50 stddev:18.93 (12.1%) stddev-sans-first:20.00 09:19:01 INFO - PROCESS | 15717 | Values: 154.0 129.0 155.0 174.0 129.0 160.0 158.0 131.0 176.0 127.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 09:19:01 INFO - PROCESS | 15717 | Values: 162.0 161.0 162.0 163.0 161.0 163.0 160.0 164.0 162.0 161.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.86 (49.8%) stddev-sans-first:39.61 09:19:01 INFO - PROCESS | 15717 | Values: 76.0 77.0 76.0 166.0 76.0 77.0 76.0 75.0 165.0 73.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.50 stddev:25.19 (26.9%) stddev-sans-first:26.13 09:19:01 INFO - PROCESS | 15717 | Values: 94.0 93.0 140.0 92.0 93.0 94.0 150.0 94.0 94.0 146.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:19:01 INFO - PROCESS | 15717 | Values: 117.0 118.0 118.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:149.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 09:19:01 INFO - PROCESS | 15717 | Values: 147.0 146.0 149.0 149.0 149.0 149.0 149.0 148.0 148.0 146.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:19:01 INFO - PROCESS | 15717 | Values: 96.0 97.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:2.94 (5.4%) stddev-sans-first:3.08 09:19:01 INFO - PROCESS | 15717 | Values: 54.0 56.0 54.0 54.0 54.0 56.0 55.0 63.0 53.0 53.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:2.99 (4.6%) stddev-sans-first:3.11 09:19:01 INFO - PROCESS | 15717 | Values: 64.0 65.0 65.0 65.0 74.0 64.0 64.0 65.0 65.0 65.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.25 (2.9%) stddev-sans-first:2.37 09:19:01 INFO - PROCESS | 15717 | Values: 78.0 79.0 78.0 85.0 78.0 78.0 78.0 79.0 78.0 77.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.00 stddev:5.61 (4.8%) stddev-sans-first:5.49 09:19:01 INFO - PROCESS | 15717 | Values: 112.0 127.0 128.0 117.0 118.0 114.0 113.0 118.0 121.0 114.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:144.50 stddev:4.30 (3.0%) stddev-sans-first:4.21 09:19:01 INFO - PROCESS | 15717 | Values: 149.0 144.0 145.0 143.0 144.0 134.0 150.0 144.0 144.0 146.0 09:19:01 INFO - PROCESS | 15717 | 09:19:01 INFO - PROCESS | 15717 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 09:19:01 INFO - PROCESS | 15717 | Values: 67.0 66.0 68.0 65.0 65.0 65.0 66.0 67.0 66.0 64.0 09:19:01 INFO - PROCESS | 15717 | -------- Summary: end -------- 09:19:01 INFO - PROCESS | 15717 | 09:19:02 INFO - TEST-INFO | 15717: exit 0 09:19:02 INFO - TEST-OK | kraken | took 60117ms 09:19:02 INFO - SUITE-END | took 1171s 09:19:03 INFO - Completed test suite (00:19:31) 09:19:03 INFO - javascript benchmark 09:19:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3263.314703912178, 3291.9835400822994, 3311.5694959655243, 3312.8012319260847, 3345.98327008365, 5327.334083239595, 5328.094223981922, 5352.304200453936, 5375.4355792641745, 5388.892222155555, 5314.973425132869, 5331.893362132765, 5366.436524164965, 5372.382176049746, 5380.865478363043, 4772.379590653228, 4902.607791376699, 4907.779149938261, 4958.479359667237, 4990.750462476862, 4880.536349046835, 4952.851414457572, 4960.6527543072, 4961.355023846895, 4973.850784476472, 4884.951150488485, 4931.0, 5014.623903207255, 5030.82392116276, 5035.068512325213, 4968.205087186033, 4978.6514943953935, 4989.426215985171, 4993.076280888047, 5018.824341148061, 4846.539578740014, 4858.538438848339, 4957.058158949788, 4959.603231741452, 4987.62592805541, 5217.165253559412, 5225.137852254374, 5239.16173412256, 5249.658772179796, 5275.446078161776, 5629.971850140764, 5690.9146362804595, 5732.054211055212, 5736.168255602956, 5739.7991070312755, 5786.623869448473, 5836.503897168745, 5854.151148083504, 5855.677937713424, 5859.2090067841145, 5421.457854214586, 5421.945780542144, 5423.159410291371, 5425.294711687456, 5466.180072989044, 5789.507891829157, 5904.0, 5907.940920590825, 5944.256967879015, 5996.280446346466, 5780.855478612984, 5812.215350927655, 5815.912761308584, 5819.883602328015, 5855.59010869235, 5857.121431785266, 5894.764209431574, 5895.941040589625, 5896.439838215363, 5898.911516327258, 5690.4025077367105, 5708.514776244066, 5810.389909059572, 5841.824745257649, 5886.205362276123, 5795.246617939725, 5796.913046304308, 5800.854978625568, 5811.331696854916, 5823.970880145572, 4422.358757980075, 4433.955660443419, 4456.509783923766, 4468.642508599304, 4477.686561940698, 3967.742096763759, 3972.6226008529143, 4015.77913214776, 4021.8994525136522, 4061.614146656063, 5509.944900550943, 5521.282233309644, 5535.667859928417, 5538.169274608841, 5544.390117087117, 5838.649681019152, 5854.531637468992, 5855.063189889597, 5867.237259156368, 5885.970570147122, 5418.566514678816, 5497.340319161646, 5549.944500555023, 5557.527610153102, 5604.355499117653, 5009.89980200394, 5014.721246082226, 5035.874103147377, 5039.5212454817465, 5046.091703493406, 5750.0, 6039.124326972565, 6053.122297266872, 6063.0, 6071.848203794852, 5805.216295800097, 5878.94121058801, 5883.146943693226, 5887.646741195542, 5899.292084949833, 5991.940080599138, 5995.61028533144, 5995.670238136944, 5996.1005849122985, 6055.303640081447, 5578.442155784389, 5700.144978253295, 5712.714364281686, 5714.942850571441, 5716.0, 5813.505852002627, 5846.94153058464, 5848.122781582627, 5852.678102704393, 5882.441168089024, 5645.463680950304, 5664.122061080539, 5690.317161940594, 5694.914576281276, 5697.202391665087, 5492.780288788404, 5532.834014979557, 5605.103183490785, 5679.6876171810945, 5714.3714191438075, 5599.300087489064, 5616.85957851057, 5617.831465056055, 5621.8594535136945, 5635.408282130317, 5704.344000440003, 5732.684702341411, 5738.741756620879, 5739.2252045973255, 5740.0815869460685, 5421.810236641699, 5507.173923911285, 5539.335279766454, 5596.860078497907, 5602.85992850182], "unit": "score", "name": "dojo.html", "value": 5360.937810434465}, {"lowerIsBetter": false, "replicates": [551.2585572405113, 562.3810777645849, 574.4485294117646, 610.0026456743225, 621.9657918814465, 40090.198196036064, 40453.393199102036, 40476.59523404765, 40511.392329115086, 40540.18919621606, 43172.78413607935, 43926.34110488337, 43957.56042439575, 43984.0, 43996.56003439973, 8815.779605509866, 9087.954560227223, 9096.135867092615, 9097.363184577081, 9097.54512274387, 8540.914590854074, 8658.87011694825, 8669.133086691343, 8670.609822557968, 8674.34942379321, 9147.268218542535, 9196.862047069299, 9198.908010919871, 9201.72394828153, 9202.401843880127, 8827.249683776887, 8855.645774169025, 8856.114388561125, 8859.202671759573, 8860.8670869937, 9150.130737579919, 9272.072792720674, 9272.258219342437, 9275.58259878307, 9291.535423228812, 43894.34158487625, 44509.77745111254, 44582.777086114365, 44621.77689111566, 44788.55211447876, 3708.0, 3796.620337966209, 3819.770813751156, 3872.283627528916, 3875.476810630557, 33610.0, 33995.32009359824, 34058.31883362319, 34654.0, 34917.825410872785, 4193.454850869398, 4263.5736426357425, 4328.50222224445, 4441.511433742286, 4444.577765112309, 236054.0, 239626.0, 239821.0, 240085.0, 240297.0, 62663.373366266664, 63268.36731632717, 63593.36406635967, 63600.0, 63726.68136659287, 72848.63575682088, 73795.0, 73867.0, 73937.6303118481, 74022.6298868513, 14525.128492290496, 14544.345504452325, 14548.709025819637, 14570.05294655844, 14570.41718331255, 11375.886241137483, 11377.88622113785, 11393.829092563617, 11402.885971140347, 11411.0, 22028.669569956463, 22513.0, 22607.208747693752, 22654.546909061726, 23362.76637233606, 8204.794880128045, 8521.403501754818, 8552.57237138153, 8748.562571871382, 8808.92990147315, 1041.8124737547162, 1047.558352585034, 1108.9600397120873, 1112.3548341961643, 1119.3899324867966, 30427.0, 30541.23646908845, 30831.537526937114, 31084.378312433626, 31253.37493250122, 1084.7993121272589, 1188.1742189178437, 1191.4578866615668, 1198.1433275208267, 1261.4575732434957, 16274.75587866183, 16326.265318060716, 16445.506634800975, 16521.752173717403, 16676.916615416845, 327758.0, 329554.0, 332505.0, 332529.0, 334680.0, 58603.41396586065, 59022.11466828001, 59071.0, 59127.408725913054, 59139.70430147822, 1395.8325000999946, 1486.3831509923477, 1499.4676889704217, 1519.3998370643756, 1527.0990115831712, 28324.575131372632, 28344.007959722137, 28896.2775930595, 29569.556456652736, 30927.536086959164, 46310.30534541917, 46397.304040440096, 46557.76721116373, 46880.29679554878, 46889.0, 225147.0, 225911.0, 226267.0, 226340.0, 226763.0, 30044.849775750983, 34816.82591587026, 35537.466937995436, 35581.82209088938, 35801.28397432089, 51916.221256681936, 52094.47905521048, 52644.410169659575, 52687.0, 53510.464895350546, 40094.799526002185, 40640.98397540085, 40816.1836763269, 41342.58657413387, 41764.1647167061, 38780.80609596934, 39706.80146599249, 39716.20567588574, 40329.596704032585, 40714.59285407108, 39570.40644390394, 40367.79816100901, 40812.79593602013, 41359.0, 41374.172516550105, 35849.283014340086, 36756.713515027914, 37154.25691486209, 37367.62632373641, 37548.812255938545, 27826.443471130868, 27948.580771288853, 28031.859840700665, 28049.579256310764, 28145.859270703517], "unit": "score", "name": "ext.html", "value": 19700.61788792828}, {"lowerIsBetter": false, "replicates": [368.1110119062464, 381.72706514841883, 389.8947284233259, 394.06409776780146, 396.6430212808472, 17606.0, 18893.33873314434, 19492.02539873008, 19637.509062273413, 19706.80293197066, 18109.90945045273, 18390.1724422401, 18444.893306401624, 18868.43394698158, 18875.244990200375, 5575.219469274295, 5761.423857614247, 5768.278965129359, 5802.448767367094, 5803.042497987848, 4223.683223758215, 5993.820185394445, 6235.095911092889, 6256.593321434115, 6268.561200715952, 6062.4543791058795, 6124.938750612504, 6143.32423433422, 6154.384561543855, 6222.62664240147, 6305.905411418832, 6326.177596912395, 6329.651869147195, 6332.90500642493, 6334.366563343675, 3876.205377897524, 5308.70802105884, 5494.890102197974, 5496.203050557687, 5499.120140777456, 20774.688379674317, 21265.57468850614, 21306.934653267428, 21583.460413489633, 21590.352289431186, 2334.3580515358244, 2345.2495201535344, 2431.8784060797066, 2640.1419538650016, 2726.6319046928807, 9995.100440960348, 10092.495375231283, 10223.488825558692, 10295.433751143684, 10367.63713270032, 1862.9161687724086, 1944.9805501945082, 1987.930422435208, 2014.9798502015085, 2018.5760990192077, 64386.3561364385, 66333.66833165851, 66377.33622663759, 68796.6560167201, 69262.0, 9600.66397676078, 9639.855402168972, 9645.228381729445, 9721.805563888824, 9793.0, 13281.667958300926, 13377.130486518345, 13393.73212535744, 13395.397207125703, 13400.06199566021, 7328.0, 7329.743458979016, 7419.59192244421, 7448.366888814511, 7461.5523068614975, 7229.530080544748, 7238.23998480152, 7246.478239569644, 7265.346118849329, 7274.345308922222, 4154.252234597741, 4230.661547076226, 4261.0, 4502.257127573914, 4734.857954261378, 1707.9146042697816, 1771.792713718889, 1878.2017642501883, 1939.4666466721483, 2012.7383440152687, 1009.4902074452501, 1015.1979935850743, 1065.8774240962234, 1083.4907593431076, 1139.8233273842568, 17602.38391656286, 17603.647927041387, 17655.205515751823, 17829.0, 17919.73120403195, 944.6457578408097, 963.2775418436173, 1001.5292812378316, 1045.3153184664056, 1085.6851513061124, 10014.74963125913, 10352.896471035343, 10353.585856565653, 10354.378737275787, 10409.9479502602, 439623.0, 448907.0, 450063.0, 455753.0, 466797.0, 73605.26394736092, 75176.62411687906, 75664.0, 76430.6178469104, 76874.61562692151, 1004.1364426593124, 1017.3844823881593, 1022.0239671114068, 1025.4001409175567, 1034.2294990232326, 15686.215689215722, 15931.36274549005, 15968.520944371687, 15990.96058756177, 16131.274092666094, 34136.82931585326, 34730.82634586811, 35411.645883540834, 35442.8227858859, 36108.458373123896, 49331.0, 49542.0, 49682.75158624184, 49687.0, 50254.49745502498, 8377.204165604258, 8437.95781021091, 8596.871046934177, 8621.353398495012, 8658.264047556027, 10410.947945260528, 12266.509339626315, 12589.181703189264, 12817.102802804087, 13006.154599950973, 10830.0, 11114.777704445703, 11251.156163287622, 11295.435228238719, 11322.60370887015, 11121.721956951142, 11551.768964620493, 11614.883851161718, 11689.532418703157, 11732.472038758448, 11094.44527773592, 11198.21612487118, 11304.0, 11329.433528323387, 11596.130290228435, 8602.139786021347, 8664.306855451674, 8670.523121228392, 8705.216530512283, 8864.290856731317, 10734.892651073702, 10955.123590112931, 11055.336679799238, 11437.256578322715, 11749.647510574696], "unit": "score", "name": "jquery.html", "value": 8807.454670932866}, {"lowerIsBetter": false, "replicates": [1490.1580606957061, 1607.4936395035566, 1629.0958518022496, 1875.3530032138908, 1974.7334109895169, 7298.197198308182, 8203.589820508972, 8279.296259817907, 8280.171982801725, 8280.83438331233, 8186.140455252202, 8350.206730360605, 8376.49741015538, 8378.832423351545, 8382.664693412271, 2083.479130217446, 2131.435169680028, 2396.376941995081, 2403.7596240375997, 2431.513697260546, 2443.059422122487, 2452.901883924641, 2453.595156799126, 2455.7175924768612, 2456.091246238885, 2340.8946597403074, 2359.9764002360016, 2372.8694921779297, 2383.2373640435067, 2386.343755467252, 2396.0, 2412.8069754419694, 2414.8671823049635, 2418.5283869645427, 2448.43685952232, 2384.594618914771, 2386.72552656445, 2399.748026457214, 2401.6037353836596, 2404.3748625357357, 8565.828683426358, 8620.0, 8632.179942905414, 8637.52493612851, 8637.654493820302, 5222.2427747976335, 5337.199420087018, 5342.332208473941, 5348.090824559834, 5349.170878513836, 3264.2165880188822, 3295.8516866741056, 3296.917577060569, 3337.2824842658947, 3416.0, 1083.5557421457165, 1113.3375641493299, 1126.6225814352201, 1169.4912712969885, 1179.8702142764375, 11938.164328497009, 11997.580084696994, 12025.0, 12030.278183308941, 12036.879631203576, 4532.9546704533195, 4635.096156249499, 4643.674942754043, 4742.407199100113, 4752.310914917318, 10186.592536298613, 10189.184865210766, 10191.745206369751, 10205.234607404474, 10216.182705383551, 5244.737763111829, 5257.894842103136, 5296.841094767163, 5301.893962120736, 5312.043832110257, 4268.59448352406, 4665.6967297125575, 4677.836275730333, 4755.785989630405, 4825.4933232010835, 3928.2143571285856, 3965.861194858166, 3974.463447434617, 3995.06116062725, 4058.4723985882238, 1267.7084270617809, 1273.1724379153625, 1294.2816736711216, 1311.6917524381763, 1318.1168617026424, 1123.8314252862135, 1129.1474936423112, 1239.7396546725108, 1393.9372728227254, 1401.0402874031322, 8096.8380632387025, 8255.504669719836, 8260.669573217125, 8262.049864265686, 8267.917320826835, 1157.1610582327912, 1190.970225744346, 1223.4616768621777, 1229.1150371732517, 1231.3289257354763, 6324.936750632527, 6346.524010699216, 6376.394242547043, 6421.0, 6430.871382572416, 10318.690439286833, 10689.83965240522, 10724.624638137628, 10732.731681707864, 10740.194485413625, 10298.0, 10472.581096756045, 10550.630727924487, 10562.630307939338, 10569.9958503942, 8084.191580841986, 8159.143289954588, 8228.588570571448, 8273.627686754111, 8280.875786863202, 7686.3082322591235, 7743.690252389842, 7747.535147891144, 7768.572728499987, 7790.415718821225, 9217.907820921973, 9238.30712696564, 9483.0, 9519.52402379892, 9542.093501117382, 8754.737357879274, 8858.512781797062, 8959.238464730572, 9588.76028099303, 9674.08096230857, 6602.306757790363, 7076.433885289061, 7168.354848063699, 7369.37360324357, 7560.6219689016425, 7811.687532498637, 7867.52794832289, 7883.172266911892, 7904.881426778488, 7947.920520794718, 7186.353228209487, 7264.527805692613, 7331.816704582215, 7428.220036896264, 7522.623868806647, 7160.8925866113095, 7172.820679483055, 7180.60506672138, 7247.891281630675, 7250.347468727839, 7295.4528410368375, 7325.230850760593, 7352.191258961617, 7355.485116041826, 7374.631268436664, 6909.1018167637885, 6926.168859736864, 6954.3393377629045, 6964.059851919926, 6974.511784175262, 7078.504504684829, 7135.357817796215, 7149.7140114396925, 7155.713771449292, 7155.962385454184], "unit": "score", "name": "mootools.html", "value": 4875.348181076967}, {"lowerIsBetter": false, "replicates": [353.35336334507855, 355.03784743345534, 356.5365025466894, 369.2909613541999, 373.7402505258845, 6029.884471372794, 6032.366601506839, 6116.908246376297, 6125.448709616134, 6133.11069894865, 6020.488258498022, 6031.668258245794, 6036.2152920120325, 6037.305709843369, 6041.486473649734, 4488.7531185784765, 4604.355390245369, 4645.581897629213, 4707.90584188316, 4727.220008698578, 4709.199436095855, 4741.217699079648, 4756.548127927841, 4769.046190761844, 4776.092542416947, 4709.646776491777, 4714.929276060861, 4724.811007559693, 4727.030958653485, 4735.147673418801, 4432.711873728197, 4579.335996280537, 4645.535446455361, 4655.02244528646, 4660.603848672867, 4149.460570125894, 4151.12826306476, 4151.958480415187, 4153.709240353177, 4161.97919010403, 5626.437356264381, 5672.8865422691315, 5707.714614269312, 5723.656580605177, 5736.942630573682, 5522.22688823565, 5530.861728456821, 5533.170024496318, 5533.972330138364, 5544.251526043973, 6388.488920886318, 6399.456046236076, 6403.679816009181, 6403.711832967528, 6404.711787969506, 4400.405945197389, 4506.662000349987, 4519.932201016954, 4576.771161441915, 4669.112868554964, 6588.505862060317, 6627.701753421059, 6629.535932484776, 6636.435902948255, 6645.66771661415, 4627.930581041287, 4637.930431043537, 4638.8608341749805, 4640.280756482751, 4646.651501137429, 4728.338032675429, 4730.597899178609, 4737.28940658897, 4739.099571081483, 4748.145333839873, 5396.028714831289, 5412.161115027177, 5419.295491586068, 5421.132618781055, 5437.646552974044, 6287.49700023997, 6395.168628078413, 6421.325760795143, 6431.453326467209, 6439.22729272481, 1633.216056292986, 1656.2960741684735, 1661.8699284486424, 1662.659154873248, 1664.7669326294329, 1034.2139973620103, 1062.3785085724937, 1083.2958576925062, 1084.1706094837455, 1086.0334302470808, 6084.482818960438, 6178.876422471525, 6181.165542651775, 6186.628802271878, 6189.8452538686, 6555.246146693096, 6558.409743123142, 6567.638779867153, 6568.080468734381, 6577.243616984012, 6146.170267013986, 6160.630362178284, 6164.0, 6170.784022559189, 6174.104754810617, 3515.9121021974142, 3553.271579326232, 3555.8933232003083, 3556.78659280444, 3558.3061303045656, 6578.473722102316, 6756.324367563205, 6759.087523184406, 6770.796876093725, 6789.898151527731, 6681.164854393201, 6686.197656281277, 6696.799096027127, 6703.530752847351, 6708.262091169968, 6735.764248251287, 6740.157480314961, 6745.8650826983185, 6775.9497277922, 6778.593284402951, 6529.151210342815, 6532.379423954717, 6544.083828263952, 6546.18172728409, 6563.146790917151, 6303.590266632654, 6446.0975463434215, 6457.3865482779065, 6476.222853257639, 6484.157059582224, 6737.494687898329, 6739.5619284746335, 6747.595144291358, 6752.5948443093575, 6755.966220168868, 4607.539246075366, 4614.907701846011, 4619.445666520039, 4620.745858977789, 4623.214053610962, 6554.770583029571, 6561.0, 6562.50781191403, 6564.540482166202, 6565.244996825235, 6198.504119670325, 6362.204724409449, 6378.90431643535, 6379.457746091449, 6387.233531976192, 6360.618362898241, 6370.948793449029, 6374.458171055512, 6378.521610879296, 6378.776742814165, 6195.473384762346, 6197.783077592263, 6226.782062627967, 6238.532110091852, 6267.62394256346, 6404.71178796946, 6405.679716014274, 6406.167198264196, 6407.167068281094, 6418.069379939976, 6047.48596369296, 6186.288576813544, 6186.597871138361, 6208.937910620836, 6227.844303892439], "unit": "score", "name": "prototype.html", "value": 4853.204803644568}, {"lowerIsBetter": false, "replicates": [831.980823491223, 842.6966292134832, 862.9223369896716, 888.5379602606645, 942.9292803039772, 14456.20490873003, 14523.273836308168, 14674.046186997837, 14694.11835289882, 14699.926500367497, 13785.793213101811, 13925.93037034816, 13954.720905581908, 13955.232462214573, 13959.0, 757.3751654884715, 909.3134683314122, 919.6827094652334, 938.6198589571235, 942.9575669094872, 927.837628415028, 933.4212788071405, 937.0, 937.5827756648295, 938.4463166731626, 956.5408603870146, 959.9616015359377, 961.1925982174971, 962.3600305796637, 962.8026254617787, 802.1617409806765, 957.2150836314225, 959.4435227568028, 969.60730903984, 980.764616492044, 714.6819665248967, 721.5598484924192, 724.0731863215093, 725.5320318394658, 726.3535453446436, 13988.720225595533, 14082.366293516816, 14085.577432677037, 14089.85910140906, 14101.942354323364, 13871.237081960488, 14736.189509576969, 14769.113853168845, 14850.702985940221, 14875.181864997421, 11740.88259117415, 11769.764604707943, 11881.881181188164, 11929.403529823561, 11968.222065565797, 3975.741576797499, 3980.7810570418615, 3987.0, 3990.880273591797, 4063.3092374296143, 50463.74768126136, 50698.0, 50767.74616126933, 51052.48947510515, 51089.74455127738, 10567.15462762977, 10928.945355273172, 11373.366017134122, 11515.884841151648, 11745.647630571097, 20896.37310880676, 20921.0, 20934.16263349449, 20945.37163885086, 20965.056572454276, 7995.960020199978, 8091.150429204967, 8178.959105204436, 8214.644583643632, 8402.579871006548, 4207.200631879933, 4350.869473915787, 4391.560843915583, 4428.269335559661, 4498.302763071663, 3433.656634336546, 3450.6204317525053, 3464.168599536093, 3468.2196505785996, 3468.959312206328, 563.8984982703153, 619.8264485943943, 623.7068577768441, 642.2678146912524, 642.3415998601471, 545.4490964126261, 596.83885350955, 610.6946526736632, 693.5630552751835, 695.5027155583681, 8178.550179740052, 8206.0, 8410.32717382608, 8462.61918213682, 8510.36172287081, 602.7860109661007, 606.2482521673094, 620.0606081786098, 623.9282482514478, 627.5356236385043, 3780.9432858507143, 3895.8052097395016, 4011.839526418969, 4127.4015267786, 4192.287311157111, 55581.72209138928, 60075.62783975571, 60700.69649651812, 60971.0, 61146.694266528386, 51436.0, 51514.0, 51858.0, 52241.0, 53262.46737532575, 48272.27591586129, 48443.27335089976, 48465.5153448461, 48901.266481002815, 49116.263256051185, 7878.448508604342, 8113.1886811320755, 8123.837523249384, 8413.663453462037, 8471.534065626449, 35575.46636800502, 36114.27771444609, 36193.0, 36684.81657591695, 37217.6278237225, 42776.35835462533, 43569.0, 44225.33661995008, 44353.55646443494, 45655.543444565126, 10049.447280399649, 10055.798884022424, 10072.446015469219, 10167.237457190888, 10194.337368071052, 10984.670459886216, 11051.557937682403, 11119.83320250213, 11356.148288878201, 11379.203455758017, 9345.719628411158, 10071.34536255141, 11488.138389620979, 11698.18658662426, 11806.173567850512, 11251.662450126509, 11452.656420307405, 11458.598949036743, 11493.82759258595, 11539.307641541534, 11195.776084478102, 11367.204295699552, 11367.602133925604, 11529.250598711056, 11703.473343699383, 9415.576299066695, 9519.904800951901, 9574.186194173295, 9673.854892176763, 10093.949530252301, 9694.321397502106, 9766.218702503924, 9859.654912078044, 9941.453220072965, 9983.251256155672], "unit": "score", "name": "yui.html", "value": 6611.88575336319}], "name": "dromaeo_css", "value": 7252.615573796066}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 110.0, 111.0, 99.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 155.0, 174.0, 129.0, 160.0, 158.0, 131.0, 176.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 163.0, 161.0, 163.0, 160.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 166.0, 76.0, 77.0, 76.0, 75.0, 165.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 92.0, 93.0, 94.0, 150.0, 94.0, 94.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 54.0, 54.0, 54.0, 56.0, 55.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 74.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 78.0, 85.0, 78.0, 78.0, 78.0, 79.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [112.0, 127.0, 128.0, 117.0, 118.0, 114.0, 113.0, 118.0, 121.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [149.0, 144.0, 145.0, 143.0, 144.0, 134.0, 150.0, 144.0, 144.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1511.1000000000001}]} 09:19:03 INFO - Return code: 0 09:19:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:19:03 INFO - # TBPL SUCCESS # 09:19:03 INFO - Running post-action listener: _resource_record_post_action 09:19:03 INFO - Running post-run listener: _resource_record_post_run 09:19:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 286720; Write bytes: 498769920; Read time: 480; Write time: 631664 09:19:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 244961280; Read time: 240; Write time: 471700 09:19:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 282624; Write bytes: 253698048; Read time: 240; Write time: 159912 09:19:04 INFO - Running post-run listener: _upload_blobber_files 09:19:04 INFO - Blob upload gear active. 09:19:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:04 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 09:19:04 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:19:04 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:19:04 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:05 INFO - (blobuploader) - INFO - Done attempting. 09:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:06 INFO - (blobuploader) - INFO - Done attempting. 09:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:06 INFO - Return code: 0 09:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d85fd06f2cfa5f117fe18f827294c66eecdbf3f49eead3e1336cbfaa0e023ec40b35d5534e4fa1a64ecfa1b9a5467bc680801284d8044637e1953bf617d56e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62a4841d9a814507e2978129cce398b2c5228a6cee99baf55579b4a7f6a9877e33706382147a470d48347494a66d89fc3f781678e8bd35e45cb91ff2f123b73"} 09:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:06 INFO - Contents: 09:19:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d85fd06f2cfa5f117fe18f827294c66eecdbf3f49eead3e1336cbfaa0e023ec40b35d5534e4fa1a64ecfa1b9a5467bc680801284d8044637e1953bf617d56e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62a4841d9a814507e2978129cce398b2c5228a6cee99baf55579b4a7f6a9877e33706382147a470d48347494a66d89fc3f781678e8bd35e45cb91ff2f123b73"} 09:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:06 INFO - Copying logs to upload dir... 09:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.104290 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-15 09:19:06.071807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 09:19:06.075567) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222 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-Aurora/sha512/5d85fd06f2cfa5f117fe18f827294c66eecdbf3f49eead3e1336cbfaa0e023ec40b35d5534e4fa1a64ecfa1b9a5467bc680801284d8044637e1953bf617d56e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62a4841d9a814507e2978129cce398b2c5228a6cee99baf55579b4a7f6a9877e33706382147a470d48347494a66d89fc3f781678e8bd35e45cb91ff2f123b73"} build_url:https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/XsbQmabVQTqYi-EcHMBFPQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d85fd06f2cfa5f117fe18f827294c66eecdbf3f49eead3e1336cbfaa0e023ec40b35d5534e4fa1a64ecfa1b9a5467bc680801284d8044637e1953bf617d56e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62a4841d9a814507e2978129cce398b2c5228a6cee99baf55579b4a7f6a9877e33706382147a470d48347494a66d89fc3f781678e8bd35e45cb91ff2f123b73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 09:19:06.101239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 09:19:06.101816) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460735474.61885-167026222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 09:19:06.184463) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 09:19:06.184844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 09:19:06.185209) ========= ========= Total master_lag: 0.15 =========