builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1460653582.99 results: success (0) buildid: 20160414073407 builduid: c9f72b920385416abc265e79f04f32cb revision: a9cfac4ce926828806b6fa4247c10d113866b9ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:22.986258) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:22.986711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:22.986983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.004519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.004911) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 10:06:23-- 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% 46.7M=0s 2016-04-14 10:06:24 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.110524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.110828) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.160361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.160751) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a9cfac4ce926828806b6fa4247c10d113866b9ac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a9cfac4ce926828806b6fa4247c10d113866b9ac --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=d6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 10:06:24,146 truncating revision to first 12 chars 2016-04-14 10:06:24,146 Setting DEBUG logging. 2016-04-14 10:06:24,146 attempt 1/10 2016-04-14 10:06:24,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a9cfac4ce926?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 10:06:24,520 unpacking tar archive at: mozilla-inbound-a9cfac4ce926/testing/mozharness/ program finished with exit code 0 elapsedTime=0.766387 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.940240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.940564) ========= script_repo_revision: a9cfac4ce926828806b6fa4247c10d113866b9ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.940967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.941256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 10:06:23.951231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-14 10:06:23.951664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:25 INFO - MultiFileLogger online at 20160414 10:06:25 in /builds/slave/test 10:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:25 INFO - {'append_to_log': False, 10:06:25 INFO - 'base_work_dir': '/builds/slave/test', 10:06:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:25 INFO - 'branch': 'Mozilla-Inbound', 10:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:25 INFO - 'config_files': ('talos/linux_config.py',), 10:06:25 INFO - 'default_actions': ('clobber', 10:06:25 INFO - 'read-buildbot-config', 10:06:25 INFO - 'download-and-extract', 10:06:25 INFO - 'populate-webroot', 10:06:25 INFO - 'create-virtualenv', 10:06:25 INFO - 'install', 10:06:25 INFO - 'run-tests'), 10:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:25 INFO - 'download_minidump_stackwalk': True, 10:06:25 INFO - 'download_symbols': 'ondemand', 10:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:25 INFO - 'installer_path': 'installer.exe', 10:06:25 INFO - 'log_level': 'info', 10:06:25 INFO - 'log_name': 'talos', 10:06:25 INFO - 'log_to_console': True, 10:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:25 INFO - 'opt_config_files': (), 10:06:25 INFO - 'pip_index': False, 10:06:25 INFO - 'sps_profile': False, 10:06:25 INFO - 'sps_profile_interval': 0, 10:06:25 INFO - 'suite': 'dromaeojs', 10:06:25 INFO - 'system_bits': '32', 10:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:25 INFO - 'title': 'talos-linux64-ix-034', 10:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:25 INFO - 'use_talos_json': True, 10:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:25 INFO - 'work_dir': 'build'} 10:06:25 INFO - ##### 10:06:25 INFO - ##### Running clobber step. 10:06:25 INFO - ##### 10:06:25 INFO - Running pre-action listener: _resource_record_pre_action 10:06:25 INFO - Running main action method: clobber 10:06:25 INFO - rmtree: /builds/slave/test/build 10:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:25 INFO - Running post-action listener: _resource_record_post_action 10:06:25 INFO - ##### 10:06:25 INFO - ##### Running read-buildbot-config step. 10:06:25 INFO - ##### 10:06:25 INFO - Running pre-action listener: _resource_record_pre_action 10:06:25 INFO - Running main action method: read_buildbot_config 10:06:25 INFO - Using buildbot properties: 10:06:25 INFO - { 10:06:25 INFO - "project": "", 10:06:25 INFO - "product": "firefox", 10:06:25 INFO - "script_repo_revision": "production", 10:06:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:06:25 INFO - "repository": "", 10:06:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:06:25 INFO - "buildid": "20160414073407", 10:06:25 INFO - "pgo_build": "True", 10:06:25 INFO - "basedir": "/builds/slave/test", 10:06:25 INFO - "buildnumber": 873, 10:06:25 INFO - "slavename": "talos-linux64-ix-034", 10:06:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:06:25 INFO - "platform": "ubuntu64_hw", 10:06:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:06:25 INFO - "branch": "mozilla-inbound", 10:06:25 INFO - "repo_path": "integration/mozilla-inbound", 10:06:25 INFO - "revision": "a9cfac4ce926828806b6fa4247c10d113866b9ac", 10:06:25 INFO - "stage_platform": "linux64-pgo", 10:06:25 INFO - "builduid": "c9f72b920385416abc265e79f04f32cb", 10:06:25 INFO - "slavebuilddir": "test" 10:06:25 INFO - } 10:06:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:06:25 INFO - Running post-action listener: _resource_record_post_action 10:06:25 INFO - ##### 10:06:25 INFO - ##### Running download-and-extract step. 10:06:25 INFO - ##### 10:06:25 INFO - Running pre-action listener: _resource_record_pre_action 10:06:25 INFO - Running main action method: download_and_extract 10:06:25 INFO - mkdir: /builds/slave/test/build/tests 10:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:25 INFO - https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:06:27 INFO - Downloaded 1361 bytes. 10:06:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:27 INFO - Using the following test package requirements: 10:06:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:06:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'jsshell-linux-x86_64.zip'], 10:06:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:06:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:06:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06: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')]} 10:06:27 INFO - https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:36 INFO - Downloaded 23775384 bytes. 10:06:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:37 INFO - Return code: 0 10:06:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:37 INFO - https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:38 INFO - Downloaded 23775384 bytes. 10:06:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:40 INFO - Return code: 0 10:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:40 INFO - https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:06:41 INFO - Downloaded 10841076 bytes. 10:06:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:06:41 INFO - Return code: 0 10:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:41 INFO - https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:06:42 INFO - Downloaded 58152562 bytes. 10:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:42 INFO - mkdir: /builds/slave/test/properties 10:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:42 INFO - Contents: 10:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:43 INFO - Running post-action listener: _resource_record_post_action 10:06:43 INFO - Running post-action listener: set_extra_try_arguments 10:06:43 INFO - ##### 10:06:43 INFO - ##### Running populate-webroot step. 10:06:43 INFO - ##### 10:06:43 INFO - Running pre-action listener: _resource_record_pre_action 10:06:43 INFO - Running main action method: populate_webroot 10:06:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:43 INFO - '--tppagecycles', 10:06:43 INFO - '7'], 10:06:43 INFO - 'tests': ['tsvgm']}}, 10:06:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['damp', 'tps']}, 10:06:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'tests': ['damp', 'tps']}, 10:06:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['dromaeo_dom']}, 10:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tsvgx', 10:06:43 INFO - 'tsvgr_opacity', 10:06:43 INFO - 'tart', 10:06:43 INFO - 'tscrollx', 10:06:43 INFO - 'cart']}, 10:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:43 INFO - 'tsvgr_opacity', 10:06:43 INFO - 'tart', 10:06:43 INFO - 'tscrollx', 10:06:43 INFO - 'cart']}, 10:06:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tp5o']}, 10:06:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'tests': ['tp5o']}, 10:06:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s', 10:06:43 INFO - '--xperf_path', 10:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:43 INFO - 'tests': ['tp5n']}, 10:06:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--xperf_path', 10:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:43 INFO - 'tests': ['tp5n']}}, 10:06:43 INFO - 'talos.zip': {'path': '', 10:06:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:43 INFO - Running post-action listener: _resource_record_post_action 10:06:43 INFO - ##### 10:06:43 INFO - ##### Running create-virtualenv step. 10:06:43 INFO - ##### 10:06:43 INFO - Running pre-action listener: _resource_record_pre_action 10:06:43 INFO - Running main action method: create_virtualenv 10:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:06:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:43 INFO - Using real prefix '/usr' 10:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:46 INFO - Installing pip.................done. 10:06:46 INFO - Return code: 0 10:06:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:46 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:06:46 INFO - Using env: {'DISPLAY': ':0', 10:06:46 INFO - 'HOME': '/home/cltbld', 10:06:46 INFO - 'LANG': 'en_US.UTF-8', 10:06:46 INFO - 'LANGUAGE': 'en_US:en', 10:06:46 INFO - 'LOGNAME': 'cltbld', 10:06:46 INFO - 'MAIL': '/var/mail/cltbld', 10:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:46 INFO - 'MOZ_NO_REMOTE': '1', 10:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:46 INFO - 'NO_EM_RESTART': '1', 10:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:46 INFO - 'PWD': '/builds/slave/test', 10:06:46 INFO - 'SHELL': '/bin/bash', 10:06:46 INFO - 'SHLVL': '1', 10:06:46 INFO - 'TERM': 'linux', 10:06:46 INFO - 'TMOUT': '86400', 10:06:46 INFO - 'USER': 'cltbld', 10:06:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:46 INFO - '_': '/tools/buildbot/bin/python'} 10:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:06:46 INFO - Cleaning up... 10:06:46 INFO - Return code: 0 10:06:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:46 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:06:46 INFO - Using env: {'DISPLAY': ':0', 10:06:46 INFO - 'HOME': '/home/cltbld', 10:06:46 INFO - 'LANG': 'en_US.UTF-8', 10:06:46 INFO - 'LANGUAGE': 'en_US:en', 10:06:46 INFO - 'LOGNAME': 'cltbld', 10:06:46 INFO - 'MAIL': '/var/mail/cltbld', 10:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:46 INFO - 'MOZ_NO_REMOTE': '1', 10:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:46 INFO - 'NO_EM_RESTART': '1', 10:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:46 INFO - 'PWD': '/builds/slave/test', 10:06:46 INFO - 'SHELL': '/bin/bash', 10:06:46 INFO - 'SHLVL': '1', 10:06:46 INFO - 'TERM': 'linux', 10:06:46 INFO - 'TMOUT': '86400', 10:06:46 INFO - 'USER': 'cltbld', 10:06:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:46 INFO - '_': '/tools/buildbot/bin/python'} 10:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:46 INFO - Downloading/unpacking psutil>=0.7.1 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:48 INFO - Installing collected packages: psutil 10:06:48 INFO - Running setup.py install for psutil 10:06:48 INFO - building 'psutil._psutil_linux' extension 10:06:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:06:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:06:48 INFO - building 'psutil._psutil_posix' extension 10:06:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:06:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:48 INFO - Successfully installed psutil 10:06:48 INFO - Cleaning up... 10:06:49 INFO - Return code: 0 10:06:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:49 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:06:49 INFO - Using env: {'DISPLAY': ':0', 10:06:49 INFO - 'HOME': '/home/cltbld', 10:06:49 INFO - 'LANG': 'en_US.UTF-8', 10:06:49 INFO - 'LANGUAGE': 'en_US:en', 10:06:49 INFO - 'LOGNAME': 'cltbld', 10:06:49 INFO - 'MAIL': '/var/mail/cltbld', 10:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:49 INFO - 'MOZ_NO_REMOTE': '1', 10:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:49 INFO - 'NO_EM_RESTART': '1', 10:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:49 INFO - 'PWD': '/builds/slave/test', 10:06:49 INFO - 'SHELL': '/bin/bash', 10:06:49 INFO - 'SHLVL': '1', 10:06:49 INFO - 'TERM': 'linux', 10:06:49 INFO - 'TMOUT': '86400', 10:06:49 INFO - 'USER': 'cltbld', 10:06:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:49 INFO - '_': '/tools/buildbot/bin/python'} 10:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:06:51 INFO - Installing collected packages: mozsystemmonitor 10:06:51 INFO - Running setup.py install for mozsystemmonitor 10:06:51 INFO - Successfully installed mozsystemmonitor 10:06:51 INFO - Cleaning up... 10:06:51 INFO - Return code: 0 10:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:06:51 INFO - Using env: {'DISPLAY': ':0', 10:06:51 INFO - 'HOME': '/home/cltbld', 10:06:51 INFO - 'LANG': 'en_US.UTF-8', 10:06:51 INFO - 'LANGUAGE': 'en_US:en', 10:06:51 INFO - 'LOGNAME': 'cltbld', 10:06:51 INFO - 'MAIL': '/var/mail/cltbld', 10:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:51 INFO - 'MOZ_NO_REMOTE': '1', 10:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:51 INFO - 'NO_EM_RESTART': '1', 10:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:51 INFO - 'PWD': '/builds/slave/test', 10:06:51 INFO - 'SHELL': '/bin/bash', 10:06:51 INFO - 'SHLVL': '1', 10:06:51 INFO - 'TERM': 'linux', 10:06:51 INFO - 'TMOUT': '86400', 10:06:51 INFO - 'USER': 'cltbld', 10:06:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:51 INFO - '_': '/tools/buildbot/bin/python'} 10:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:54 INFO - Downloading docopt-0.6.1.tar.gz 10:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:54 INFO - Running setup.py install for blobuploader 10:06:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:54 INFO - Running setup.py install for requests 10:06:54 INFO - Running setup.py install for docopt 10:06:54 INFO - Successfully installed blobuploader requests docopt 10:06:54 INFO - Cleaning up... 10:06:54 INFO - Return code: 0 10:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:54 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:54 INFO - Using env: {'DISPLAY': ':0', 10:06:54 INFO - 'HOME': '/home/cltbld', 10:06:54 INFO - 'LANG': 'en_US.UTF-8', 10:06:54 INFO - 'LANGUAGE': 'en_US:en', 10:06:54 INFO - 'LOGNAME': 'cltbld', 10:06:54 INFO - 'MAIL': '/var/mail/cltbld', 10:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:54 INFO - 'MOZ_NO_REMOTE': '1', 10:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:54 INFO - 'NO_EM_RESTART': '1', 10:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:54 INFO - 'PWD': '/builds/slave/test', 10:06:54 INFO - 'SHELL': '/bin/bash', 10:06:54 INFO - 'SHLVL': '1', 10:06:54 INFO - 'TERM': 'linux', 10:06:54 INFO - 'TMOUT': '86400', 10:06:54 INFO - 'USER': 'cltbld', 10:06:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:54 INFO - '_': '/tools/buildbot/bin/python'} 10:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:54 INFO - Running setup.py (path:/tmp/pip-F6S66b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:54 INFO - Running setup.py (path:/tmp/pip-NOR098-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:55 INFO - Running setup.py (path:/tmp/pip-zf9qMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:55 INFO - Running setup.py (path:/tmp/pip-rztEvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:55 INFO - Running setup.py (path:/tmp/pip-stU7ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:55 INFO - Running setup.py (path:/tmp/pip-q8uXXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:55 INFO - Running setup.py (path:/tmp/pip-PHH_Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:55 INFO - Running setup.py (path:/tmp/pip-LtCM5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:55 INFO - Running setup.py (path:/tmp/pip-Pgdp9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:55 INFO - Running setup.py (path:/tmp/pip-MiwUcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:55 INFO - Running setup.py (path:/tmp/pip-WNXzqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:55 INFO - Running setup.py (path:/tmp/pip-_TGpsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:55 INFO - Running setup.py (path:/tmp/pip-MN_bev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:55 INFO - Running setup.py (path:/tmp/pip-AnkUFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:55 INFO - Running setup.py (path:/tmp/pip-d6IlHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:55 INFO - Running setup.py (path:/tmp/pip-_c18p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:56 INFO - Running setup.py (path:/tmp/pip-Hr1BGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:56 INFO - Running setup.py install for manifestparser 10:06:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozcrash 10:06:56 INFO - Running setup.py install for mozdebug 10:06:56 INFO - Running setup.py install for mozdevice 10:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozfile 10:06:56 INFO - Running setup.py install for mozhttpd 10:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozinfo 10:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozInstall 10:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozleak 10:06:57 INFO - Running setup.py install for mozlog 10:06:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for moznetwork 10:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozprocess 10:06:57 INFO - Running setup.py install for mozprofile 10:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozrunner 10:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozscreenshot 10:06:57 INFO - Running setup.py install for moztest 10:06:57 INFO - Running setup.py install for mozversion 10:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:57 INFO - Cleaning up... 10:06:57 INFO - Return code: 0 10:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:57 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:57 INFO - Using env: {'DISPLAY': ':0', 10:06:57 INFO - 'HOME': '/home/cltbld', 10:06:57 INFO - 'LANG': 'en_US.UTF-8', 10:06:57 INFO - 'LANGUAGE': 'en_US:en', 10:06:57 INFO - 'LOGNAME': 'cltbld', 10:06:57 INFO - 'MAIL': '/var/mail/cltbld', 10:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:57 INFO - 'MOZ_NO_REMOTE': '1', 10:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:57 INFO - 'NO_EM_RESTART': '1', 10:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:57 INFO - 'PWD': '/builds/slave/test', 10:06:57 INFO - 'SHELL': '/bin/bash', 10:06:57 INFO - 'SHLVL': '1', 10:06:57 INFO - 'TERM': 'linux', 10:06:57 INFO - 'TMOUT': '86400', 10:06:57 INFO - 'USER': 'cltbld', 10:06:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:57 INFO - '_': '/tools/buildbot/bin/python'} 10:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:58 INFO - Running setup.py (path:/tmp/pip-AJg9GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:58 INFO - Running setup.py (path:/tmp/pip-NB5yuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:58 INFO - Running setup.py (path:/tmp/pip-SQn8Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:58 INFO - Running setup.py (path:/tmp/pip-0sV2IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:58 INFO - Running setup.py (path:/tmp/pip-jg7kdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:58 INFO - Running setup.py (path:/tmp/pip-CScdMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:58 INFO - Running setup.py (path:/tmp/pip-0i55ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:58 INFO - Running setup.py (path:/tmp/pip-QaeyO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:58 INFO - Running setup.py (path:/tmp/pip-leRRC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:58 INFO - Running setup.py (path:/tmp/pip-SpvN_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:58 INFO - Running setup.py (path:/tmp/pip-uIGne8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:58 INFO - Running setup.py (path:/tmp/pip-24LDkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:59 INFO - Running setup.py (path:/tmp/pip-YeAo6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:59 INFO - Running setup.py (path:/tmp/pip-uFyZA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:59 INFO - Running setup.py (path:/tmp/pip-gkfSUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:59 INFO - Running setup.py (path:/tmp/pip-o_BrOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:59 INFO - Running setup.py (path:/tmp/pip-E6cDKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:01 INFO - Downloading blessings-1.6.tar.gz 10:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:01 INFO - Installing collected packages: blessings 10:07:01 INFO - Running setup.py install for blessings 10:07:01 INFO - Successfully installed blessings 10:07:01 INFO - Cleaning up... 10:07:01 INFO - Return code: 0 10:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:01 INFO - Reading from file tmpfile_stdout 10:07:01 INFO - Current package versions: 10:07:01 INFO - argparse == 1.2.1 10:07:01 INFO - blessings == 1.6 10:07:01 INFO - blobuploader == 1.2.4 10:07:01 INFO - docopt == 0.6.1 10:07:01 INFO - manifestparser == 1.1 10:07:01 INFO - mozInstall == 1.12 10:07:01 INFO - mozcrash == 0.17 10:07:01 INFO - mozdebug == 0.1 10:07:01 INFO - mozdevice == 0.48 10:07:01 INFO - mozfile == 1.2 10:07:01 INFO - mozhttpd == 0.7 10:07:01 INFO - mozinfo == 0.9 10:07:01 INFO - mozleak == 0.1 10:07:01 INFO - mozlog == 3.1 10:07:01 INFO - moznetwork == 0.27 10:07:01 INFO - mozprocess == 0.22 10:07:01 INFO - mozprofile == 0.28 10:07:01 INFO - mozrunner == 6.11 10:07:01 INFO - mozscreenshot == 0.1 10:07:01 INFO - mozsystemmonitor == 0.0 10:07:01 INFO - moztest == 0.7 10:07:01 INFO - mozversion == 1.4 10:07:01 INFO - psutil == 3.1.1 10:07:01 INFO - requests == 1.2.3 10:07:01 INFO - wsgiref == 0.1.2 10:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:07:01 INFO - Using env: {'DISPLAY': ':0', 10:07:01 INFO - 'HOME': '/home/cltbld', 10:07:01 INFO - 'LANG': 'en_US.UTF-8', 10:07:01 INFO - 'LANGUAGE': 'en_US:en', 10:07:01 INFO - 'LOGNAME': 'cltbld', 10:07:01 INFO - 'MAIL': '/var/mail/cltbld', 10:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:01 INFO - 'MOZ_NO_REMOTE': '1', 10:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:01 INFO - 'NO_EM_RESTART': '1', 10:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:01 INFO - 'PWD': '/builds/slave/test', 10:07:01 INFO - 'SHELL': '/bin/bash', 10:07:01 INFO - 'SHLVL': '1', 10:07:01 INFO - 'TERM': 'linux', 10:07:01 INFO - 'TMOUT': '86400', 10:07:01 INFO - 'USER': 'cltbld', 10:07:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:01 INFO - '_': '/tools/buildbot/bin/python'} 10:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:07:01 INFO - Cleaning up... 10:07:01 INFO - Return code: 0 10:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:07:01 INFO - Using env: {'DISPLAY': ':0', 10:07:01 INFO - 'HOME': '/home/cltbld', 10:07:01 INFO - 'LANG': 'en_US.UTF-8', 10:07:01 INFO - 'LANGUAGE': 'en_US:en', 10:07:01 INFO - 'LOGNAME': 'cltbld', 10:07:01 INFO - 'MAIL': '/var/mail/cltbld', 10:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:01 INFO - 'MOZ_NO_REMOTE': '1', 10:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:01 INFO - 'NO_EM_RESTART': '1', 10:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:01 INFO - 'PWD': '/builds/slave/test', 10:07:01 INFO - 'SHELL': '/bin/bash', 10:07:01 INFO - 'SHLVL': '1', 10:07:01 INFO - 'TERM': 'linux', 10:07:01 INFO - 'TMOUT': '86400', 10:07:01 INFO - 'USER': 'cltbld', 10:07:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:01 INFO - '_': '/tools/buildbot/bin/python'} 10:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:02 INFO - Downloading/unpacking jsonschema 10:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:04 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:04 INFO - warning: no files found matching '*.txt' 10:07:04 INFO - no previously-included directories found matching 'build' 10:07:04 INFO - no previously-included directories found matching 'dist' 10:07:04 INFO - no previously-included directories found matching '.git*' 10:07:04 INFO - Installing collected packages: jsonschema, functools32 10:07:04 INFO - Running setup.py install for functools32 10:07:04 INFO - warning: no files found matching '*.txt' 10:07:04 INFO - no previously-included directories found matching 'build' 10:07:04 INFO - no previously-included directories found matching 'dist' 10:07:04 INFO - no previously-included directories found matching '.git*' 10:07:04 INFO - Successfully installed jsonschema functools32 10:07:04 INFO - Cleaning up... 10:07:04 INFO - Return code: 0 10:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:04 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 0x7fa48c81af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:07:04 INFO - Using env: {'DISPLAY': ':0', 10:07:04 INFO - 'HOME': '/home/cltbld', 10:07:04 INFO - 'LANG': 'en_US.UTF-8', 10:07:04 INFO - 'LANGUAGE': 'en_US:en', 10:07:04 INFO - 'LOGNAME': 'cltbld', 10:07:04 INFO - 'MAIL': '/var/mail/cltbld', 10:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:04 INFO - 'MOZ_NO_REMOTE': '1', 10:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:04 INFO - 'NO_EM_RESTART': '1', 10:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:04 INFO - 'PWD': '/builds/slave/test', 10:07:04 INFO - 'SHELL': '/bin/bash', 10:07:04 INFO - 'SHLVL': '1', 10:07:04 INFO - 'TERM': 'linux', 10:07:04 INFO - 'TMOUT': '86400', 10:07:04 INFO - 'USER': 'cltbld', 10:07:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:04 INFO - '_': '/tools/buildbot/bin/python'} 10:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:04 INFO - Downloading/unpacking flake8 10:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:07 INFO - no previously-included directories found matching 'docs/_build' 10:07:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:07 INFO - Running setup.py install for pep8 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:07 INFO - no previously-included directories found matching 'docs/_build' 10:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:07 INFO - Cleaning up... 10:07:07 INFO - Return code: 0 10:07:07 INFO - Running post-action listener: _resource_record_post_action 10:07:07 INFO - Running post-action listener: _start_resource_monitoring 10:07:07 INFO - Starting resource monitoring. 10:07:07 INFO - ##### 10:07:07 INFO - ##### Running install step. 10:07:07 INFO - ##### 10:07:07 INFO - Running pre-action listener: _resource_record_pre_action 10:07:07 INFO - Running main action method: install 10:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:07 INFO - Reading from file tmpfile_stdout 10:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:07 INFO - Reading from file tmpfile_stdout 10:07:07 INFO - Output received: 10:07:07 INFO - Usage: mozinstall [options] installer 10:07:07 INFO - Options: 10:07:07 INFO - -h, --help show this help message and exit 10:07:07 INFO - -d DEST, --destination=DEST 10:07:07 INFO - Directory to install application into. [default: 10:07:07 INFO - "/builds/slave/test"] 10:07:07 INFO - --app=APP Application being installed. [default: firefox] 10:07:07 INFO - mkdir: /builds/slave/test/build/application 10:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:07:24 INFO - Reading from file tmpfile_stdout 10:07:24 INFO - Output received: 10:07:24 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:24 INFO - Running post-action listener: _resource_record_post_action 10:07:24 INFO - ##### 10:07:24 INFO - ##### Running run-tests step. 10:07:24 INFO - ##### 10:07:24 INFO - Running pre-action listener: _resource_record_pre_action 10:07:24 INFO - Running main action method: run_tests 10:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:24 INFO - Python 2.7.3 10:07:24 INFO - Return code: 0 10:07:24 INFO - grabbing minidump binary from tooltool 10:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:24 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 0x190d640>, '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 0x190e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x190e9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:07:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:07:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:24 INFO - Return code: 0 10:07:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:25 INFO - Return code: 0 10:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:07:25 INFO - Using env: {'DISPLAY': ':0', 10:07:25 INFO - 'HOME': '/home/cltbld', 10:07:25 INFO - 'LANG': 'en_US.UTF-8', 10:07:25 INFO - 'LANGUAGE': 'en_US:en', 10:07:25 INFO - 'LOGNAME': 'cltbld', 10:07:25 INFO - 'MAIL': '/var/mail/cltbld', 10:07:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:25 INFO - 'MOZ_NO_REMOTE': '1', 10:07:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:25 INFO - 'NO_EM_RESTART': '1', 10:07:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:25 INFO - 'PWD': '/builds/slave/test', 10:07:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:25 INFO - 'SHELL': '/bin/bash', 10:07:25 INFO - 'SHLVL': '1', 10:07:25 INFO - 'TERM': 'linux', 10:07:25 INFO - 'TMOUT': '86400', 10:07:25 INFO - 'USER': 'cltbld', 10:07:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626', 10:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:25 INFO - '_': '/tools/buildbot/bin/python'} 10:07:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:07:25 INFO - mozversion application_buildid: 20160414073407 10:07:25 INFO - mozversion application_changeset: a9cfac4ce926828806b6fa4247c10d113866b9ac 10:07:25 INFO - mozversion application_display_name: Nightly 10:07:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:25 INFO - mozversion application_name: Firefox 10:07:25 INFO - mozversion application_remotingname: firefox 10:07:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:07:25 INFO - mozversion application_vendor: Mozilla 10:07:25 INFO - mozversion application_version: 48.0a1 10:07:25 INFO - mozversion platform_buildid: 20160414073407 10:07:25 INFO - mozversion platform_changeset: a9cfac4ce926828806b6fa4247c10d113866b9ac 10:07:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:07:25 INFO - mozversion platform_version: 48.0a1 10:07:25 INFO - using testdate: 1460653645 10:07:25 INFO - actual date: 1460653645 10:07:25 INFO - starting webserver on 'localhost:41489' 10:07:25 INFO - SUITE-START | Running 2 tests 10:07:25 INFO - TEST-START | dromaeo_css 10:07:25 INFO - operating with platform_type : linux_ 10:07:25 INFO - Initialising browser for dromaeo_css test... 10:07:25 INFO - TEST-INFO | started process 16273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsj4hl/profile http://localhost:41489/getInfo.html) 10:07:29 INFO - PROCESS | 16273 | __metrics Screen width/height:1600/1200 10:07:29 INFO - PROCESS | 16273 | colorDepth:24 10:07:29 INFO - PROCESS | 16273 | Browser inner width/height: 1024/697 10:07:29 INFO - PROCESS | 16273 | __metrics 10:07:30 ERROR - PROCESS | 16273 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:07:31 INFO - TEST-INFO | 16273: exit 0 10:07:31 INFO - Browser initialized. 10:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:31 INFO - TEST-INFO | started process 16359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsj4hl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:43 INFO - PROCESS | 16359 | RSS: Main: 152018944 10:07:43 INFO - PROCESS | 16359 | 10:08:34 INFO - PROCESS | 16359 | 1460653714095 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:10:41 INFO - PROCESS | 16359 | Cycle 1(1): loaded http://localhost:41489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41489/tests/dromaeo/cssquery-ext.html) 10:10:42 INFO - PROCESS | 16359 | RSS: Main: 252649472 10:10:42 INFO - PROCESS | 16359 | 10:13:44 INFO - PROCESS | 16359 | Cycle 1(1): loaded http://localhost:41489/tests/dromaeo/cssquery-ext.html (next: http://localhost:41489/tests/dromaeo/cssquery-jquery.html) 10:13:45 INFO - PROCESS | 16359 | RSS: Main: 242171904 10:13:45 INFO - PROCESS | 16359 | 10:16:47 INFO - PROCESS | 16359 | Cycle 1(1): loaded http://localhost:41489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41489/tests/dromaeo/cssquery-mootools.html) 10:16:48 INFO - PROCESS | 16359 | RSS: Main: 234303488 10:16:48 INFO - PROCESS | 16359 | 10:19:50 INFO - PROCESS | 16359 | Cycle 1(1): loaded http://localhost:41489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41489/tests/dromaeo/cssquery-prototype.html) 10:19:50 INFO - PROCESS | 16359 | RSS: Main: 226930688 10:19:50 INFO - PROCESS | 16359 | 10:22:53 INFO - PROCESS | 16359 | Cycle 1(1): loaded http://localhost:41489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41489/tests/dromaeo/cssquery-yui.html) 10:22:53 INFO - PROCESS | 16359 | RSS: Main: 217432064 10:22:53 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | Cycle 1(1): loaded http://localhost:41489/tests/dromaeo/cssquery-yui.html (next: http://localhost:41489/tests/dromaeo/cssquery-dojo.html) 10:25:56 INFO - PROCESS | 16359 | RSS: Main: 257806336 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | __start_tp_report 10:25:56 INFO - PROCESS | 16359 | _x_x_mozilla_page_load 10:25:56 INFO - PROCESS | 16359 | _x_x_mozilla_page_load_details 10:25:56 INFO - PROCESS | 16359 | |i|pagename|runs| 10:25:56 INFO - PROCESS | 16359 | |0;dojo.html;3053.221428535723;3103.34829685766;3146.669599692034;3149.10250578585;3173.98413007935;5242.737863106839;5310.336207973998;5328.49379308966;5341.839744807658;5409.621326507141;5319.760610772515;5357.223202635615;5363.785448582052;5445.401005889349;5452.2094296327;4792.976035119819;4811.350467686852;4940.184869496528;4990.850274491771;5022.995400919831;4924.162892308298;4963.925541116868;4970.627202959774;4986.152354099793;4990.500949905017;4839.225723884179;4862.319275301443;4893.437254715717;4924.039812236615;4958.87602809929;4845.951540484585;4860.538248866352;4860.7326597037145;4875.731834749087;4910.582600478963;4808.447028591721;4845.345878306419;4854.635902307341;4862.124817532843;4877.365942427497;5190.480951904817;5293.814716484943;5351.973240133813;5377.139657654757;5384.165454354581;5618.91571626426;5620.297462817148;5630.831075067755;5644.379118296984;5647.29408823897;5658.12299093637;5674.829755107354;5679.148127780824;5680.034394153004;5681.289838770153;5328.6269961102735;5360.142377219626;5371.060064488699;5399.78400863965;5410.513053825135;5911.379305172981;5917.881642367129;5921.61509501881;5923.466887980103;5940.198073260141;5550;5645.802396916089;5665.433456654301;5670.659760414388;5675.233843431167;5728.398518155617;5739.024365857814;5751.827445176651;5761.279840019997;5793.102069179284;5694.572907031989;5704.971475142598;5717.399673034354;5717.799877004285;5718.485336319751;5528.198411230349;5649.661020338793;5721.599488035798;5724.026915424388;5725.799597014085;4252.192083504125;4276.144771045741;4289.24938135825;4300.61294483498;4313.676474264443;3821.2548553032448;3836.731428799957;3850.0759817643566;3858.9421158682644;3889.649931506178;5359.464053594687;5403.756830942617;5473.151661492475;5540.030494663499;5548.69482178484;5671.829845104653;5672.262605861211;5689.345725241567;5691.4877661010705;5693.402192769782;5356.384015838151;5383.569314454834;5383.596230282745;5394.433584473652;5430.104032834538;4857.344258525124;4888.169011268093;4905.705657660552;4949.084419382426;4958.181899986462;5901.321348044944;5917.437843404869;5918.053111502139;5919.67441790697;5925.792597259076;5684.602077854511;5718.142278658234;5723.31320241557;5726.770929162787;5728.312602487728;5906.970465147647;5937.435943585352;5944.346121926671;5987.790427335022;6000.309964353981;5664.745086471201;5665.12190610456;5667.943320566742;5670.971645141913;5674.659520428788;5636.887262254814;5686.9715651421475;5688.914666280092;5744.655320680772;5747.913781293368;5615.298087739033;5617.7191140442;5622.690752008679;5633.126865335879;5672.290963629546;5591.077472217039;5591.329040515164;5597.356304024926;5601.887962240651;5604.047311956896;5433.8369848904595;5462.644928079662;5498.862528436821;5500.312460942382;5591.412901645432;5585;5642.463965923231;5648.943510564842;5663.4053424391495;5687.488126068673;5527.170924361217;5533.3083364579425;5534.05920993424;5535.335759708861;5535.446455354432 10:25:56 INFO - PROCESS | 16359 | |1;ext.html;593.1369856858272;622.37140488107;637.1144109687532;644.3105876711917;658.960462372258;29987.850060749694;30719.84640076802;30775.846120769394;30779.38441231174;30795.07614771555;37035.629643703556;38054.4291835622;38123.61876381235;38194.61805381945;38219.808900955526;8461.87307190391;8616.095309992455;8640.697575584856;8650.956745216265;8653.783655408633;7854.646540905673;8659.740207793777;8788.604512796908;8797.868031979526;10150.949245253763;10126.898731012707;10238.641647542338;10241.231907606922;10253.33353332031;10262.179025677928;10360.430176340298;10538.156947444262;10540.894591054068;10541.209409294333;10543;7624.19945905683;10013.39919604826;10294.845577316346;10319.484025798754;10335.483225838752;35837.46243806345;36321.63678363209;36454.088647783756;36508.0872978175;36536.26927461463;3406.557147570825;3486.511888335635;3511.7892926424497;3583.4266517357096;3954.62431069048;28034.158975230574;28422.431551369064;28572.57129144495;28616.85691571529;28629.57055644167;3625.7461977661574;3637.672609465161;3655.323765103438;3693.298273328059;3704.814759262026;248988;251355;253021;253116;253315;34672.65327346745;35530.82234588862;50544.747276263384;50639;50720.74639626852;34474.65525344764;34519.827400862836;34554.82722586371;34635.307293853984;34650.30699385998;13378.39797209128;13383;13466.730665386638;13526.32368381577;13560.11859229147;11471.25436846619;11544.94227528857;11564.42177891102;11568.479418426023;11575.76848463043;8487.10885357041;8552.059273479912;8557.614907329185;8606.741797746077;8620.52587107715;3291.4075466415798;3293.6212335581713;3305.0415379539663;3327.584051993501;3359.328134373135;1065.6376831877199;1066.6586692258402;1078.1374900080061;1120.1629327902085;1131.4229742831214;31577;32121.357572848414;32614.184645384055;32638.673613263563;32978.3404331912;1056.3081181825917;1095.6220104064084;1121.6410748560545;1126.099120703434;1161.3438407299848;16483.423080192137;17015.23431445588;17185.226664800113;17199.65600687979;17204.1397930103;451452;451603;458037;458179;459121;55749.44250557443;56581;56601;56643.43356566464;56880.43119568834;1158.9072874170047;1249.425264378378;1381.5579014715195;1390.3048475762118;1395.2117053864533;29279;31626;31977.36045279128;32314.83842580772;32663.34673306473;44554.55445445504;45086;45164;45227;45276.54723452855;273465;279909;280204;280878;281295;24804.751952480965;25648.102316418837;26976.865115674296;27438.314042148308;28028.159155225378;41725.37411938884;41745.16509669729;42421;42479.362809557264;42731.786341068095;38564;39098.804505977285;39197.216055679295;39253.41119883147;39359.803200984956;37781.2443751118;37994;38965;39434.80282598684;39518.209635807696;39610.80194599008;40016;40199.3970090443;40299.19401611893;40322.395164071975;33329.33341333208;34398.312033759685;34440.31119377548;34481.482777757854;34520;26982.460350793266;27665.446691066467;27713.168604941882;27861.736654521064;27931.58102628503 10:25:56 INFO - PROCESS | 16359 | |2;jquery.html;384.79798105994365;388.2293647110485;392.23318412503556;393.7259765634611;399.1577770903393;17210.827891721077;17664.381746638872;18207.27170913162;18230.544236394097;18244.54388640283;14409.13545187287;14973.47592834251;16629.251683674232;17618;19029.809701902977;5524.392316845144;5636.746346414421;5665.1502274658715;5673.12066629671;5679.119736440858;5396.487333703292;5636.549076073925;5683.3464151622675;5683.54531637468;5685.488306052454;3853.364194907837;5648.068068768648;6692.899606505906;7050.29497050296;7062.788116356517;7073.717051317993;7121.2878712128895;7171.28287171284;7176.497645164841;7215.891761623579;6816.965915170442;7029.859402811966;7038.6128762918015;7076.893846592306;7082.822929426754;24288.39279018021;25363;25547.872260638764;25800;25897.870510647514;2403.375122468171;2463.064035666453;2639.9604005939927;2900.7534359579463;3338.315645292709;14424.639384015378;15310.540683779505;15389.769153462707;15403.614909627237;15689.607759805982;2112.7992840680113;2176.912923483059;2217.733871935362;2220.5114874727533;2276.4081338852016;69842.65078674625;74923;81132.9999999994;87540.56229718875;92289.53855230748;16835.49493515172;17165.7425138623;17469.301227950993;17551.912240438716;17643.470695879143;31329.373412531622;31396.686033139376;31552.211194720316;31773;31828;9027.50348730826;9273.814523709489;9346.485943273185;9490.810183796286;9503.144716975505;7555.282248186413;7644.044494438195;7649.120351159577;7725.8454830903065;7741.341985931146;8595.484270943638;8608.698695545625;8748.956255218684;8805.16350946659;8814.77963050916;3078.6767389424235;3329.679091090264;3359.882404115844;3439.208981934119;3496.6852983231634;956.1108169402522;991.4844280973854;996.5266498413196;1038.4496217004998;1103.9282446640943;18273.890336838205;18309.992950387856;18457.630847383247;18601.25594976213;18622.53443663892;940.6660635474445;946.2524605561667;958.8657587937695;984.832578461649;1031.2523420520063;10256.230782691327;10388.065074143364;10544.525496352682;10626.521806518725;10730.89269107299;335617;342184;345751;348042;472769;85383.57308213544;92419.53790231005;92595.99999999865;93233;93353;1019.8368261078192;1030.6032177611523;1076.8653918260218;1086.869575650927;1123.213750374741;15443.2278386078;16273.267702953159;16356.67286654284;16564.763756892666;16647.91676041612;33625.66374336225;34424.96725098251;35039.29921401507;35851.28297434089;36524.63475365212;50455.747721261156;51048;51165;52435;53188.73405632947;8417;8672.913270867211;8709;8812.51531165792;8853.51305678194;9450.858237126586;12593.622191334274;13179.802302965272;13309.46762129504;13381.933090334485;11326.150538709466;11363.829542557034;11448.713782155513;11772.764544709229;11987.100967427652;7284.890726639211;8429.747107586782;11167.1066314693;11325.32048077118;11360.727854428982;9590.184834289164;11866.228695134789;11990.580329688419;12290.926509919664;12298.077644176543;8193.262606365455;8421.07368189511;8442.957785211034;8715.259202967818;8822.33832462555;11876.346800926032;11889.881101188877;11898.107641926717;11960.46177922013;12123.75752484963 10:25:56 INFO - PROCESS | 16359 | |3;mootools.html;1309.2537253765358;1497.091208708896;1513.1601960911696;1636.124673299785;1755.6656940725045;7919.604019799016;8187.18128187181;8195.467294625845;8209.589520523965;8212.589370531472;7986.720464783733;8120;8130.471519351238;8134.796630084251;8140.389470789685;2009.4273132157339;2234.731832180141;2282;2305.8501197422197;2312.2600767754325;2161.9567608647817;2164.718586583742;2173.2067795254775;2176.075168053571;2177.031221106608;2170.413988223179;2210.082815631511;2213.634750266212;2216.1246307708525;2219.7891200335944;1936.5739537301772;2166.122720298282;2224.27710993926;2227.9220227291967;2228.699125618037;2158.589867925089;2162.556675881456;2171.3811563704267;2171.739391273057;2217.9778202218095;8084.878726819103;8093.514389136671;8109;8172.305354044914;8186.2632363087605;4880.6095512358925;5018.949810501885;5026.070177017227;5035.169197082477;5122.1804511278015;3382.1713680148273;3387.8306084695914;3447.120984149051;3456.0495863637448;3466.584009918826;1065.5844220753913;1076.7415820203173;1083.8428427877993;1102.614085070227;1120.1430905357408;11314.490847911864;11319.151063670257;11438.656840294721;11454.599089031928;11465.31208127515;4373.890652733643;4450.198964186413;4516.728996260234;4610.170169369479;4639.976800115978;9582.185514231229;9622.13400793918;9622.326437149472;9626.807463850684;9650.95174524137;4632.143053535106;5084.872878178001;5092.770825312869;5109.233614957786;5126.666766660155;4636.397268355092;4714.622830173578;4716.080364328992;4747.406574178228;4761.809527618926;3792.791396473165;3874.9418758718643;3904.8047597620007;3909.257241124177;3971.7418367806;1248.4881198708485;1248.9437975291135;1249.7000719827176;1263.6398626391435;1267.2649863079391;974.7904200596905;995.7809281957958;999.2505620784411;1000.0899181744578;1004.279318277386;5714.485696287354;5792.652440853562;5835.008048631743;5865.794697185664;5924.5852790305125;975.6438899801522;989.7921436498272;998.9400635961865;1022.9795404091876;1024.7438140464883;3881.204353107606;4016.256992456405;4073.9796301018305;4076.7961601919787;4095.5904409558807;9967.252456065824;10346.896531034743;10379.221558383151;10382.844257336146;10440.321379110334;10202.285839991278;10272.743181420376;10286.434246116385;10312.226583006304;10326.690199294033;7412.629368531552;7743.070831500256;7746.070471543563;7905.486143400661;8019.7995050123045;5780.450857168562;5831.096180092092;5839.474447299764;5939.07944268639;5974.761009559569;8950.23922966555;9195.586198620944;9287.814243714953;9319.068093190897;9359.251259899327;9230.169284764403;9458.574364153492;9582.520873956413;9645.565949532429;9662.71011869645;6809.659517024228;7028.683709232994;7164.211936687065;7460.403167746459;7611.467197296136;7810.765677029698;7854.371650268079;7856;7880.05439347282;7897.289243968071;6993.965030174817;7171.067761191011;7237.240089790706;7258.274172582699;7317.085364329459;7023.894641580483;7064.823379415556;7069.893951590833;7171.820704482429;7186.568805871664;6531.412172904462;6622.63575503352;6657.667116644246;6659.766908158192;6664.300248473841;5088.542031217208;5098.1842905135;5121.820736274212;5123.820666276812;5147.433782284021;5089.236614507706;5100.285959965682;5102.69383836971;5115.335006449287;5237.423883372902 10:25:56 INFO - PROCESS | 16359 | |4;prototype.html;303.92553824313046;305.083224909148;310.17493467376767;323.71351354051654;327.16246409192456;5552.833414997546;5605.775768969246;5723.513501352385;5794.217780599623;5808.506276966463;5714.57140714446;5735.397783232763;5752.913706294409;5770.365259821427;5788.073908174693;4402.075564131536;4415.139047885664;4417.359482874981;4426.97786511067;4435.356873253377;4202.831886724527;4324.07032488015;4347.739135651856;4421.828215522889;4424.756638384888;4277.14457108578;4279.87160385189;4282.764447955361;4287.078278170193;4314.395984562164;4294.423345992411;4311.353297005443;4320.978395108035;4321.481422229353;4332.328489084165;3664.303782281358;3750.287445385368;3752.7991042866292;3756.1548651553453;3758.267137908109;5503.642263252876;5507.228987941691;5508.08071721988;5549.972250138764;5581.581381396411;4882.658213925027;4915.778789954461;4930.186519224324;4961.8511444656715;4975.925361119586;5826.854328641775;5898.528117750569;5934.703264836784;5956.255468066492;5980.611260268069;4041.2523683118716;4061.62394998926;4063.085805693725;4084.4894388201474;4086.6730661547303;6218.875622487571;6232.439080482733;6276.121343011982;6279.120923070774;6283;4044.9191016180102;4136.73111247768;4173.4157217989505;4175.5824417558;4183.330667093251;4195;4202.2646036943415;4209.34755112958;4225.260579398593;4229.281022226229;4914.877128071756;4930.9013819723405;4934.358533390637;4941.283513890466;4943.4809345018975;5955.34491205967;6044.939550604526;6085.3306136325855;6087.482563982023;6120.755169793248;1463.8023866777849;1482.2588705647177;1483.3992233145593;1485.1979930837442;1489.6648254142947;953.6526742576848;981.4454833019321;990.9950450247702;994.7612572982432;996.1881066930429;5849.327327357323;5855.765769369177;5858.853528661817;5866.384029676908;5873;6227.221597300338;6229.657368844757;6251.249850017936;6256;6264.968675156595;5544.500994910397;5840;5874.089516125007;5912.852178695567;5925.259342582177;3311.9503207451908;3336.5662463880026;3344.816035118092;3350.8994730158133;3357.2446199605383;6285.465735412449;6461.8061458156335;6482.773102941374;6496.870062598816;6525.4453371463005;6296.874062518724;6312.43188113072;6324.659875845874;6329.208848893888;6358.237011558643;6223.688815559204;6490.4807615390655;6513.185851768529;6514;6514.283428822826;6293.276273228637;6302.558820882494;6310.211223597051;6319.905201422074;6326.051092336186;6237.12680224778;6238.968805155945;6248.4688801452385;6252.843678908063;6253.812385628438;6210.5031597473;6299.267701382157;6464.256610489666;6495.935040649722;6525.216973962965;4142.420061191376;4266;4269.124829410026;4271.081717430643;4299.742015479082;6148.661823599566;6165.506759459322;6166.599171053867;6171.043488259327;6199.5970261934635;5881.147233651011;6044.425779550936;6054.848628784315;6056.757729690763;6065.939340606537;5920.555958303231;5985.191999080069;6003.249593800775;6017.308009578955;6039.909401358896;5808.5353171747;5911.763529458945;5938.545056461195;5946.73239704223;5947.494462970696;6015.548833837567;6039.577229593886;6039.818805435844;6047.425494578008;6068.666223357758;5864.853378665567;5902.321233058082;5915.142304365929;5926.318473375617;5948.70974674762 10:25:56 INFO - PROCESS | 16359 | |5;yui.html;827.1067247372838;842.5110405706818;856.8543347630903;866.3199388480044;868.7958329792498;12778.424970876322;12820.743585128292;12826;12843.871561284373;14195.858041419595;12297.26216427015;12328.630141095759;12377.690557736061;12409.441575129118;12434.564790232344;660.5640277416906;761.2425636491698;771.8996530451034;782.3701919954434;783.017313271843;787.4999375396636;790.8022994251437;790.952542847431;791.145562792186;792.029763539665;825.1171246765963;827.8509868223717;832.3382910586068;835.5404527509845;835.8871552340418;689.3451221339723;807.1283014344494;831.9417640765149;832.9458585192003;832.9750107496785;611.5016261746707;611.6727550760367;612.761023200952;612.9509639228851;613.3467856732566;13120.540781072712;13155.73688526224;13188.934055329757;13241.205527668371;13327.400266987912;12923.15999460032;13299.601011969657;13349.599512014654;13383.464661413533;13518.324083795771;10935.945320273428;10975.231733778639;11003.944980275128;11115.221934464591;11308.321500709984;3712.393867690045;3786.413105968579;3800.8217452589784;3803.5625903020955;3848.7883166425836;52333;52406.737966310306;52516.47483525154;52951.73524132355;53207.999999999614;10162.847557286646;10250.794984100276;10269.127124194378;10354.741131471774;10379.532921018572;18383.080845957647;18586.163622637014;18891.244350225836;18910.52723681919;18915;7784.6886124554385;7791.0650721913735;7931;7988.320992715568;8051.2351326623875;4437.5784300491405;4495.752733599618;4548.931766023512;4572.1312950539295;4622;3224.1778346521955;3319.8838040668943;3324.5013248012992;3330.0675810773023;3349.0790032741193;560.5095541401274;621.4220774679501;626.3673689573563;640.6860638287299;642.6240649220165;635.3455940381415;647.3526473526474;658.6838317607575;680.4114441008492;688.2257460357098;8495.617697203517;8951.41815781972;8968.192862642263;9085.454872707658;9086.273098152133;662.6129566623417;685.396850771328;691.695653912277;707.3704403081261;733.4975541753915;4242.809073591696;4344.218040752632;4353.542877997828;4355.825766969349;4366.454193225847;63219;67211.66394167997;67436.32563674399;67469.32530674728;67604.32395676078;55694;57041;57204.71397642985;57515.13727294094;57620.71189644025;50698.23952640713;51500.48499515032;51735.22397164046;52368.47631523712;52373.47626523686;8025.5987200638565;8272.751817445485;8494.53280069602;8701;8873.04792945551;28229.858850705616;28802.711972880843;29319;29505.11484655464;30530.694693052785;36740.26519469542;37742.24515509729;40966;41965.58034419617;42447.787761060994;10929.453527323762;12039.398030098635;12099.879001209874;12339.876601233873;12433.689157771129;13179.868201317864;13519;13579.660508486972;13651.317434128452;13747.656308592364;12702.110852240254;12802.295873727035;12870.292133932724;12911.612651620466;13150.868491314965;11583.189176757545;11639.825402618799;11650.359230242419;11690.123240756808;11781;12956.740865182832;13100.803487947498;13220.471181152647;13410.731785364043;13780.448782048607;11060.778784424427;11078.944605276922;11128.666140015812;11173.72065698364;11543.4805433754;10949.671509854717;11133.83299250528;11306.94022113867;11343.716407089558;11565.710857228636 10:25:56 INFO - PROCESS | 16359 | __end_tp_report 10:25:56 INFO - PROCESS | 16359 | __start_cc_report 10:25:56 INFO - PROCESS | 16359 | _x_x_mozilla_cycle_collect,837 10:25:56 INFO - PROCESS | 16359 | __end_cc_report 10:25:56 INFO - PROCESS | 16359 | __startTimestamp1460654756555__endTimestamp 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | ------- Summary: start ------- 10:25:56 INFO - PROCESS | 16359 | Number of tests: 6 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | [#0] dojo.html Cycles:165 Average:5317.73 Median:5535.45 stddev:605.22 (10.9%) stddev-sans-first:580.42 10:25:56 INFO - PROCESS | 16359 | Values: 3053.2 3103.3 3146.7 3149.1 3174.0 5242.7 5310.3 5328.5 5341.8 5409.6 5319.8 5357.2 5363.8 5445.4 5452.2 4793.0 4811.4 4940.2 4990.9 5023.0 4924.2 4963.9 4970.6 4986.2 4990.5 4839.2 4862.3 4893.4 4924.0 4958.9 4846.0 4860.5 4860.7 4875.7 4910.6 4808.4 4845.3 4854.6 4862.1 4877.4 5190.5 5293.8 5352.0 5377.1 5384.2 5618.9 5620.3 5630.8 5644.4 5647.3 5658.1 5674.8 5679.1 5680.0 5681.3 5328.6 5360.1 5371.1 5399.8 5410.5 5911.4 5917.9 5921.6 5923.5 5940.2 5550.0 5645.8 5665.4 5670.7 5675.2 5728.4 5739.0 5751.8 5761.3 5793.1 5694.6 5705.0 5717.4 5717.8 5718.5 5528.2 5649.7 5721.6 5724.0 5725.8 4252.2 4276.1 4289.2 4300.6 4313.7 3821.3 3836.7 3850.1 3858.9 3889.6 5359.5 5403.8 5473.2 5540.0 5548.7 5671.8 5672.3 5689.3 5691.5 5693.4 5356.4 5383.6 5383.6 5394.4 5430.1 4857.3 4888.2 4905.7 4949.1 4958.2 5901.3 5917.4 5918.1 5919.7 5925.8 5684.6 5718.1 5723.3 5726.8 5728.3 5907.0 5937.4 5944.3 5987.8 6000.3 5664.7 5665.1 5667.9 5671.0 5674.7 5636.9 5687.0 5688.9 5744.7 5747.9 5615.3 5617.7 5622.7 5633.1 5672.3 5591.1 5591.3 5597.4 5601.9 5604.0 5433.8 5462.6 5498.9 5500.3 5591.4 5585.0 5642.5 5648.9 5663.4 5687.5 5527.2 5533.3 5534.1 5535.3 5535.4 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | [#1] ext.html Cycles:180 Average:47955.79 Median:3382.94 stddev:90240.12 (2667.5%) stddev-sans-first:90423.20 10:25:56 INFO - PROCESS | 16359 | Values: 593.1 622.4 637.1 644.3 659.0 29987.9 30719.8 30775.8 30779.4 30795.1 37035.6 38054.4 38123.6 38194.6 38219.8 8461.9 8616.1 8640.7 8651.0 8653.8 7854.6 8659.7 8788.6 8797.9 10150.9 10126.9 10238.6 10241.2 10253.3 10262.2 10360.4 10538.2 10540.9 10541.2 10543.0 7624.2 10013.4 10294.8 10319.5 10335.5 35837.5 36321.6 36454.1 36508.1 36536.3 3406.6 3486.5 3511.8 3583.4 3954.6 28034.2 28422.4 28572.6 28616.9 28629.6 3625.7 3637.7 3655.3 3693.3 3704.8 248988.0 251355.0 253021.0 253116.0 253315.0 34672.7 35530.8 50544.7 50639.0 50720.7 34474.7 34519.8 34554.8 34635.3 34650.3 13378.4 13383.0 13466.7 13526.3 13560.1 11471.3 11544.9 11564.4 11568.5 11575.8 8487.1 8552.1 8557.6 8606.7 8620.5 3291.4 3293.6 3305.0 3327.6 3359.3 1065.6 1066.7 1078.1 1120.2 1131.4 31577.0 32121.4 32614.2 32638.7 32978.3 1056.3 1095.6 1121.6 1126.1 1161.3 16483.4 17015.2 17185.2 17199.7 17204.1 451452.0 451603.0 458037.0 458179.0 459121.0 55749.4 56581.0 56601.0 56643.4 56880.4 1158.9 1249.4 1381.6 1390.3 1395.2 29279.0 31626.0 31977.4 32314.8 32663.3 44554.6 45086.0 45164.0 45227.0 45276.5 273465.0 279909.0 280204.0 280878.0 281295.0 24804.8 25648.1 26976.9 27438.3 28028.2 41725.4 41745.2 42421.0 42479.4 42731.8 38564.0 39098.8 39197.2 39253.4 39359.8 37781.2 37994.0 38965.0 39434.8 39518.2 39610.8 40016.0 40199.4 40299.2 40322.4 33329.3 34398.3 34440.3 34481.5 34520.0 26982.5 27665.4 27713.2 27861.7 27931.6 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | [#2] jquery.html Cycles:180 Average:26136.89 Median:18932.09 stddev:62055.47 (327.8%) stddev-sans-first:62199.43 10:25:56 INFO - PROCESS | 16359 | Values: 384.8 388.2 392.2 393.7 399.2 17210.8 17664.4 18207.3 18230.5 18244.5 14409.1 14973.5 16629.3 17618.0 19029.8 5524.4 5636.7 5665.2 5673.1 5679.1 5396.5 5636.5 5683.3 5683.5 5685.5 3853.4 5648.1 6692.9 7050.3 7062.8 7073.7 7121.3 7171.3 7176.5 7215.9 6817.0 7029.9 7038.6 7076.9 7082.8 24288.4 25363.0 25547.9 25800.0 25897.9 2403.4 2463.1 2640.0 2900.8 3338.3 14424.6 15310.5 15389.8 15403.6 15689.6 2112.8 2176.9 2217.7 2220.5 2276.4 69842.7 74923.0 81133.0 87540.6 92289.5 16835.5 17165.7 17469.3 17551.9 17643.5 31329.4 31396.7 31552.2 31773.0 31828.0 9027.5 9273.8 9346.5 9490.8 9503.1 7555.3 7644.0 7649.1 7725.8 7741.3 8595.5 8608.7 8749.0 8805.2 8814.8 3078.7 3329.7 3359.9 3439.2 3496.7 956.1 991.5 996.5 1038.4 1103.9 18273.9 18310.0 18457.6 18601.3 18622.5 940.7 946.3 958.9 984.8 1031.3 10256.2 10388.1 10544.5 10626.5 10730.9 335617.0 342184.0 345751.0 348042.0 472769.0 85383.6 92419.5 92596.0 93233.0 93353.0 1019.8 1030.6 1076.9 1086.9 1123.2 15443.2 16273.3 16356.7 16564.8 16647.9 33625.7 34425.0 35039.3 35851.3 36524.6 50455.7 51048.0 51165.0 52435.0 53188.7 8417.0 8672.9 8709.0 8812.5 8853.5 9450.9 12593.6 13179.8 13309.5 13381.9 11326.2 11363.8 11448.7 11772.8 11987.1 7284.9 8429.7 11167.1 11325.3 11360.7 9590.2 11866.2 11990.6 12290.9 12298.1 8193.3 8421.1 8443.0 8715.3 8822.3 11876.3 11889.9 11898.1 11960.5 12123.8 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | [#3] mootools.html Cycles:180 Average:5496.06 Median:5091.00 stddev:3032.57 (59.6%) stddev-sans-first:3024.75 10:25:56 INFO - PROCESS | 16359 | Values: 1309.3 1497.1 1513.2 1636.1 1755.7 7919.6 8187.2 8195.5 8209.6 8212.6 7986.7 8120.0 8130.5 8134.8 8140.4 2009.4 2234.7 2282.0 2305.9 2312.3 2162.0 2164.7 2173.2 2176.1 2177.0 2170.4 2210.1 2213.6 2216.1 2219.8 1936.6 2166.1 2224.3 2227.9 2228.7 2158.6 2162.6 2171.4 2171.7 2218.0 8084.9 8093.5 8109.0 8172.3 8186.3 4880.6 5018.9 5026.1 5035.2 5122.2 3382.2 3387.8 3447.1 3456.0 3466.6 1065.6 1076.7 1083.8 1102.6 1120.1 11314.5 11319.2 11438.7 11454.6 11465.3 4373.9 4450.2 4516.7 4610.2 4640.0 9582.2 9622.1 9622.3 9626.8 9651.0 4632.1 5084.9 5092.8 5109.2 5126.7 4636.4 4714.6 4716.1 4747.4 4761.8 3792.8 3874.9 3904.8 3909.3 3971.7 1248.5 1248.9 1249.7 1263.6 1267.3 974.8 995.8 999.3 1000.1 1004.3 5714.5 5792.7 5835.0 5865.8 5924.6 975.6 989.8 998.9 1023.0 1024.7 3881.2 4016.3 4074.0 4076.8 4095.6 9967.3 10346.9 10379.2 10382.8 10440.3 10202.3 10272.7 10286.4 10312.2 10326.7 7412.6 7743.1 7746.1 7905.5 8019.8 5780.5 5831.1 5839.5 5939.1 5974.8 8950.2 9195.6 9287.8 9319.1 9359.3 9230.2 9458.6 9582.5 9645.6 9662.7 6809.7 7028.7 7164.2 7460.4 7611.5 7810.8 7854.4 7856.0 7880.1 7897.3 6994.0 7171.1 7237.2 7258.3 7317.1 7023.9 7064.8 7069.9 7171.8 7186.6 6531.4 6622.6 6657.7 6659.8 6664.3 5088.5 5098.2 5121.8 5123.8 5147.4 5089.2 5100.3 5102.7 5115.3 5237.4 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | [#4] prototype.html Cycles:180 Average:5031.46 Median:5857.31 stddev:1537.36 (26.2%) stddev-sans-first:1500.16 10:25:56 INFO - PROCESS | 16359 | Values: 303.9 305.1 310.2 323.7 327.2 5552.8 5605.8 5723.5 5794.2 5808.5 5714.6 5735.4 5752.9 5770.4 5788.1 4402.1 4415.1 4417.4 4427.0 4435.4 4202.8 4324.1 4347.7 4421.8 4424.8 4277.1 4279.9 4282.8 4287.1 4314.4 4294.4 4311.4 4321.0 4321.5 4332.3 3664.3 3750.3 3752.8 3756.2 3758.3 5503.6 5507.2 5508.1 5550.0 5581.6 4882.7 4915.8 4930.2 4961.9 4975.9 5826.9 5898.5 5934.7 5956.3 5980.6 4041.3 4061.6 4063.1 4084.5 4086.7 6218.9 6232.4 6276.1 6279.1 6283.0 4044.9 4136.7 4173.4 4175.6 4183.3 4195.0 4202.3 4209.3 4225.3 4229.3 4914.9 4930.9 4934.4 4941.3 4943.5 5955.3 6044.9 6085.3 6087.5 6120.8 1463.8 1482.3 1483.4 1485.2 1489.7 953.7 981.4 991.0 994.8 996.2 5849.3 5855.8 5858.9 5866.4 5873.0 6227.2 6229.7 6251.2 6256.0 6265.0 5544.5 5840.0 5874.1 5912.9 5925.3 3312.0 3336.6 3344.8 3350.9 3357.2 6285.5 6461.8 6482.8 6496.9 6525.4 6296.9 6312.4 6324.7 6329.2 6358.2 6223.7 6490.5 6513.2 6514.0 6514.3 6293.3 6302.6 6310.2 6319.9 6326.1 6237.1 6239.0 6248.5 6252.8 6253.8 6210.5 6299.3 6464.3 6495.9 6525.2 4142.4 4266.0 4269.1 4271.1 4299.7 6148.7 6165.5 6166.6 6171.0 6199.6 5881.1 6044.4 6054.8 6056.8 6065.9 5920.6 5985.2 6003.2 6017.3 6039.9 5808.5 5911.8 5938.5 5946.7 5947.5 6015.5 6039.6 6039.8 6047.4 6068.7 5864.9 5902.3 5915.1 5926.3 5948.7 10:25:56 INFO - PROCESS | 16359 | 10:25:56 INFO - PROCESS | 16359 | [#5] yui.html Cycles:180 Average:14528.24 Median:23396.00 stddev:17207.25 (73.5%) stddev-sans-first:17224.76 10:25:56 INFO - PROCESS | 16359 | Values: 827.1 842.5 856.9 866.3 868.8 12778.4 12820.7 12826.0 12843.9 14195.9 12297.3 12328.6 12377.7 12409.4 12434.6 660.6 761.2 771.9 782.4 783.0 787.5 790.8 791.0 791.1 792.0 825.1 827.9 832.3 835.5 835.9 689.3 807.1 831.9 832.9 833.0 611.5 611.7 612.8 613.0 613.3 13120.5 13155.7 13188.9 13241.2 13327.4 12923.2 13299.6 13349.6 13383.5 13518.3 10935.9 10975.2 11003.9 11115.2 11308.3 3712.4 3786.4 3800.8 3803.6 3848.8 52333.0 52406.7 52516.5 52951.7 53208.0 10162.8 10250.8 10269.1 10354.7 10379.5 18383.1 18586.2 18891.2 18910.5 18915.0 7784.7 7791.1 7931.0 7988.3 8051.2 4437.6 4495.8 4548.9 4572.1 4622.0 3224.2 3319.9 3324.5 3330.1 3349.1 560.5 621.4 626.4 640.7 642.6 635.3 647.4 658.7 680.4 688.2 8495.6 8951.4 8968.2 9085.5 9086.3 662.6 685.4 691.7 707.4 733.5 4242.8 4344.2 4353.5 4355.8 4366.5 63219.0 67211.7 67436.3 67469.3 67604.3 55694.0 57041.0 57204.7 57515.1 57620.7 50698.2 51500.5 51735.2 52368.5 52373.5 8025.6 8272.8 8494.5 8701.0 8873.0 28229.9 28802.7 29319.0 29505.1 30530.7 36740.3 37742.2 40966.0 41965.6 42447.8 10929.5 12039.4 12099.9 12339.9 12433.7 13179.9 13519.0 13579.7 13651.3 13747.7 12702.1 12802.3 12870.3 12911.6 13150.9 11583.2 11639.8 11650.4 11690.1 11781.0 12956.7 13100.8 13220.5 13410.7 13780.4 11060.8 11078.9 11128.7 11173.7 11543.5 10949.7 11133.8 11306.9 11343.7 11565.7 10:25:56 INFO - PROCESS | 16359 | -------- Summary: end -------- 10:25:56 INFO - PROCESS | 16359 | 10:25:57 INFO - TEST-INFO | 16359: exit 0 10:25:57 INFO - TEST-OK | dromaeo_css | took 1111617ms 10:25:57 INFO - TEST-START | kraken 10:25:57 INFO - operating with platform_type : linux_ 10:25:57 INFO - Initialising browser for kraken test... 10:25:57 INFO - TEST-INFO | started process 16543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUkhdh/profile http://localhost:41489/getInfo.html) 10:26:01 INFO - PROCESS | 16543 | __metrics Screen width/height:1600/1200 10:26:01 INFO - PROCESS | 16543 | colorDepth:24 10:26:01 INFO - PROCESS | 16543 | Browser inner width/height: 1024/697 10:26:01 INFO - PROCESS | 16543 | __metrics 10:26:02 ERROR - PROCESS | 16543 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:26:03 INFO - TEST-INFO | 16543: exit 0 10:26:03 INFO - Browser initialized. 10:26:03 INFO - Running cycle 1/1 for kraken test... 10:26:03 INFO - TEST-INFO | started process 16627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUkhdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:14 INFO - PROCESS | 16627 | RSS: Main: 153055232 10:26:14 INFO - PROCESS | 16627 | 10:26:17 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41489/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:18 INFO - PROCESS | 16627 | RSS: Main: 208084992 10:26:18 INFO - PROCESS | 16627 | 10:26:20 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41489/tests/kraken/driver.html?testName=audio-dft) 10:26:21 INFO - PROCESS | 16627 | RSS: Main: 193769472 10:26:21 INFO - PROCESS | 16627 | 10:26:24 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41489/tests/kraken/driver.html?testName=audio-fft) 10:26:25 INFO - PROCESS | 16627 | RSS: Main: 264024064 10:26:25 INFO - PROCESS | 16627 | 10:26:27 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41489/tests/kraken/driver.html?testName=audio-oscillator) 10:26:27 INFO - PROCESS | 16627 | RSS: Main: 172781568 10:26:27 INFO - PROCESS | 16627 | 10:26:29 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:30 INFO - PROCESS | 16627 | RSS: Main: 176828416 10:26:30 INFO - PROCESS | 16627 | 10:26:33 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41489/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:34 INFO - PROCESS | 16627 | RSS: Main: 213667840 10:26:34 INFO - PROCESS | 16627 | 10:26:37 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41489/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:37 INFO - PROCESS | 16627 | RSS: Main: 214720512 10:26:37 INFO - PROCESS | 16627 | 10:26:40 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41489/tests/kraken/driver.html?testName=json-parse-financial) 10:26:41 INFO - PROCESS | 16627 | RSS: Main: 214433792 10:26:41 INFO - PROCESS | 16627 | 10:26:42 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:43 INFO - PROCESS | 16627 | RSS: Main: 204857344 10:26:43 INFO - PROCESS | 16627 | 10:26:45 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:45 INFO - PROCESS | 16627 | RSS: Main: 203726848 10:26:45 INFO - PROCESS | 16627 | 10:26:47 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:48 INFO - PROCESS | 16627 | RSS: Main: 217796608 10:26:48 INFO - PROCESS | 16627 | 10:26:50 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:51 INFO - PROCESS | 16627 | RSS: Main: 222081024 10:26:51 INFO - PROCESS | 16627 | 10:26:54 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:54 INFO - PROCESS | 16627 | RSS: Main: 219348992 10:26:54 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41489/tests/kraken/driver.html?testName=ai-astar) 10:26:56 INFO - PROCESS | 16627 | RSS: Main: 283271168 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | __start_tp_report 10:26:56 INFO - PROCESS | 16627 | _x_x_mozilla_page_load 10:26:56 INFO - PROCESS | 16627 | _x_x_mozilla_page_load_details 10:26:56 INFO - PROCESS | 16627 | |i|pagename|runs| 10:26:56 INFO - PROCESS | 16627 | |0;ai-astar;109;111;105;109;109;111;98;112;111;112 10:26:56 INFO - PROCESS | 16627 | |1;audio-beat-detection;159;127;153;178;129;153;156;131;183;127 10:26:56 INFO - PROCESS | 16627 | |2;audio-dft;161;160;162;160;160;160;162;165;161;162 10:26:56 INFO - PROCESS | 16627 | |3;audio-fft;75;75;96;109;76;76;73;126;112;72 10:26:56 INFO - PROCESS | 16627 | |4;audio-oscillator;92;93;153;92;91;93;147;92;92;143 10:26:56 INFO - PROCESS | 16627 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 10:26:56 INFO - PROCESS | 16627 | |6;imaging-darkroom;146;145;146;147;146;145;146;145;145;147 10:26:56 INFO - PROCESS | 16627 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 10:26:56 INFO - PROCESS | 16627 | |8;json-parse-financial;57;59;57;57;58;58;57;74;56;55 10:26:56 INFO - PROCESS | 16627 | |9;json-stringify-tinderbox;60;61;61;60;61;60;60;61;61;61 10:26:56 INFO - PROCESS | 16627 | |10;stanford-crypto-aes;77;76;75;74;76;78;76;77;78;77 10:26:56 INFO - PROCESS | 16627 | |11;stanford-crypto-ccm;126;124;123;121;120;119;131;126;156;128 10:26:56 INFO - PROCESS | 16627 | |12;stanford-crypto-pbkdf2;169;170;172;166;166;168;163;171;164;166 10:26:56 INFO - PROCESS | 16627 | |13;stanford-crypto-sha256-iterative;68;69;69;67;68;66;69;69;66;67 10:26:56 INFO - PROCESS | 16627 | __end_tp_report 10:26:56 INFO - PROCESS | 16627 | __start_cc_report 10:26:56 INFO - PROCESS | 16627 | _x_x_mozilla_cycle_collect,1617 10:26:56 INFO - PROCESS | 16627 | __end_cc_report 10:26:56 INFO - PROCESS | 16627 | __startTimestamp1460654816942__endTimestamp 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | ------- Summary: start ------- 10:26:56 INFO - PROCESS | 16627 | Number of tests: 14 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:4.30 (3.9%) stddev-sans-first:4.56 10:26:56 INFO - PROCESS | 16627 | Values: 109.0 111.0 105.0 109.0 109.0 111.0 98.0 112.0 111.0 112.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:154.50 stddev:20.73 (13.4%) stddev-sans-first:21.70 10:26:56 INFO - PROCESS | 16627 | Values: 159.0 127.0 153.0 178.0 129.0 153.0 156.0 131.0 183.0 127.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.57 (1.0%) stddev-sans-first:1.66 10:26:56 INFO - PROCESS | 16627 | Values: 161.0 160.0 162.0 160.0 160.0 160.0 162.0 165.0 161.0 162.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#3] audio-fft Cycles:10 Average:89.00 Median:75.00 stddev:20.06 (26.7%) stddev-sans-first:20.63 10:26:56 INFO - PROCESS | 16627 | Values: 75.0 75.0 96.0 109.0 76.0 76.0 73.0 126.0 112.0 72.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:26.93 (29.3%) stddev-sans-first:27.87 10:26:56 INFO - PROCESS | 16627 | Values: 92.0 93.0 153.0 92.0 91.0 93.0 147.0 92.0 92.0 143.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:26:56 INFO - PROCESS | 16627 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:26:56 INFO - PROCESS | 16627 | Values: 146.0 145.0 146.0 147.0 146.0 145.0 146.0 145.0 145.0 147.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:26:56 INFO - PROCESS | 16627 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:57.50 stddev:5.45 (9.5%) stddev-sans-first:5.74 10:26:56 INFO - PROCESS | 16627 | Values: 57.0 59.0 57.0 57.0 58.0 58.0 57.0 74.0 56.0 55.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 10:26:56 INFO - PROCESS | 16627 | Values: 60.0 61.0 61.0 60.0 61.0 60.0 60.0 61.0 61.0 61.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:77.00 stddev:1.26 (1.6%) stddev-sans-first:1.32 10:26:56 INFO - PROCESS | 16627 | Values: 77.0 76.0 75.0 74.0 76.0 78.0 76.0 77.0 78.0 77.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.00 stddev:10.71 (8.5%) stddev-sans-first:11.35 10:26:56 INFO - PROCESS | 16627 | Values: 126.0 124.0 123.0 121.0 120.0 119.0 131.0 126.0 156.0 128.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:168.50 stddev:2.99 (1.8%) stddev-sans-first:3.12 10:26:56 INFO - PROCESS | 16627 | Values: 169.0 170.0 172.0 166.0 166.0 168.0 163.0 171.0 164.0 166.0 10:26:56 INFO - PROCESS | 16627 | 10:26:56 INFO - PROCESS | 16627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.23 (1.8%) stddev-sans-first:1.30 10:26:56 INFO - PROCESS | 16627 | Values: 68.0 69.0 69.0 67.0 68.0 66.0 69.0 69.0 66.0 67.0 10:26:56 INFO - PROCESS | 16627 | -------- Summary: end -------- 10:26:56 INFO - PROCESS | 16627 | 10:26:57 INFO - TEST-INFO | 16627: exit 0 10:26:57 INFO - TEST-OK | kraken | took 60633ms 10:26:57 INFO - SUITE-END | took 1172s 10:26:58 INFO - Completed test suite (00:19:32) 10:26:58 INFO - javascript benchmark 10:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.221428535723, 3103.34829685766, 3146.669599692034, 3149.10250578585, 3173.98413007935, 5242.737863106839, 5310.336207973998, 5328.49379308966, 5341.839744807658, 5409.621326507141, 5319.760610772515, 5357.223202635615, 5363.785448582052, 5445.401005889349, 5452.2094296327, 4792.976035119819, 4811.350467686852, 4940.184869496528, 4990.850274491771, 5022.995400919831, 4924.162892308298, 4963.925541116868, 4970.627202959774, 4986.152354099793, 4990.500949905017, 4839.225723884179, 4862.319275301443, 4893.437254715717, 4924.039812236615, 4958.87602809929, 4845.951540484585, 4860.538248866352, 4860.7326597037145, 4875.731834749087, 4910.582600478963, 4808.447028591721, 4845.345878306419, 4854.635902307341, 4862.124817532843, 4877.365942427497, 5190.480951904817, 5293.814716484943, 5351.973240133813, 5377.139657654757, 5384.165454354581, 5618.91571626426, 5620.297462817148, 5630.831075067755, 5644.379118296984, 5647.29408823897, 5658.12299093637, 5674.829755107354, 5679.148127780824, 5680.034394153004, 5681.289838770153, 5328.6269961102735, 5360.142377219626, 5371.060064488699, 5399.78400863965, 5410.513053825135, 5911.379305172981, 5917.881642367129, 5921.61509501881, 5923.466887980103, 5940.198073260141, 5550.0, 5645.802396916089, 5665.433456654301, 5670.659760414388, 5675.233843431167, 5728.398518155617, 5739.024365857814, 5751.827445176651, 5761.279840019997, 5793.102069179284, 5694.572907031989, 5704.971475142598, 5717.399673034354, 5717.799877004285, 5718.485336319751, 5528.198411230349, 5649.661020338793, 5721.599488035798, 5724.026915424388, 5725.799597014085, 4252.192083504125, 4276.144771045741, 4289.24938135825, 4300.61294483498, 4313.676474264443, 3821.2548553032448, 3836.731428799957, 3850.0759817643566, 3858.9421158682644, 3889.649931506178, 5359.464053594687, 5403.756830942617, 5473.151661492475, 5540.030494663499, 5548.69482178484, 5671.829845104653, 5672.262605861211, 5689.345725241567, 5691.4877661010705, 5693.402192769782, 5356.384015838151, 5383.569314454834, 5383.596230282745, 5394.433584473652, 5430.104032834538, 4857.344258525124, 4888.169011268093, 4905.705657660552, 4949.084419382426, 4958.181899986462, 5901.321348044944, 5917.437843404869, 5918.053111502139, 5919.67441790697, 5925.792597259076, 5684.602077854511, 5718.142278658234, 5723.31320241557, 5726.770929162787, 5728.312602487728, 5906.970465147647, 5937.435943585352, 5944.346121926671, 5987.790427335022, 6000.309964353981, 5664.745086471201, 5665.12190610456, 5667.943320566742, 5670.971645141913, 5674.659520428788, 5636.887262254814, 5686.9715651421475, 5688.914666280092, 5744.655320680772, 5747.913781293368, 5615.298087739033, 5617.7191140442, 5622.690752008679, 5633.126865335879, 5672.290963629546, 5591.077472217039, 5591.329040515164, 5597.356304024926, 5601.887962240651, 5604.047311956896, 5433.8369848904595, 5462.644928079662, 5498.862528436821, 5500.312460942382, 5591.412901645432, 5585.0, 5642.463965923231, 5648.943510564842, 5663.4053424391495, 5687.488126068673, 5527.170924361217, 5533.3083364579425, 5534.05920993424, 5535.335759708861, 5535.446455354432], "value": 5276.679348733373, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.1369856858272, 622.37140488107, 637.1144109687532, 644.3105876711917, 658.960462372258, 29987.850060749694, 30719.84640076802, 30775.846120769394, 30779.38441231174, 30795.07614771555, 37035.629643703556, 38054.4291835622, 38123.61876381235, 38194.61805381945, 38219.808900955526, 8461.87307190391, 8616.095309992455, 8640.697575584856, 8650.956745216265, 8653.783655408633, 7854.646540905673, 8659.740207793777, 8788.604512796908, 8797.868031979526, 10150.949245253763, 10126.898731012707, 10238.641647542338, 10241.231907606922, 10253.33353332031, 10262.179025677928, 10360.430176340298, 10538.156947444262, 10540.894591054068, 10541.209409294333, 10543.0, 7624.19945905683, 10013.39919604826, 10294.845577316346, 10319.484025798754, 10335.483225838752, 35837.46243806345, 36321.63678363209, 36454.088647783756, 36508.0872978175, 36536.26927461463, 3406.557147570825, 3486.511888335635, 3511.7892926424497, 3583.4266517357096, 3954.62431069048, 28034.158975230574, 28422.431551369064, 28572.57129144495, 28616.85691571529, 28629.57055644167, 3625.7461977661574, 3637.672609465161, 3655.323765103438, 3693.298273328059, 3704.814759262026, 248988.0, 251355.0, 253021.0, 253116.0, 253315.0, 34672.65327346745, 35530.82234588862, 50544.747276263384, 50639.0, 50720.74639626852, 34474.65525344764, 34519.827400862836, 34554.82722586371, 34635.307293853984, 34650.30699385998, 13378.39797209128, 13383.0, 13466.730665386638, 13526.32368381577, 13560.11859229147, 11471.25436846619, 11544.94227528857, 11564.42177891102, 11568.479418426023, 11575.76848463043, 8487.10885357041, 8552.059273479912, 8557.614907329185, 8606.741797746077, 8620.52587107715, 3291.4075466415798, 3293.6212335581713, 3305.0415379539663, 3327.584051993501, 3359.328134373135, 1065.6376831877199, 1066.6586692258402, 1078.1374900080061, 1120.1629327902085, 1131.4229742831214, 31577.0, 32121.357572848414, 32614.184645384055, 32638.673613263563, 32978.3404331912, 1056.3081181825917, 1095.6220104064084, 1121.6410748560545, 1126.099120703434, 1161.3438407299848, 16483.423080192137, 17015.23431445588, 17185.226664800113, 17199.65600687979, 17204.1397930103, 451452.0, 451603.0, 458037.0, 458179.0, 459121.0, 55749.44250557443, 56581.0, 56601.0, 56643.43356566464, 56880.43119568834, 1158.9072874170047, 1249.425264378378, 1381.5579014715195, 1390.3048475762118, 1395.2117053864533, 29279.0, 31626.0, 31977.36045279128, 32314.83842580772, 32663.34673306473, 44554.55445445504, 45086.0, 45164.0, 45227.0, 45276.54723452855, 273465.0, 279909.0, 280204.0, 280878.0, 281295.0, 24804.751952480965, 25648.102316418837, 26976.865115674296, 27438.314042148308, 28028.159155225378, 41725.37411938884, 41745.16509669729, 42421.0, 42479.362809557264, 42731.786341068095, 38564.0, 39098.804505977285, 39197.216055679295, 39253.41119883147, 39359.803200984956, 37781.2443751118, 37994.0, 38965.0, 39434.80282598684, 39518.209635807696, 39610.80194599008, 40016.0, 40199.3970090443, 40299.19401611893, 40322.395164071975, 33329.33341333208, 34398.312033759685, 34440.31119377548, 34481.482777757854, 34520.0, 26982.460350793266, 27665.446691066467, 27713.168604941882, 27861.736654521064, 27931.58102628503], "value": 17665.24850230054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.79798105994365, 388.2293647110485, 392.23318412503556, 393.7259765634611, 399.1577770903393, 17210.827891721077, 17664.381746638872, 18207.27170913162, 18230.544236394097, 18244.54388640283, 14409.13545187287, 14973.47592834251, 16629.251683674232, 17618.0, 19029.809701902977, 5524.392316845144, 5636.746346414421, 5665.1502274658715, 5673.12066629671, 5679.119736440858, 5396.487333703292, 5636.549076073925, 5683.3464151622675, 5683.54531637468, 5685.488306052454, 3853.364194907837, 5648.068068768648, 6692.899606505906, 7050.29497050296, 7062.788116356517, 7073.717051317993, 7121.2878712128895, 7171.28287171284, 7176.497645164841, 7215.891761623579, 6816.965915170442, 7029.859402811966, 7038.6128762918015, 7076.893846592306, 7082.822929426754, 24288.39279018021, 25363.0, 25547.872260638764, 25800.0, 25897.870510647514, 2403.375122468171, 2463.064035666453, 2639.9604005939927, 2900.7534359579463, 3338.315645292709, 14424.639384015378, 15310.540683779505, 15389.769153462707, 15403.614909627237, 15689.607759805982, 2112.7992840680113, 2176.912923483059, 2217.733871935362, 2220.5114874727533, 2276.4081338852016, 69842.65078674625, 74923.0, 81132.9999999994, 87540.56229718875, 92289.53855230748, 16835.49493515172, 17165.7425138623, 17469.301227950993, 17551.912240438716, 17643.470695879143, 31329.373412531622, 31396.686033139376, 31552.211194720316, 31773.0, 31828.0, 9027.50348730826, 9273.814523709489, 9346.485943273185, 9490.810183796286, 9503.144716975505, 7555.282248186413, 7644.044494438195, 7649.120351159577, 7725.8454830903065, 7741.341985931146, 8595.484270943638, 8608.698695545625, 8748.956255218684, 8805.16350946659, 8814.77963050916, 3078.6767389424235, 3329.679091090264, 3359.882404115844, 3439.208981934119, 3496.6852983231634, 956.1108169402522, 991.4844280973854, 996.5266498413196, 1038.4496217004998, 1103.9282446640943, 18273.890336838205, 18309.992950387856, 18457.630847383247, 18601.25594976213, 18622.53443663892, 940.6660635474445, 946.2524605561667, 958.8657587937695, 984.832578461649, 1031.2523420520063, 10256.230782691327, 10388.065074143364, 10544.525496352682, 10626.521806518725, 10730.89269107299, 335617.0, 342184.0, 345751.0, 348042.0, 472769.0, 85383.57308213544, 92419.53790231005, 92595.99999999865, 93233.0, 93353.0, 1019.8368261078192, 1030.6032177611523, 1076.8653918260218, 1086.869575650927, 1123.213750374741, 15443.2278386078, 16273.267702953159, 16356.67286654284, 16564.763756892666, 16647.91676041612, 33625.66374336225, 34424.96725098251, 35039.29921401507, 35851.28297434089, 36524.63475365212, 50455.747721261156, 51048.0, 51165.0, 52435.0, 53188.73405632947, 8417.0, 8672.913270867211, 8709.0, 8812.51531165792, 8853.51305678194, 9450.858237126586, 12593.622191334274, 13179.802302965272, 13309.46762129504, 13381.933090334485, 11326.150538709466, 11363.829542557034, 11448.713782155513, 11772.764544709229, 11987.100967427652, 7284.890726639211, 8429.747107586782, 11167.1066314693, 11325.32048077118, 11360.727854428982, 9590.184834289164, 11866.228695134789, 11990.580329688419, 12290.926509919664, 12298.077644176543, 8193.262606365455, 8421.07368189511, 8442.957785211034, 8715.259202967818, 8822.33832462555, 11876.346800926032, 11889.881101188877, 11898.107641926717, 11960.46177922013, 12123.75752484963], "value": 9909.491923730573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.2537253765358, 1497.091208708896, 1513.1601960911696, 1636.124673299785, 1755.6656940725045, 7919.604019799016, 8187.18128187181, 8195.467294625845, 8209.589520523965, 8212.589370531472, 7986.720464783733, 8120.0, 8130.471519351238, 8134.796630084251, 8140.389470789685, 2009.4273132157339, 2234.731832180141, 2282.0, 2305.8501197422197, 2312.2600767754325, 2161.9567608647817, 2164.718586583742, 2173.2067795254775, 2176.075168053571, 2177.031221106608, 2170.413988223179, 2210.082815631511, 2213.634750266212, 2216.1246307708525, 2219.7891200335944, 1936.5739537301772, 2166.122720298282, 2224.27710993926, 2227.9220227291967, 2228.699125618037, 2158.589867925089, 2162.556675881456, 2171.3811563704267, 2171.739391273057, 2217.9778202218095, 8084.878726819103, 8093.514389136671, 8109.0, 8172.305354044914, 8186.2632363087605, 4880.6095512358925, 5018.949810501885, 5026.070177017227, 5035.169197082477, 5122.1804511278015, 3382.1713680148273, 3387.8306084695914, 3447.120984149051, 3456.0495863637448, 3466.584009918826, 1065.5844220753913, 1076.7415820203173, 1083.8428427877993, 1102.614085070227, 1120.1430905357408, 11314.490847911864, 11319.151063670257, 11438.656840294721, 11454.599089031928, 11465.31208127515, 4373.890652733643, 4450.198964186413, 4516.728996260234, 4610.170169369479, 4639.976800115978, 9582.185514231229, 9622.13400793918, 9622.326437149472, 9626.807463850684, 9650.95174524137, 4632.143053535106, 5084.872878178001, 5092.770825312869, 5109.233614957786, 5126.666766660155, 4636.397268355092, 4714.622830173578, 4716.080364328992, 4747.406574178228, 4761.809527618926, 3792.791396473165, 3874.9418758718643, 3904.8047597620007, 3909.257241124177, 3971.7418367806, 1248.4881198708485, 1248.9437975291135, 1249.7000719827176, 1263.6398626391435, 1267.2649863079391, 974.7904200596905, 995.7809281957958, 999.2505620784411, 1000.0899181744578, 1004.279318277386, 5714.485696287354, 5792.652440853562, 5835.008048631743, 5865.794697185664, 5924.5852790305125, 975.6438899801522, 989.7921436498272, 998.9400635961865, 1022.9795404091876, 1024.7438140464883, 3881.204353107606, 4016.256992456405, 4073.9796301018305, 4076.7961601919787, 4095.5904409558807, 9967.252456065824, 10346.896531034743, 10379.221558383151, 10382.844257336146, 10440.321379110334, 10202.285839991278, 10272.743181420376, 10286.434246116385, 10312.226583006304, 10326.690199294033, 7412.629368531552, 7743.070831500256, 7746.070471543563, 7905.486143400661, 8019.7995050123045, 5780.450857168562, 5831.096180092092, 5839.474447299764, 5939.07944268639, 5974.761009559569, 8950.23922966555, 9195.586198620944, 9287.814243714953, 9319.068093190897, 9359.251259899327, 9230.169284764403, 9458.574364153492, 9582.520873956413, 9645.565949532429, 9662.71011869645, 6809.659517024228, 7028.683709232994, 7164.211936687065, 7460.403167746459, 7611.467197296136, 7810.765677029698, 7854.371650268079, 7856.0, 7880.05439347282, 7897.289243968071, 6993.965030174817, 7171.067761191011, 7237.240089790706, 7258.274172582699, 7317.085364329459, 7023.894641580483, 7064.823379415556, 7069.893951590833, 7171.820704482429, 7186.568805871664, 6531.412172904462, 6622.63575503352, 6657.667116644246, 6659.766908158192, 6664.300248473841, 5088.542031217208, 5098.1842905135, 5121.820736274212, 5123.820666276812, 5147.433782284021, 5089.236614507706, 5100.285959965682, 5102.69383836971, 5115.335006449287, 5237.423883372902], "value": 4451.941929048215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.92553824313046, 305.083224909148, 310.17493467376767, 323.71351354051654, 327.16246409192456, 5552.833414997546, 5605.775768969246, 5723.513501352385, 5794.217780599623, 5808.506276966463, 5714.57140714446, 5735.397783232763, 5752.913706294409, 5770.365259821427, 5788.073908174693, 4402.075564131536, 4415.139047885664, 4417.359482874981, 4426.97786511067, 4435.356873253377, 4202.831886724527, 4324.07032488015, 4347.739135651856, 4421.828215522889, 4424.756638384888, 4277.14457108578, 4279.87160385189, 4282.764447955361, 4287.078278170193, 4314.395984562164, 4294.423345992411, 4311.353297005443, 4320.978395108035, 4321.481422229353, 4332.328489084165, 3664.303782281358, 3750.287445385368, 3752.7991042866292, 3756.1548651553453, 3758.267137908109, 5503.642263252876, 5507.228987941691, 5508.08071721988, 5549.972250138764, 5581.581381396411, 4882.658213925027, 4915.778789954461, 4930.186519224324, 4961.8511444656715, 4975.925361119586, 5826.854328641775, 5898.528117750569, 5934.703264836784, 5956.255468066492, 5980.611260268069, 4041.2523683118716, 4061.62394998926, 4063.085805693725, 4084.4894388201474, 4086.6730661547303, 6218.875622487571, 6232.439080482733, 6276.121343011982, 6279.120923070774, 6283.0, 4044.9191016180102, 4136.73111247768, 4173.4157217989505, 4175.5824417558, 4183.330667093251, 4195.0, 4202.2646036943415, 4209.34755112958, 4225.260579398593, 4229.281022226229, 4914.877128071756, 4930.9013819723405, 4934.358533390637, 4941.283513890466, 4943.4809345018975, 5955.34491205967, 6044.939550604526, 6085.3306136325855, 6087.482563982023, 6120.755169793248, 1463.8023866777849, 1482.2588705647177, 1483.3992233145593, 1485.1979930837442, 1489.6648254142947, 953.6526742576848, 981.4454833019321, 990.9950450247702, 994.7612572982432, 996.1881066930429, 5849.327327357323, 5855.765769369177, 5858.853528661817, 5866.384029676908, 5873.0, 6227.221597300338, 6229.657368844757, 6251.249850017936, 6256.0, 6264.968675156595, 5544.500994910397, 5840.0, 5874.089516125007, 5912.852178695567, 5925.259342582177, 3311.9503207451908, 3336.5662463880026, 3344.816035118092, 3350.8994730158133, 3357.2446199605383, 6285.465735412449, 6461.8061458156335, 6482.773102941374, 6496.870062598816, 6525.4453371463005, 6296.874062518724, 6312.43188113072, 6324.659875845874, 6329.208848893888, 6358.237011558643, 6223.688815559204, 6490.4807615390655, 6513.185851768529, 6514.0, 6514.283428822826, 6293.276273228637, 6302.558820882494, 6310.211223597051, 6319.905201422074, 6326.051092336186, 6237.12680224778, 6238.968805155945, 6248.4688801452385, 6252.843678908063, 6253.812385628438, 6210.5031597473, 6299.267701382157, 6464.256610489666, 6495.935040649722, 6525.216973962965, 4142.420061191376, 4266.0, 4269.124829410026, 4271.081717430643, 4299.742015479082, 6148.661823599566, 6165.506759459322, 6166.599171053867, 6171.043488259327, 6199.5970261934635, 5881.147233651011, 6044.425779550936, 6054.848628784315, 6056.757729690763, 6065.939340606537, 5920.555958303231, 5985.191999080069, 6003.249593800775, 6017.308009578955, 6039.909401358896, 5808.5353171747, 5911.763529458945, 5938.545056461195, 5946.73239704223, 5947.494462970696, 6015.548833837567, 6039.577229593886, 6039.818805435844, 6047.425494578008, 6068.666223357758, 5864.853378665567, 5902.321233058082, 5915.142304365929, 5926.318473375617, 5948.70974674762], "value": 4526.105661536698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.1067247372838, 842.5110405706818, 856.8543347630903, 866.3199388480044, 868.7958329792498, 12778.424970876322, 12820.743585128292, 12826.0, 12843.871561284373, 14195.858041419595, 12297.26216427015, 12328.630141095759, 12377.690557736061, 12409.441575129118, 12434.564790232344, 660.5640277416906, 761.2425636491698, 771.8996530451034, 782.3701919954434, 783.017313271843, 787.4999375396636, 790.8022994251437, 790.952542847431, 791.145562792186, 792.029763539665, 825.1171246765963, 827.8509868223717, 832.3382910586068, 835.5404527509845, 835.8871552340418, 689.3451221339723, 807.1283014344494, 831.9417640765149, 832.9458585192003, 832.9750107496785, 611.5016261746707, 611.6727550760367, 612.761023200952, 612.9509639228851, 613.3467856732566, 13120.540781072712, 13155.73688526224, 13188.934055329757, 13241.205527668371, 13327.400266987912, 12923.15999460032, 13299.601011969657, 13349.599512014654, 13383.464661413533, 13518.324083795771, 10935.945320273428, 10975.231733778639, 11003.944980275128, 11115.221934464591, 11308.321500709984, 3712.393867690045, 3786.413105968579, 3800.8217452589784, 3803.5625903020955, 3848.7883166425836, 52333.0, 52406.737966310306, 52516.47483525154, 52951.73524132355, 53207.999999999614, 10162.847557286646, 10250.794984100276, 10269.127124194378, 10354.741131471774, 10379.532921018572, 18383.080845957647, 18586.163622637014, 18891.244350225836, 18910.52723681919, 18915.0, 7784.6886124554385, 7791.0650721913735, 7931.0, 7988.320992715568, 8051.2351326623875, 4437.5784300491405, 4495.752733599618, 4548.931766023512, 4572.1312950539295, 4622.0, 3224.1778346521955, 3319.8838040668943, 3324.5013248012992, 3330.0675810773023, 3349.0790032741193, 560.5095541401274, 621.4220774679501, 626.3673689573563, 640.6860638287299, 642.6240649220165, 635.3455940381415, 647.3526473526474, 658.6838317607575, 680.4114441008492, 688.2257460357098, 8495.617697203517, 8951.41815781972, 8968.192862642263, 9085.454872707658, 9086.273098152133, 662.6129566623417, 685.396850771328, 691.695653912277, 707.3704403081261, 733.4975541753915, 4242.809073591696, 4344.218040752632, 4353.542877997828, 4355.825766969349, 4366.454193225847, 63219.0, 67211.66394167997, 67436.32563674399, 67469.32530674728, 67604.32395676078, 55694.0, 57041.0, 57204.71397642985, 57515.13727294094, 57620.71189644025, 50698.23952640713, 51500.48499515032, 51735.22397164046, 52368.47631523712, 52373.47626523686, 8025.5987200638565, 8272.751817445485, 8494.53280069602, 8701.0, 8873.04792945551, 28229.858850705616, 28802.711972880843, 29319.0, 29505.11484655464, 30530.694693052785, 36740.26519469542, 37742.24515509729, 40966.0, 41965.58034419617, 42447.787761060994, 10929.453527323762, 12039.398030098635, 12099.879001209874, 12339.876601233873, 12433.689157771129, 13179.868201317864, 13519.0, 13579.660508486972, 13651.317434128452, 13747.656308592364, 12702.110852240254, 12802.295873727035, 12870.292133932724, 12911.612651620466, 13150.868491314965, 11583.189176757545, 11639.825402618799, 11650.359230242419, 11690.123240756808, 11781.0, 12956.740865182832, 13100.803487947498, 13220.471181152647, 13410.731785364043, 13780.448782048607, 11060.778784424427, 11078.944605276922, 11128.666140015812, 11173.72065698364, 11543.4805433754, 10949.671509854717, 11133.83299250528, 11306.94022113867, 11343.716407089558, 11565.710857228636], "value": 6563.964684326763, "unit": "score"}], "name": "dromaeo_css", "value": 7044.261227689176, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 109.0, 109.0, 111.0, 98.0, 112.0, 111.0, 112.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 153.0, 178.0, 129.0, 153.0, 156.0, 131.0, 183.0, 127.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 162.0, 165.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 96.0, 109.0, 76.0, 76.0, 73.0, 126.0, 112.0, 72.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 92.0, 91.0, 93.0, 147.0, 92.0, 92.0, 143.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 57.0, 58.0, 58.0, 57.0, 74.0, 56.0, 55.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 74.0, 76.0, 78.0, 76.0, 77.0, 78.0, 77.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 123.0, 121.0, 120.0, 119.0, 131.0, 126.0, 156.0, 128.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 172.0, 166.0, 166.0, 168.0, 163.0, 171.0, 164.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 67.0, 68.0, 66.0, 69.0, 69.0, 66.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1533.6, "alertThreshold": 2.0}]} 10:26:58 INFO - Return code: 0 10:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:58 ERROR - # TBPL SUCCESS # 10:26:58 INFO - Running post-action listener: _resource_record_post_action 10:26:58 INFO - Running post-run listener: _resource_record_post_run 10:26:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536657920; Read time: 12; Write time: 576836 10:26:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243990528; Read time: 0; Write time: 348476 10:26:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292618240; Read time: 12; Write time: 228336 10:26:59 INFO - Running post-run listener: _upload_blobber_files 10:26:59 INFO - Blob upload gear active. 10:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:00 INFO - (blobuploader) - INFO - Done attempting. 10:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:01 INFO - (blobuploader) - INFO - Done attempting. 10:27:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:01 INFO - Return code: 0 10:27:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d5a6ad39b7480f8807fa3ebf0b836d6c892614bb3b24f7a8a50eede490619dbf57304c34fa0704af778cd812c2da22ace222cd60c2081f6ee7a7bf544244ccd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ca49f14db1ea13f7cdc0eb7bcce60572566ec9cb669287f24e78eb8d3ad4a24ae970d2cc0379c3260bb03903367004b3612003b1f1bc275b6deddb345bd31250"} 10:27:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:01 INFO - Contents: 10:27:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d5a6ad39b7480f8807fa3ebf0b836d6c892614bb3b24f7a8a50eede490619dbf57304c34fa0704af778cd812c2da22ace222cd60c2081f6ee7a7bf544244ccd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ca49f14db1ea13f7cdc0eb7bcce60572566ec9cb669287f24e78eb8d3ad4a24ae970d2cc0379c3260bb03903367004b3612003b1f1bc275b6deddb345bd31250"} 10:27:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:01 INFO - Copying logs to upload dir... 10:27:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.651383 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-14 10:27:00.617485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 10:27:00.620885) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d5a6ad39b7480f8807fa3ebf0b836d6c892614bb3b24f7a8a50eede490619dbf57304c34fa0704af778cd812c2da22ace222cd60c2081f6ee7a7bf544244ccd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ca49f14db1ea13f7cdc0eb7bcce60572566ec9cb669287f24e78eb8d3ad4a24ae970d2cc0379c3260bb03903367004b3612003b1f1bc275b6deddb345bd31250"} build_url:https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/IuF3fmujRRSuz1cnbvOiwQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d5a6ad39b7480f8807fa3ebf0b836d6c892614bb3b24f7a8a50eede490619dbf57304c34fa0704af778cd812c2da22ace222cd60c2081f6ee7a7bf544244ccd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ca49f14db1ea13f7cdc0eb7bcce60572566ec9cb669287f24e78eb8d3ad4a24ae970d2cc0379c3260bb03903367004b3612003b1f1bc275b6deddb345bd31250"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 10:27:00.649605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:27:00.649971) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1460650022.84689-754701626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:27:00.731355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 10:27:00.731831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 10:27:00.732336) ========= ========= Total master_lag: 0.17 =========