builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1461064813.24 results: success (0) buildid: 20160419025944 builduid: 33b87f2012724d1ead24a708768fb835 revision: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.236826) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.237547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.237943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.255985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.256391) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 04:20:13-- 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% 38.2M=0s 2016-04-19 04:20:13 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.372304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.372625) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.421958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:13.422333) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae7413abfa4d3954a6a4ce7c1613a7100f367f9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ae7413abfa4d3954a6a4ce7c1613a7100f367f9a --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=8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 04:20:13,701 truncating revision to first 12 chars 2016-04-19 04:20:13,701 Setting DEBUG logging. 2016-04-19 04:20:13,701 attempt 1/10 2016-04-19 04:20:13,701 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae7413abfa4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 04:20:14,013 unpacking tar archive at: mozilla-central-ae7413abfa4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:14.008146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:14.008460) ========= script_repo_revision: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:14.008875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:14.009177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:20:14.019825) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-19 04:20:14.020131) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:14 INFO - MultiFileLogger online at 20160419 04:20:14 in /builds/slave/test 04:20:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:20:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:14 INFO - {'append_to_log': False, 04:20:14 INFO - 'base_work_dir': '/builds/slave/test', 04:20:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:20:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:14 INFO - 'branch': 'Firefox-Non-PGO', 04:20:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:14 INFO - 'config_files': ('talos/linux_config.py',), 04:20:14 INFO - 'default_actions': ('clobber', 04:20:14 INFO - 'read-buildbot-config', 04:20:14 INFO - 'download-and-extract', 04:20:14 INFO - 'populate-webroot', 04:20:14 INFO - 'create-virtualenv', 04:20:14 INFO - 'install', 04:20:14 INFO - 'run-tests'), 04:20:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:14 INFO - 'download_minidump_stackwalk': True, 04:20:14 INFO - 'download_symbols': 'ondemand', 04:20:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:14 INFO - 'installer_path': 'installer.exe', 04:20:14 INFO - 'log_level': 'info', 04:20:14 INFO - 'log_name': 'talos', 04:20:14 INFO - 'log_to_console': True, 04:20:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:14 INFO - 'opt_config_files': (), 04:20:14 INFO - 'pip_index': False, 04:20:14 INFO - 'sps_profile': False, 04:20:14 INFO - 'sps_profile_interval': 0, 04:20:14 INFO - 'suite': 'dromaeojs', 04:20:14 INFO - 'system_bits': '32', 04:20:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:14 INFO - 'title': 'talos-linux64-ix-001', 04:20:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:14 INFO - 'use_talos_json': True, 04:20:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:14 INFO - 'work_dir': 'build'} 04:20:14 INFO - ##### 04:20:14 INFO - ##### Running clobber step. 04:20:14 INFO - ##### 04:20:14 INFO - Running pre-action listener: _resource_record_pre_action 04:20:14 INFO - Running main action method: clobber 04:20:14 INFO - rmtree: /builds/slave/test/build 04:20:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:14 INFO - Running post-action listener: _resource_record_post_action 04:20:14 INFO - ##### 04:20:14 INFO - ##### Running read-buildbot-config step. 04:20:14 INFO - ##### 04:20:14 INFO - Running pre-action listener: _resource_record_pre_action 04:20:14 INFO - Running main action method: read_buildbot_config 04:20:14 INFO - Using buildbot properties: 04:20:14 INFO - { 04:20:14 INFO - "project": "", 04:20:14 INFO - "product": "firefox", 04:20:14 INFO - "script_repo_revision": "production", 04:20:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:20:14 INFO - "repository": "", 04:20:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:20:14 INFO - "buildid": "20160419025944", 04:20:14 INFO - "pgo_build": "False", 04:20:14 INFO - "basedir": "/builds/slave/test", 04:20:14 INFO - "buildnumber": 552, 04:20:14 INFO - "slavename": "talos-linux64-ix-001", 04:20:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:20:14 INFO - "platform": "ubuntu64_hw", 04:20:14 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:20:14 INFO - "branch": "mozilla-central", 04:20:14 INFO - "repo_path": "mozilla-central", 04:20:14 INFO - "revision": "ae7413abfa4d3954a6a4ce7c1613a7100f367f9a", 04:20:14 INFO - "stage_platform": "linux64", 04:20:14 INFO - "builduid": "33b87f2012724d1ead24a708768fb835", 04:20:14 INFO - "slavebuilddir": "test" 04:20:14 INFO - } 04:20:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:20:14 INFO - Running post-action listener: _resource_record_post_action 04:20:14 INFO - ##### 04:20:14 INFO - ##### Running download-and-extract step. 04:20:14 INFO - ##### 04:20:14 INFO - Running pre-action listener: _resource_record_pre_action 04:20:14 INFO - Running main action method: download_and_extract 04:20:14 INFO - mkdir: /builds/slave/test/build/tests 04:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:14 INFO - https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:15 INFO - Downloaded 1361 bytes. 04:20:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:20:15 INFO - Using the following test package requirements: 04:20:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:20:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'jsshell-linux-x86_64.zip'], 04:20:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:20:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:20:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:17 INFO - Downloaded 22210247 bytes. 04:20:17 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'] 04:20:17 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 04:20:18 INFO - Return code: 0 04:20:18 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 04:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:18 INFO - https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:31 INFO - Downloaded 22210247 bytes. 04:20:31 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'] 04:20:31 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 04:20:33 INFO - Return code: 0 04:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:33 INFO - https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:20:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:34 INFO - Downloaded 10845952 bytes. 04:20:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:20:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:20:34 INFO - Return code: 0 04:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:34 INFO - https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0hTnQhfT3mkG39NFGoD_w/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 04:20:36 INFO - Downloaded 54450319 bytes. 04:20:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:36 INFO - mkdir: /builds/slave/test/properties 04:20:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:36 INFO - Contents: 04:20:36 INFO - build_url:https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:20:37 INFO - Running post-action listener: _resource_record_post_action 04:20:37 INFO - Running post-action listener: set_extra_try_arguments 04:20:37 INFO - ##### 04:20:37 INFO - ##### Running populate-webroot step. 04:20:37 INFO - ##### 04:20:37 INFO - Running pre-action listener: _resource_record_pre_action 04:20:37 INFO - Running main action method: populate_webroot 04:20:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:37 INFO - '--tppagecycles', 04:20:37 INFO - '7'], 04:20:37 INFO - 'tests': ['tsvgm']}}, 04:20:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['damp', 'tps']}, 04:20:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'tests': ['damp', 'tps']}, 04:20:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['dromaeo_dom']}, 04:20:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['a11yr', 04:20:37 INFO - 'ts_paint', 04:20:37 INFO - 'tpaint', 04:20:37 INFO - 'sessionrestore', 04:20:37 INFO - 'sessionrestore_no_auto_restore', 04:20:37 INFO - 'tabpaint']}, 04:20:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:37 INFO - 'ts_paint', 04:20:37 INFO - 'tpaint', 04:20:37 INFO - 'sessionrestore', 04:20:37 INFO - 'sessionrestore_no_auto_restore', 04:20:37 INFO - 'tabpaint']}, 04:20:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:20:37 INFO - 'ts_paint', 04:20:37 INFO - 'tpaint', 04:20:37 INFO - 'sessionrestore', 04:20:37 INFO - 'sessionrestore_no_auto_restore', 04:20:37 INFO - 'tabpaint']}, 04:20:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:20:37 INFO - 'ts_paint', 04:20:37 INFO - 'tpaint', 04:20:37 INFO - 'sessionrestore', 04:20:37 INFO - 'sessionrestore_no_auto_restore', 04:20:37 INFO - 'tabpaint']}, 04:20:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['a11yr', 04:20:37 INFO - 'ts_paint', 04:20:37 INFO - 'tpaint', 04:20:37 INFO - 'sessionrestore', 04:20:37 INFO - 'sessionrestore_no_auto_restore', 04:20:37 INFO - 'tabpaint']}, 04:20:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['a11yr', 04:20:37 INFO - 'ts_paint', 04:20:37 INFO - 'tpaint', 04:20:37 INFO - 'sessionrestore', 04:20:37 INFO - 'sessionrestore_no_auto_restore', 04:20:37 INFO - 'tabpaint']}, 04:20:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['tsvgx', 04:20:37 INFO - 'tsvgr_opacity', 04:20:37 INFO - 'tart', 04:20:37 INFO - 'tscrollx', 04:20:37 INFO - 'cart']}, 04:20:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:37 INFO - 'tsvgr_opacity', 04:20:37 INFO - 'tart', 04:20:37 INFO - 'tscrollx', 04:20:37 INFO - 'cart']}, 04:20:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'talos_options': ['--disable-e10s'], 04:20:37 INFO - 'tests': ['tp5o']}, 04:20:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'tests': ['tp5o']}, 04:20:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'talos_options': ['--disable-e10s', 04:20:37 INFO - '--xperf_path', 04:20:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:37 INFO - 'tests': ['tp5n']}, 04:20:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:37 INFO - 'talos_options': ['--xperf_path', 04:20:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:37 INFO - 'tests': ['tp5n']}}, 04:20:37 INFO - 'talos.zip': {'path': '', 04:20:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:37 INFO - Running post-action listener: _resource_record_post_action 04:20:37 INFO - ##### 04:20:37 INFO - ##### Running create-virtualenv step. 04:20:37 INFO - ##### 04:20:37 INFO - Running pre-action listener: _resource_record_pre_action 04:20:37 INFO - Running main action method: create_virtualenv 04:20:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:20:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:37 INFO - Using real prefix '/usr' 04:20:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:39 INFO - Installing pip.................done. 04:20:39 INFO - Return code: 0 04:20:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:39 INFO - Using env: {'DISPLAY': ':0', 04:20:39 INFO - 'HOME': '/home/cltbld', 04:20:39 INFO - 'LANG': 'en_US.UTF-8', 04:20:39 INFO - 'LANGUAGE': 'en_US:en', 04:20:39 INFO - 'LOGNAME': 'cltbld', 04:20:39 INFO - 'MAIL': '/var/mail/cltbld', 04:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:39 INFO - 'MOZ_NO_REMOTE': '1', 04:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:39 INFO - 'NO_EM_RESTART': '1', 04:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:39 INFO - 'PWD': '/builds/slave/test', 04:20:39 INFO - 'SHELL': '/bin/bash', 04:20:39 INFO - 'SHLVL': '1', 04:20:39 INFO - 'TERM': 'linux', 04:20:39 INFO - 'TMOUT': '86400', 04:20:39 INFO - 'USER': 'cltbld', 04:20:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:39 INFO - '_': '/tools/buildbot/bin/python'} 04:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:20:39 INFO - Cleaning up... 04:20:39 INFO - Return code: 0 04:20:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:20:39 INFO - Using env: {'DISPLAY': ':0', 04:20:39 INFO - 'HOME': '/home/cltbld', 04:20:39 INFO - 'LANG': 'en_US.UTF-8', 04:20:39 INFO - 'LANGUAGE': 'en_US:en', 04:20:39 INFO - 'LOGNAME': 'cltbld', 04:20:39 INFO - 'MAIL': '/var/mail/cltbld', 04:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:39 INFO - 'MOZ_NO_REMOTE': '1', 04:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:39 INFO - 'NO_EM_RESTART': '1', 04:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:39 INFO - 'PWD': '/builds/slave/test', 04:20:39 INFO - 'SHELL': '/bin/bash', 04:20:39 INFO - 'SHLVL': '1', 04:20:39 INFO - 'TERM': 'linux', 04:20:39 INFO - 'TMOUT': '86400', 04:20:39 INFO - 'USER': 'cltbld', 04:20:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:39 INFO - '_': '/tools/buildbot/bin/python'} 04:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:40 INFO - Downloading/unpacking psutil>=0.7.1 04:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:47 INFO - Installing collected packages: psutil 04:20:47 INFO - Running setup.py install for psutil 04:20:47 INFO - building 'psutil._psutil_linux' extension 04:20:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:20:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:20:47 INFO - building 'psutil._psutil_posix' extension 04:20:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:20:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:47 INFO - Successfully installed psutil 04:20:47 INFO - Cleaning up... 04:20:47 INFO - Return code: 0 04:20:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:47 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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:47 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 04:20:47 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 04:20:47 INFO - Using env: {'DISPLAY': ':0', 04:20:47 INFO - 'HOME': '/home/cltbld', 04:20:47 INFO - 'LANG': 'en_US.UTF-8', 04:20:47 INFO - 'LANGUAGE': 'en_US:en', 04:20:47 INFO - 'LOGNAME': 'cltbld', 04:20:47 INFO - 'MAIL': '/var/mail/cltbld', 04:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:47 INFO - 'MOZ_NO_REMOTE': '1', 04:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:47 INFO - 'NO_EM_RESTART': '1', 04:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:47 INFO - 'PWD': '/builds/slave/test', 04:20:47 INFO - 'SHELL': '/bin/bash', 04:20:47 INFO - 'SHLVL': '1', 04:20:47 INFO - 'TERM': 'linux', 04:20:47 INFO - 'TMOUT': '86400', 04:20:47 INFO - 'USER': 'cltbld', 04:20:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:47 INFO - '_': '/tools/buildbot/bin/python'} 04:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:20:49 INFO - Installing collected packages: mozsystemmonitor 04:20:49 INFO - Running setup.py install for mozsystemmonitor 04:20:49 INFO - Successfully installed mozsystemmonitor 04:20:49 INFO - Cleaning up... 04:20:49 INFO - Return code: 0 04:20:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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', '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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:20: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 blobuploader==1.2.4 04:20:49 INFO - Using env: {'DISPLAY': ':0', 04:20:49 INFO - 'HOME': '/home/cltbld', 04:20:49 INFO - 'LANG': 'en_US.UTF-8', 04:20:49 INFO - 'LANGUAGE': 'en_US:en', 04:20:49 INFO - 'LOGNAME': 'cltbld', 04:20:49 INFO - 'MAIL': '/var/mail/cltbld', 04:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:49 INFO - 'MOZ_NO_REMOTE': '1', 04:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:49 INFO - 'NO_EM_RESTART': '1', 04:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:49 INFO - 'PWD': '/builds/slave/test', 04:20:49 INFO - 'SHELL': '/bin/bash', 04:20:49 INFO - 'SHLVL': '1', 04:20:49 INFO - 'TERM': 'linux', 04:20:49 INFO - 'TMOUT': '86400', 04:20:49 INFO - 'USER': 'cltbld', 04:20:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:49 INFO - '_': '/tools/buildbot/bin/python'} 04:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:52 INFO - Downloading docopt-0.6.1.tar.gz 04:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:52 INFO - Running setup.py install for blobuploader 04:20:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:52 INFO - Running setup.py install for requests 04:20:53 INFO - Running setup.py install for docopt 04:20:53 INFO - Successfully installed blobuploader requests docopt 04:20:53 INFO - Cleaning up... 04:20:53 INFO - Return code: 0 04:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:53 INFO - Using env: {'DISPLAY': ':0', 04:20:53 INFO - 'HOME': '/home/cltbld', 04:20:53 INFO - 'LANG': 'en_US.UTF-8', 04:20:53 INFO - 'LANGUAGE': 'en_US:en', 04:20:53 INFO - 'LOGNAME': 'cltbld', 04:20:53 INFO - 'MAIL': '/var/mail/cltbld', 04:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:53 INFO - 'MOZ_NO_REMOTE': '1', 04:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:53 INFO - 'NO_EM_RESTART': '1', 04:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:53 INFO - 'PWD': '/builds/slave/test', 04:20:53 INFO - 'SHELL': '/bin/bash', 04:20:53 INFO - 'SHLVL': '1', 04:20:53 INFO - 'TERM': 'linux', 04:20:53 INFO - 'TMOUT': '86400', 04:20:53 INFO - 'USER': 'cltbld', 04:20:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:53 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:53 INFO - Running setup.py (path:/tmp/pip-szfvzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:53 INFO - Running setup.py (path:/tmp/pip-dKCbAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:53 INFO - Running setup.py (path:/tmp/pip-PjPxeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:53 INFO - Running setup.py (path:/tmp/pip-HWa7OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:53 INFO - Running setup.py (path:/tmp/pip-9wU8ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:54 INFO - Running setup.py (path:/tmp/pip-OqKzUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:54 INFO - Running setup.py (path:/tmp/pip-KUAOn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:54 INFO - Running setup.py (path:/tmp/pip-Cs9jaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:54 INFO - Running setup.py (path:/tmp/pip-3EC6eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:54 INFO - Running setup.py (path:/tmp/pip-RyRS0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:54 INFO - Running setup.py (path:/tmp/pip-ABbT_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:54 INFO - Running setup.py (path:/tmp/pip-FzHtrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:54 INFO - Running setup.py (path:/tmp/pip-gUR04d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:54 INFO - Running setup.py (path:/tmp/pip-b23nCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:54 INFO - Running setup.py (path:/tmp/pip-iv889l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:54 INFO - Running setup.py (path:/tmp/pip-BeroDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:54 INFO - Running setup.py (path:/tmp/pip-hcpQAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:54 INFO - Running setup.py install for manifestparser 04:20:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:54 INFO - Running setup.py install for mozcrash 04:20:55 INFO - Running setup.py install for mozdebug 04:20:55 INFO - Running setup.py install for mozdevice 04:20:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Running setup.py install for mozfile 04:20:55 INFO - Running setup.py install for mozhttpd 04:20:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Running setup.py install for mozinfo 04:20:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Running setup.py install for mozInstall 04:20:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Running setup.py install for mozleak 04:20:55 INFO - Running setup.py install for mozlog 04:20:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Running setup.py install for moznetwork 04:20:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:55 INFO - Running setup.py install for mozprocess 04:20:56 INFO - Running setup.py install for mozprofile 04:20:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:56 INFO - Running setup.py install for mozrunner 04:20:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:56 INFO - Running setup.py install for mozscreenshot 04:20:56 INFO - Running setup.py install for moztest 04:20:56 INFO - Running setup.py install for mozversion 04:20:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:56 INFO - Cleaning up... 04:20:56 INFO - Return code: 0 04:20:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:56 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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:56 INFO - Using env: {'DISPLAY': ':0', 04:20:56 INFO - 'HOME': '/home/cltbld', 04:20:56 INFO - 'LANG': 'en_US.UTF-8', 04:20:56 INFO - 'LANGUAGE': 'en_US:en', 04:20:56 INFO - 'LOGNAME': 'cltbld', 04:20:56 INFO - 'MAIL': '/var/mail/cltbld', 04:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:56 INFO - 'MOZ_NO_REMOTE': '1', 04:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:56 INFO - 'NO_EM_RESTART': '1', 04:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:56 INFO - 'PWD': '/builds/slave/test', 04:20:56 INFO - 'SHELL': '/bin/bash', 04:20:56 INFO - 'SHLVL': '1', 04:20:56 INFO - 'TERM': 'linux', 04:20:56 INFO - 'TMOUT': '86400', 04:20:56 INFO - 'USER': 'cltbld', 04:20:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:56 INFO - '_': '/tools/buildbot/bin/python'} 04:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:56 INFO - Running setup.py (path:/tmp/pip-krG6Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:56 INFO - Running setup.py (path:/tmp/pip-DkoY3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:57 INFO - Running setup.py (path:/tmp/pip-dgeoli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:57 INFO - Running setup.py (path:/tmp/pip-XaK9Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:57 INFO - Running setup.py (path:/tmp/pip-MfBThb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:57 INFO - Running setup.py (path:/tmp/pip-8HN4TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:57 INFO - Running setup.py (path:/tmp/pip-utH44H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:57 INFO - Running setup.py (path:/tmp/pip-DTIFPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:57 INFO - Running setup.py (path:/tmp/pip-4Ie37R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:57 INFO - Running setup.py (path:/tmp/pip-CZFB6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:57 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)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:57 INFO - Running setup.py (path:/tmp/pip-4GJKsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:57 INFO - Running setup.py (path:/tmp/pip-oVhdiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:57 INFO - Running setup.py (path:/tmp/pip-NHaZDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:57 INFO - Running setup.py (path:/tmp/pip-2ja3wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:57 INFO - Running setup.py (path:/tmp/pip-blnZnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:57 INFO - Running setup.py (path:/tmp/pip-u9PUsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:58 INFO - Running setup.py (path:/tmp/pip-ADpOMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:59 INFO - Downloading blessings-1.6.tar.gz 04:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:00 INFO - Installing collected packages: blessings 04:21:00 INFO - Running setup.py install for blessings 04:21:00 INFO - Successfully installed blessings 04:21:00 INFO - Cleaning up... 04:21:00 INFO - Return code: 0 04:21:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:00 INFO - Reading from file tmpfile_stdout 04:21:00 INFO - Current package versions: 04:21:00 INFO - argparse == 1.2.1 04:21:00 INFO - blessings == 1.6 04:21:00 INFO - blobuploader == 1.2.4 04:21:00 INFO - docopt == 0.6.1 04:21:00 INFO - manifestparser == 1.1 04:21:00 INFO - mozInstall == 1.12 04:21:00 INFO - mozcrash == 0.17 04:21:00 INFO - mozdebug == 0.1 04:21:00 INFO - mozdevice == 0.48 04:21:00 INFO - mozfile == 1.2 04:21:00 INFO - mozhttpd == 0.7 04:21:00 INFO - mozinfo == 0.9 04:21:00 INFO - mozleak == 0.1 04:21:00 INFO - mozlog == 3.1 04:21:00 INFO - moznetwork == 0.27 04:21:00 INFO - mozprocess == 0.22 04:21:00 INFO - mozprofile == 0.28 04:21:00 INFO - mozrunner == 6.11 04:21:00 INFO - mozscreenshot == 0.1 04:21:00 INFO - mozsystemmonitor == 0.0 04:21:00 INFO - moztest == 0.7 04:21:00 INFO - mozversion == 1.4 04:21:00 INFO - psutil == 3.1.1 04:21:00 INFO - requests == 1.2.3 04:21:00 INFO - wsgiref == 0.1.2 04:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:00 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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:21:00 INFO - Using env: {'DISPLAY': ':0', 04:21:00 INFO - 'HOME': '/home/cltbld', 04:21:00 INFO - 'LANG': 'en_US.UTF-8', 04:21:00 INFO - 'LANGUAGE': 'en_US:en', 04:21:00 INFO - 'LOGNAME': 'cltbld', 04:21:00 INFO - 'MAIL': '/var/mail/cltbld', 04:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:00 INFO - 'MOZ_NO_REMOTE': '1', 04:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:00 INFO - 'NO_EM_RESTART': '1', 04:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:00 INFO - 'PWD': '/builds/slave/test', 04:21:00 INFO - 'SHELL': '/bin/bash', 04:21:00 INFO - 'SHLVL': '1', 04:21:00 INFO - 'TERM': 'linux', 04:21:00 INFO - 'TMOUT': '86400', 04:21:00 INFO - 'USER': 'cltbld', 04:21:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:00 INFO - '_': '/tools/buildbot/bin/python'} 04:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:21:00 INFO - Cleaning up... 04:21:00 INFO - Return code: 0 04:21:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:00 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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:21:00 INFO - Using env: {'DISPLAY': ':0', 04:21:00 INFO - 'HOME': '/home/cltbld', 04:21:00 INFO - 'LANG': 'en_US.UTF-8', 04:21:00 INFO - 'LANGUAGE': 'en_US:en', 04:21:00 INFO - 'LOGNAME': 'cltbld', 04:21:00 INFO - 'MAIL': '/var/mail/cltbld', 04:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:00 INFO - 'MOZ_NO_REMOTE': '1', 04:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:00 INFO - 'NO_EM_RESTART': '1', 04:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:00 INFO - 'PWD': '/builds/slave/test', 04:21:00 INFO - 'SHELL': '/bin/bash', 04:21:00 INFO - 'SHLVL': '1', 04:21:00 INFO - 'TERM': 'linux', 04:21:00 INFO - 'TMOUT': '86400', 04:21:00 INFO - 'USER': 'cltbld', 04:21:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:00 INFO - '_': '/tools/buildbot/bin/python'} 04:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:00 INFO - Downloading/unpacking jsonschema 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:02 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:03 INFO - warning: no files found matching '*.txt' 04:21:03 INFO - no previously-included directories found matching 'build' 04:21:03 INFO - no previously-included directories found matching 'dist' 04:21:03 INFO - no previously-included directories found matching '.git*' 04:21:03 INFO - Installing collected packages: jsonschema, functools32 04:21:03 INFO - Running setup.py install for functools32 04:21:03 INFO - warning: no files found matching '*.txt' 04:21:03 INFO - no previously-included directories found matching 'build' 04:21:03 INFO - no previously-included directories found matching 'dist' 04:21:03 INFO - no previously-included directories found matching '.git*' 04:21:03 INFO - Successfully installed jsonschema functools32 04:21:03 INFO - Cleaning up... 04:21:03 INFO - Return code: 0 04:21:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:03 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 0x7f9bc8b08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:21:03 INFO - Using env: {'DISPLAY': ':0', 04:21:03 INFO - 'HOME': '/home/cltbld', 04:21:03 INFO - 'LANG': 'en_US.UTF-8', 04:21:03 INFO - 'LANGUAGE': 'en_US:en', 04:21:03 INFO - 'LOGNAME': 'cltbld', 04:21:03 INFO - 'MAIL': '/var/mail/cltbld', 04:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:03 INFO - 'MOZ_NO_REMOTE': '1', 04:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:03 INFO - 'NO_EM_RESTART': '1', 04:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:03 INFO - 'PWD': '/builds/slave/test', 04:21:03 INFO - 'SHELL': '/bin/bash', 04:21:03 INFO - 'SHLVL': '1', 04:21:03 INFO - 'TERM': 'linux', 04:21:03 INFO - 'TMOUT': '86400', 04:21:03 INFO - 'USER': 'cltbld', 04:21:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:03 INFO - '_': '/tools/buildbot/bin/python'} 04:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:03 INFO - Downloading/unpacking flake8 04:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:06 INFO - no previously-included directories found matching 'docs/_build' 04:21:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:06 INFO - Running setup.py install for pep8 04:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:06 INFO - no previously-included directories found matching 'docs/_build' 04:21:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:06 INFO - Cleaning up... 04:21:06 INFO - Return code: 0 04:21:06 INFO - Running post-action listener: _resource_record_post_action 04:21:06 INFO - Running post-action listener: _start_resource_monitoring 04:21:06 INFO - Starting resource monitoring. 04:21:06 INFO - ##### 04:21:06 INFO - ##### Running install step. 04:21:06 INFO - ##### 04:21:06 INFO - Running pre-action listener: _resource_record_pre_action 04:21:06 INFO - Running main action method: install 04:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:06 INFO - Reading from file tmpfile_stdout 04:21:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:06 INFO - Reading from file tmpfile_stdout 04:21:06 INFO - Output received: 04:21:06 INFO - Usage: mozinstall [options] installer 04:21:06 INFO - Options: 04:21:06 INFO - -h, --help show this help message and exit 04:21:06 INFO - -d DEST, --destination=DEST 04:21:06 INFO - Directory to install application into. [default: 04:21:06 INFO - "/builds/slave/test"] 04:21:06 INFO - --app=APP Application being installed. [default: firefox] 04:21:06 INFO - mkdir: /builds/slave/test/build/application 04:21:06 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'] 04:21:06 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 04:21:22 INFO - Reading from file tmpfile_stdout 04:21:22 INFO - Output received: 04:21:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:22 INFO - Running post-action listener: _resource_record_post_action 04:21:22 INFO - ##### 04:21:22 INFO - ##### Running run-tests step. 04:21:22 INFO - ##### 04:21:22 INFO - Running pre-action listener: _resource_record_pre_action 04:21:22 INFO - Running main action method: run_tests 04:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:22 INFO - Python 2.7.3 04:21:22 INFO - Return code: 0 04:21:22 INFO - grabbing minidump binary from tooltool 04:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:22 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 0x1261410>, '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 0x1262310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12627a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:21:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:21:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:22 INFO - Return code: 0 04:21:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:21:23 INFO - Return code: 0 04:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:21:23 INFO - Using env: {'DISPLAY': ':0', 04:21:23 INFO - 'HOME': '/home/cltbld', 04:21:23 INFO - 'LANG': 'en_US.UTF-8', 04:21:23 INFO - 'LANGUAGE': 'en_US:en', 04:21:23 INFO - 'LOGNAME': 'cltbld', 04:21:23 INFO - 'MAIL': '/var/mail/cltbld', 04:21:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:23 INFO - 'MOZ_NO_REMOTE': '1', 04:21:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:23 INFO - 'NO_EM_RESTART': '1', 04:21:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:23 INFO - 'PWD': '/builds/slave/test', 04:21:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:23 INFO - 'SHELL': '/bin/bash', 04:21:23 INFO - 'SHLVL': '1', 04:21:23 INFO - 'TERM': 'linux', 04:21:23 INFO - 'TMOUT': '86400', 04:21:23 INFO - 'USER': 'cltbld', 04:21:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892', 04:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:23 INFO - '_': '/tools/buildbot/bin/python'} 04:21:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:21:23 INFO - mozversion application_buildid: 20160419025944 04:21:23 INFO - mozversion application_changeset: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a 04:21:23 INFO - mozversion application_display_name: Nightly 04:21:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:23 INFO - mozversion application_name: Firefox 04:21:23 INFO - mozversion application_remotingname: firefox 04:21:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:21:23 INFO - mozversion application_vendor: Mozilla 04:21:23 INFO - mozversion application_version: 48.0a1 04:21:23 INFO - mozversion platform_buildid: 20160419025944 04:21:23 INFO - mozversion platform_changeset: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a 04:21:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:21:23 INFO - mozversion platform_version: 48.0a1 04:21:23 INFO - using testdate: 1461064883 04:21:23 INFO - actual date: 1461064883 04:21:23 INFO - starting webserver on 'localhost:53047' 04:21:23 INFO - SUITE-START | Running 2 tests 04:21:23 INFO - TEST-START | dromaeo_css 04:21:23 INFO - operating with platform_type : linux_ 04:21:23 INFO - Initialising browser for dromaeo_css test... 04:21:23 INFO - TEST-INFO | started process 29997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm1O421/profile http://localhost:53047/getInfo.html) 04:21:28 INFO - PROCESS | 29997 | __metrics Screen width/height:1600/1200 04:21:28 INFO - PROCESS | 29997 | colorDepth:24 04:21:28 INFO - PROCESS | 29997 | Browser inner width/height: 1024/697 04:21:28 INFO - PROCESS | 29997 | __metrics 04:21:29 ERROR - PROCESS | 29997 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:21:30 INFO - TEST-INFO | 29997: exit 0 04:21:30 INFO - Browser initialized. 04:21:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:30 INFO - TEST-INFO | started process 30080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm1O421/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:42 INFO - PROCESS | 30080 | RSS: Main: 154165248 04:21:42 INFO - PROCESS | 30080 | 04:22:33 INFO - PROCESS | 30080 | 1461064953371 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:24:45 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53047/tests/dromaeo/cssquery-ext.html) 04:24:46 INFO - PROCESS | 30080 | RSS: Main: 271908864 04:24:46 INFO - PROCESS | 30080 | 04:27:48 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-ext.html (next: http://localhost:53047/tests/dromaeo/cssquery-jquery.html) 04:27:49 INFO - PROCESS | 30080 | RSS: Main: 239996928 04:27:49 INFO - PROCESS | 30080 | 04:30:51 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53047/tests/dromaeo/cssquery-mootools.html) 04:30:52 INFO - PROCESS | 30080 | RSS: Main: 229883904 04:30:52 INFO - PROCESS | 30080 | 04:33:54 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53047/tests/dromaeo/cssquery-prototype.html) 04:33:55 INFO - PROCESS | 30080 | RSS: Main: 229126144 04:33:55 INFO - PROCESS | 30080 | 04:36:58 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53047/tests/dromaeo/cssquery-yui.html) 04:36:58 INFO - PROCESS | 30080 | RSS: Main: 218148864 04:36:58 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-yui.html (next: http://localhost:53047/tests/dromaeo/cssquery-dojo.html) 04:40:01 INFO - PROCESS | 30080 | RSS: Main: 280059904 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | __start_tp_report 04:40:01 INFO - PROCESS | 30080 | _x_x_mozilla_page_load 04:40:01 INFO - PROCESS | 30080 | _x_x_mozilla_page_load_details 04:40:01 INFO - PROCESS | 30080 | |i|pagename|runs| 04:40:01 INFO - PROCESS | 30080 | |0;dojo.html;2563.9743602563976;2645.1932160690994;2651.535981203289;2667.4531720997197;2692.1654287170973;4479.955200447995;4567.748773817439;4605.516420775816;4607.35497030416;4634.860954171376;4622.375979242801;4640.095181439612;4694.835680751175;4734.431868175824;4754.429468463789;4204.8738537843765;4209.705320627558;4231.788410579474;4266.168097221043;4327.567243275679;4231.978840105795;4328.523862375137;4382.298832186851;4399.164158809832;4402.647788176954;4306.870793876157;4313.352997050436;4355.346697995295;4363.54182810805;4419.690621656486;4105.4662893823615;4178.247915375231;4190.392393103013;4198.580141985807;4203.76879271643;4190.832366705328;4234.343676730112;4243.045314804175;4245.150969806051;4247.129338485603;4490.461144662629;4511.729296242203;4535.659825513099;4552.226121559343;4566.794494247767;4816.084943860656;4940.90118197634;4996.325496058022;4998.300237966688;4999.075171093359;4975.179095449246;5003.774830132653;5003.924941125886;5041.470645582198;5069.645124841262;4534.478534968455;4626.1210370029585;4675.7895894684825;4677.970846413784;4712.481627021025;5113.769880355393;5114.43741188469;5114.897702045938;5135.306733590917;5165.173572228426;4846.975765121152;4913.361263035782;4918.01639672067;4923.113839508851;4965.9751701241985;4861.732604706775;4904;4973.52751488608;4980.676256043345;4988;4969.627277954168;4980.526849949249;5004.724740139254;5009.423916249605;5065.037642847848;4958.950410495849;4974.303597496353;4983.352164218701;4992.400911890524;5040.722760248148;4036.8788936331957;4108.77401742907;4123.670106391482;4179.435776170239;4196.559361267084;3576.2668652926086;3587.7847329160336;3602.4596310553625;3632.164602141522;3633.0554055945117;4258.04194056341;4263.360495925574;4265.594768496988;4269.210196113729;4290.89272768177;4744.335792988984;4983.152864013126;5020.146575082244;5064.848054558369;5071.5689166420525;4283.635890949305;4285.7000009999;4302.9354559681005;4303.677224208197;4312.353147027971;4310.116426132698;4443.022535042285;4445.4220951276775;4448.710833795858;4486.057927835126;4695.413073365829;4740.360051393018;4742.7865746040825;4781.450133234723;4793.688410253322;4961.1318019345745;4993.500649935123;4998.425181104074;4999.450060493416;5032.496750324938;4562.452505699337;4707.105649926503;4726.338312636165;4736.455307639528;4785.665003449725;4820.469748327751;4845.224764037737;4850.466448690711;4867.537583929521;4907.901841963069;4910.263460480814;4912.066707325596;4913.950860491493;4919.040787046635;4955.45489996093;4672.9532704673875;4767.856964291077;4786.2820576912345;4789.090072886141;4825.782839772289;4811;4833.419989601271;4844.0554091951735;4864.902701945871;4880.682755620874;4747.976260118678;4769.785359658893;4771.117343291502;4771.284307353924;4828.830990915301;4652.162610730101;4769.546893045155;4803.519648035169;4879.609631229564;4891.315215869852;4695.295705644181;4749.05018996209;4750.168720473835;4757.643176761688;4788.760561971818 04:40:01 INFO - PROCESS | 30080 | |1;ext.html;556.9832905012851;592.7480820651224;600.3606159440193;602.2712517853398;609.5062998970836;26335.868320658396;27038.729612703868;27066.729332706665;27089.32276693079;27098.864505677444;26542.203733887967;37311.25377492449;38254.80872595633;38285.80857095711;38319.42520862189;7710.306072453492;7947.324477419397;7950.4037197210155;7950.960245198795;7953.920460795404;7708.768736937901;7826.334761545276;7834.882476762825;7841.529508229524;7841.725539606115;7801.180876008023;7867.6852925882895;7870.134285228621;7871.8032049198655;7878.6848526059175;7773.7279195228175;7821.256980586835;7832.608369581498;7838.9216107838765;7844;7611.3910887128895;7711.884321735179;7721.806954826118;7722.845543089163;7726.072871255486;37778.62221377779;38391;38405.61594384049;38421.423678644845;38486;3106.3631955449077;3216.3567286542784;3244.5619841321354;3286.2277364819247;3290.0952238134464;27985.30036749077;28070;28712.282192945135;28790.42419151626;28908;3136.1375621703987;3141.5130654748323;3166.5250212468313;3194.520821876714;3225.741940644743;233426.83286583627;233797;234278;234330;234866;43958.340624890654;44232.3365149523;44270.77864610721;49709.75145124324;49965.500344996086;51956.48043519592;52457.47542524602;52482.475175248524;52520.212196817076;52547.73726131345;13216.537421190213;13861.4455421782;13870.237136957565;13871.930640346734;13879.653008674662;9518.666846660333;9571;9615.951920240354;9628.47043412619;9670.371425857438;17276.13619319029;17345.3929112483;17435.825641743675;17488.213030413663;17527.64944701099;6455.870882582322;6574.178227721535;6593.439557637558;6846.383825455733;6863.142107236596;867.5618812499647;893.8257039877292;896.7356028000488;946.4274114160834;1008.996048931318;25882.6117608236;26142.34644133912;26474.6028809568;27473.587896181172;27601;988.9159421449258;993.5529011944653;1006.7684432580547;1030.685640879524;1110.9388983605818;14077.225752583501;14699.191544464944;14761.55715328542;15006.099634021994;15037.774433383507;331202;332574;336920;337353;338246;47433;48185.5181448188;48239.51760482421;48317;48344.51655483471;1111.6553868300853;1156.4217891054473;1165.8600967883908;1166.393475392791;1248.0701877101435;26221.34446638849;27004.594931075655;27097;27365;27626;37381.439278410304;37784.62215377811;37834.81082594569;37880.91654959004;37898.242035159696;223443;224106;225274;225792;226203;24240.63639045451;24668.259952201464;36931.44602830906;38464.2307153861;38710.80644596759;38210;38502.42246366363;38822.51877896661;39307.6069239304;39611.60388396194;32944.34111317712;33044.339113218084;33174.83412582921;33443.33113337768;33738.49392259069;32761.344773103927;32987.67012329846;33249.335013300086;33434.33131337408;33962.49056264207;31576;33596;35394;36125;36772.63227367692;29335;29644.851775740983;29985.400291994476;30058.84970575133;30259.546106808855;23534.529309414058;23544.529109418057;23725.58028045177;23820.285391438283;24073.638895416934 04:40:01 INFO - PROCESS | 30080 | |2;jquery.html;377.1683438019167;378.8636091007237;385.75504554607835;389.8849839297407;392.29974495525494;15846.920765396171;16290.83709162908;17138.914305428487;17152.48542543726;17176;12668.366581670902;14906.105633661988;15595.1422671753;15640.530784076467;15665.295061722221;4683.882902927428;4909.754512274372;4955.851324460272;4957.380327459067;4957.603391728653;3424.777389469689;5237.764300606463;5574.219609254707;5582.748776305056;5595.356533998602;5482.2873026506695;5537.169424586325;5554.472325129106;5575.107982722765;5580.414056524068;5437.456254374551;5564.221009058735;5566.749496272678;5575;5584;3341.114604629775;3522.418800897849;3526.1360966563097;3526.34762568923;3527.171114788023;11908.16642835002;12303.815442768366;16137.789665775113;18228.635427291512;19489.122989465508;1976.2984140630012;2043.2439997200981;2131.9659964917005;2472.085328428475;2488.042103790036;8825.382223244376;8966.193042626195;9330.253579713606;9499.620015199383;11320.547178112865;1664.0847533856331;1742.712452445345;1774.8136445673147;1788.642271545696;1791.1777810782764;65251.673741631465;65792.3420765791;67626.66186669085;68754;68967;9821.116099551075;9826;9826.508674566243;9943.055409736064;9978.351407158512;13959;14052.648683782987;14071.71856562863;14104;14118.43526258938;6834.829129271808;6884.139482564679;6934.410575101173;7013.89479157813;7043.964780176067;6393.712282947278;6420.646864422408;6454.741810327629;6509.609423434609;6531.248906375828;4289.0992891492515;4363.192809330284;4370.191514569815;4415.337699345124;4433.844815431445;1615.6849414364085;1697.7029019921465;1768.4871387297796;1827.950593786556;1864.7855496618063;834.7871292820413;893.9284857211408;921.4195057114109;961.5432669481941;964.3972517176765;16257.268422920997;16863.15684215809;17108.48674539766;17143.828561714225;17563.38528151534;873.3188113271658;879.9340049496313;907.2288554728428;917.4724533393193;932.7295084425441;9241.722748317427;9326.487043212688;9535.332526723063;9650.662226822027;9711;359879;371325.43011854845;373635;374158;375122;77324;77519.22480775233;78177.60911195521;78319.60840195762;78685;920.0661328751323;925.9861102083474;935.854942483916;939.4973689076448;948.4972964328916;14867.92566037163;14963.551093467213;15127.243637817845;15339.386424542894;15462.768058479356;24473.51052978966;32954.67045329516;33116.668833311356;33378;34771.304573908885;46861.76569117133;49322.50677493179;50135.24797127973;50608.493915060375;51563;5732.799352022659;6950.374466298057;7941.880871786812;7946.801329966797;8001.879971800311;11535.711607209887;11644.708882278012;12020.459079341275;12137.575184868487;12138.575149870065;9672.226221902372;10350.22373322019;10412.583496660049;10508.527116279633;10842.186835987175;8033.277005069338;10097.747556310856;10195.184385249015;10243.180545556188;10260;9909.851352229578;10129.442880641636;10247.897521024992;10688.198385120992;10772.192085593768;7251.854962900607;7385.187629360874;7459.776206713807;7460.104787425544;7485.887711684438;8441.409101362846;9722.368046076983;9818.803623927339;9845.704628861145;9881.50592470388 04:40:01 INFO - PROCESS | 30080 | |3;mootools.html;1259.9055070869688;1422.743906096902;1461;1577.2271586922411;1744.3197153110282;6577.112089867873;7512.962435187823;7695.384369250461;7695.846083078335;7700.884486732696;7390.8521829563515;7543.3211011009;7544.283293087148;7556.886646700304;7562.508436951608;1862.0689655172414;1930.1314408516155;1938.7479627648386;2195.056125865877;2226.9888650556722;2185.2897808212315;2261.2537862505415;2261.502469456717;2263.954720905581;2264.932052038433;2130.2650585547963;2138.8075073243403;2148.2803260907613;2150;2214.3799736073925;1735.305877648938;2152.45112496314;2169.8481106322483;2185.63936950403;2187.278198194592;2213.8007579317937;2233.8547994380474;2237.026893301419;2242.4505996031075;2243.9214627488122;7443.516171448839;7488.101427828696;7497.437692173109;7500.8124796879965;7507.3243408092985;4343.478782546114;4467.888302792424;4476.93284600728;4487.0352874131895;4491.124230775;2758.3517873299757;2792.3577577157366;2863.7565806906437;2884.812487188326;2900.463414268346;915.4873270968279;943.6508491858057;956.9760755981087;960.9855852162223;963.6001059560274;10376.118029967462;10399.220058495568;10414.323069000491;10423.895761042368;10436.739081523023;3982.8008599569907;4011.799410029487;4056.8377264909664;4229.450171477688;4233.343831706091;8909.5099769512;8929.910700893039;8950.462972221687;8951.552422378854;8965.417247878868;4489.304157855538;4504.752238626841;4515.774211289488;4516.209663308908;4524;3679.466477360821;4036.899077523027;4059.106996460774;4083.0404854859084;4200.432941552913;3610.7833529988284;3639.926221764586;3699.9445008324897;3706.9814650926573;3759.342115129841;1220.6277085489012;1221.1146918484028;1227.4660522672666;1242.9564965226173;1243.247835059794;738.6823665823747;808.7331180710352;826.5123577089546;835.4694768821842;847.5296210603175;5054.393472783216;5229.241759944863;5276.762545685377;5294.41761406245;5304.761285742151;386.94582758413844;394.80457173699205;395.28848073467645;410.18168753337284;414.37429481482576;3575.570931488186;3628.6189950054863;3693.1874987502706;3715.535558055243;3718;9254.259659227246;9341.813163736688;9706.95146524277;9727.319087663936;9732.70801875945;9601.135897769234;9631.903680963242;9634.614615415305;9640.566174522164;9649.131578158;7195.352418282275;7204.567725936356;7273.709051637981;7287.562746235137;7293.562386256842;5003.899922001612;5091.312672789126;5094.847154585368;5149.536541711264;5157.484251574812;8479.915200847912;8523.872141917753;8587.699430519902;8598.441101328393;8818.074102219174;8449.95775021121;8674.262687671619;8688.869666955126;8707.695230666895;8797.560121994004;6078.665673388006;6316.652584107918;6319.304876463493;6419.422251997343;6489.480841532761;6724;7187.065681461377;7385.9261407387385;7402.555846649218;7431.925680743123;6558.409743123142;6720.529562930548;6734.831629209309;6795.558288711218;6831.11195544576;6525.2169739631545;6578.276389597237;6774.729010839511;6813.318668133147;6843.657817109025;5994.520438365008;6039.365866583946;6058;6065.029595264737;6156.107364432043;4513.796879140381;4579.816807327803;4641.930371044505;4671.346011558317;4697.483276839476;4446.933296000628;4583.72497650142;4601.953980460153;4711.19909615373;4717.481077081587 04:40:01 INFO - PROCESS | 30080 | |4;prototype.html;301.88377474672245;313.64401404406;318.90911090339245;320.63127403486004;321.4246498767207;5066.36670416198;5100.744962751857;5110.003549307887;5154.123798954178;5158.019976204523;4789.784459699314;4894.167991441454;5045.64680472367;5050.64645474816;5056.393232812058;3964.1278918638;3967.6627486663524;3991.221711766214;4008.6191811777835;4018.2566225248274;4000.2999475091888;4009.1781184857036;4009.558948515661;4012.638862502374;4014.7189696721243;3675.577308609504;3819.2361527694434;3915.5888631693547;3926.3325234710023;3974.085960229149;3933;3948.7828169450668;3950.348192548226;3973.7417067890497;3980.900477488057;3515.6835884770494;3526.8589256429714;3530.5233793437815;3531.858725650971;3536.3811333016874;4781.163296423112;4816.229403295491;4849.151398505247;4869.245266983623;4880.633952453581;4525.773711314454;4547.113312903985;4563.224251877189;4565.383673204141;4566.862994110182;5283.788648454057;5289.682619042831;5295.338082739658;5303.946960530384;5346.866328341784;3723.5345581802276;3855.267499175176;3862.594427585091;3863.150106976461;3864.285107255139;5571.303587051619;5582.637128586629;5588.161775733632;5600.635958662674;5618.381977982419;3951.150502641946;3955.3078211312904;3956.6241207085855;3962.7424217425773;3967.8016099194924;3912.921741565153;4012.8194231259663;4019.33680942647;4019.738716983387;4024.2353952748886;4518.322251662277;4536.523665015192;4536.637069034536;4546.954530454719;4559.635229181657;5296.602754793406;5319.202119682079;5326.97336513315;5332.733363331896;5350.117230656976;1297.9740405191844;1316.960491185266;1371.4856928651755;1392.5056604905315;1398.6573289544126;939.3096074385321;946.8248374050822;959.5154447004218;967.4920666649924;969.4522594734094;4637.420322459692;4661.7367842510375;4666.32338310943;4678.0410015946645;4682.157211701926;5450.591205659592;5452.59105567084;5459.590530710213;5466.262054622654;5470.56235501159;4460.643148548108;4665.95334046662;4669.18289299378;4670.556297151765;4684.531546845288;2915.9854200729283;2924.4589750896153;2931.4137172565574;2932.135020169055;2937.6327959005125;5182.53357197854;5184.403793563713;5194.753259217836;5195.558377537952;5199.532042116228;5451.509364157245;5593.524550413179;5594.1608758686525;5603.551715862803;5611.943880561143;5172.974135129375;5179.974100129551;5182.637215394886;5183.222516622537;5190.92213616796;5458.263134476795;5458.754356054066;5479.589030822624;5487.341519017744;5487.6158668894395;5149.871253218699;5279.788808447619;5292.153255479105;5316.149416093406;5361.839144825662;5152.922706159336;5171.120909445328;5173.870653233699;5179.378474583074;5181.974090129676;3942.2115576885312;3944.2900277950243;3945.704072194654;3951.545572259227;3953.9011524712114;5244.7902083916215;5275.498827611371;5432.375276843056;5439.456054394529;5445.53712934405;5225.16397376418;5338.919916201337;5346.117890548016;5346.43862394443;5352.116900711339;5342.893142137058;5355.839324820262;5357.946420535744;5373.328333958255;5396.676199428047;5145.552479838442;5211.530962213419;5247.947520524746;5265.104932161618;5273.235380869675;5343.65266257692;5354.384245811626;5387.649802762808;5389.730513474389;5399.136138217867;5245.396779370269;5263.947360526499;5281.15501519755;5296.735163241746;5302.469753024667 04:40:01 INFO - PROCESS | 30080 | |5;yui.html;611.0406661541379;684.3396122741557;689.7137687859539;692.0691669704246;698.6506746626685;11588.362640054804;11932.403379831017;11965.461554230069;12649.557265495687;12773.552925647604;13050.543230986917;13057;13073.869261307384;13163.80254296184;13171.341432928339;644.4618743349309;793.9285464308211;813.0812182234067;821.1008945204991;829.6971605364029;801.587182600961;806;806.1173015547965;807.8505476486839;812.3704129299811;838.4717627894418;842.1326034184799;843.1063073142489;844.2907957315854;844.9366297527679;661.8577005943721;677.7695583501584;678.4775722693498;802.3300544045729;838.5052818836886;605.7576969212306;606.0182504342948;608.5831205624162;610.7587502936316;613.2150846915955;12271.07966902477;12288.324142172178;12339.568115116017;12417.19288246261;12423;10379.221558383077;10481.58073677052;10613.150947924225;10717.732056698567;11001.504932278067;9392.436453812794;9488.430694158373;9522.333436659437;9743.123118919331;9946.254030947708;2915;2986.074316961749;3134.843257837099;3355.4966754986704;3381.2730262993327;49324.753376233246;49794.751026245;50114.49885501171;50932.49067509315;51149;8995.775105622412;9010.41432306911;9092.8636070459;10069.395836249849;10183.236257280734;17023;17446.912765436344;17529.298828046736;17553.736693949602;17669.469915902544;5873.412658734178;5923.259592550931;6147.44672979434;6213.565050446426;6385.233771947396;3413.6245013048547;3465.8267086645565;3486.38988177068;3492.5285086513504;3520.7887526748477;2679.812413131062;2742.780577553791;2746.4507098579966;2748.3403983043927;2748.491529067129;492.11910679883323;498.8603191106496;500.4670026421849;503.8639567316877;507.4519518919558;487.29585748592945;497.53729032000587;543.7661805423627;573.5755540899787;581.7585701933734;7128.28717128283;7317.634118294171;7346.742863999734;7476.850462990818;7586.81032974169;426.45413870246136;545.2720617975048;552.4889477233543;555.2171438272097;560.8698472577759;3488.5464889564196;3615.81920903959;3675.1363429594026;3710.7588006779474;3716.8141592920247;41221.38167927483;42638.57361426408;47327.29009064867;47464;47649.5235047652;39129.6087039126;39466.21067578632;40181;40336.79831600823;41077.38383924244;35781;36035.459468108;36376.45435318472;36978.260434791155;37304.44043339406;7726;7834.608269586612;7984.84030319402;7987.361011119213;8193.631286592237;24877.751222487543;25285;26403.471930561664;27329.590056149573;27497.17508474749;33663.4950475748;34198.65801342054;34441.311173776885;34606.480902785974;35446;9985.350952188084;10205.948970255102;10213.540390682585;10639.095676867553;11021.779564408827;11931.224470409396;12037.759244814879;12093;12116.818247726114;12679.429425675682;10324.690259292232;10519.631812886511;10812.783744325227;11190.32858028521;11210.719732006764;9975.700728978143;10374.22193335518;10434.843477347695;10522.368657880552;10662.253642244968;9158.633654653739;9625.422474651543;9761.365511241747;9870.062344077302;9946.651867184613;8981.281497480055;9205.447673139633;9214.539273036455;9351.158395744416;9581;8556.27271681914;8971.372003959661;9510.47692376926;9548.283878709264;9551.808963820824 04:40:01 INFO - PROCESS | 30080 | __end_tp_report 04:40:01 INFO - PROCESS | 30080 | __start_cc_report 04:40:01 INFO - PROCESS | 30080 | _x_x_mozilla_cycle_collect,1091 04:40:01 INFO - PROCESS | 30080 | __end_cc_report 04:40:01 INFO - PROCESS | 30080 | __startTimestamp1461066001791__endTimestamp 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | ------- Summary: start ------- 04:40:01 INFO - PROCESS | 30080 | Number of tests: 6 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | [#0] dojo.html Cycles:165 Average:4584.00 Median:4740.36 stddev:484.79 (10.2%) stddev-sans-first:459.65 04:40:01 INFO - PROCESS | 30080 | Values: 2564.0 2645.2 2651.5 2667.5 2692.2 4480.0 4567.7 4605.5 4607.4 4634.9 4622.4 4640.1 4694.8 4734.4 4754.4 4204.9 4209.7 4231.8 4266.2 4327.6 4232.0 4328.5 4382.3 4399.2 4402.6 4306.9 4313.4 4355.3 4363.5 4419.7 4105.5 4178.2 4190.4 4198.6 4203.8 4190.8 4234.3 4243.0 4245.2 4247.1 4490.5 4511.7 4535.7 4552.2 4566.8 4816.1 4940.9 4996.3 4998.3 4999.1 4975.2 5003.8 5003.9 5041.5 5069.6 4534.5 4626.1 4675.8 4678.0 4712.5 5113.8 5114.4 5114.9 5135.3 5165.2 4847.0 4913.4 4918.0 4923.1 4966.0 4861.7 4904.0 4973.5 4980.7 4988.0 4969.6 4980.5 5004.7 5009.4 5065.0 4959.0 4974.3 4983.4 4992.4 5040.7 4036.9 4108.8 4123.7 4179.4 4196.6 3576.3 3587.8 3602.5 3632.2 3633.1 4258.0 4263.4 4265.6 4269.2 4290.9 4744.3 4983.2 5020.1 5064.8 5071.6 4283.6 4285.7 4302.9 4303.7 4312.4 4310.1 4443.0 4445.4 4448.7 4486.1 4695.4 4740.4 4742.8 4781.5 4793.7 4961.1 4993.5 4998.4 4999.5 5032.5 4562.5 4707.1 4726.3 4736.5 4785.7 4820.5 4845.2 4850.5 4867.5 4907.9 4910.3 4912.1 4914.0 4919.0 4955.5 4673.0 4767.9 4786.3 4789.1 4825.8 4811.0 4833.4 4844.1 4864.9 4880.7 4748.0 4769.8 4771.1 4771.3 4828.8 4652.2 4769.5 4803.5 4879.6 4891.3 4695.3 4749.1 4750.2 4757.6 4788.8 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | [#1] ext.html Cycles:180 Average:41665.35 Median:185545.75 stddev:70594.39 (38.0%) stddev-sans-first:70724.95 04:40:01 INFO - PROCESS | 30080 | Values: 557.0 592.7 600.4 602.3 609.5 26335.9 27038.7 27066.7 27089.3 27098.9 26542.2 37311.3 38254.8 38285.8 38319.4 7710.3 7947.3 7950.4 7951.0 7953.9 7708.8 7826.3 7834.9 7841.5 7841.7 7801.2 7867.7 7870.1 7871.8 7878.7 7773.7 7821.3 7832.6 7838.9 7844.0 7611.4 7711.9 7721.8 7722.8 7726.1 37778.6 38391.0 38405.6 38421.4 38486.0 3106.4 3216.4 3244.6 3286.2 3290.1 27985.3 28070.0 28712.3 28790.4 28908.0 3136.1 3141.5 3166.5 3194.5 3225.7 233426.8 233797.0 234278.0 234330.0 234866.0 43958.3 44232.3 44270.8 49709.8 49965.5 51956.5 52457.5 52482.5 52520.2 52547.7 13216.5 13861.4 13870.2 13871.9 13879.7 9518.7 9571.0 9616.0 9628.5 9670.4 17276.1 17345.4 17435.8 17488.2 17527.6 6455.9 6574.2 6593.4 6846.4 6863.1 867.6 893.8 896.7 946.4 1009.0 25882.6 26142.3 26474.6 27473.6 27601.0 988.9 993.6 1006.8 1030.7 1110.9 14077.2 14699.2 14761.6 15006.1 15037.8 331202.0 332574.0 336920.0 337353.0 338246.0 47433.0 48185.5 48239.5 48317.0 48344.5 1111.7 1156.4 1165.9 1166.4 1248.1 26221.3 27004.6 27097.0 27365.0 27626.0 37381.4 37784.6 37834.8 37880.9 37898.2 223443.0 224106.0 225274.0 225792.0 226203.0 24240.6 24668.3 36931.4 38464.2 38710.8 38210.0 38502.4 38822.5 39307.6 39611.6 32944.3 33044.3 33174.8 33443.3 33738.5 32761.3 32987.7 33249.3 33434.3 33962.5 31576.0 33596.0 35394.0 36125.0 36772.6 29335.0 29644.9 29985.4 30058.8 30259.5 23534.5 23544.5 23725.6 23820.3 24073.6 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | [#2] jquery.html Cycles:180 Average:23271.34 Median:25885.76 stddev:61363.87 (237.1%) stddev-sans-first:61511.94 04:40:01 INFO - PROCESS | 30080 | Values: 377.2 378.9 385.8 389.9 392.3 15846.9 16290.8 17138.9 17152.5 17176.0 12668.4 14906.1 15595.1 15640.5 15665.3 4683.9 4909.8 4955.9 4957.4 4957.6 3424.8 5237.8 5574.2 5582.7 5595.4 5482.3 5537.2 5554.5 5575.1 5580.4 5437.5 5564.2 5566.7 5575.0 5584.0 3341.1 3522.4 3526.1 3526.3 3527.2 11908.2 12303.8 16137.8 18228.6 19489.1 1976.3 2043.2 2132.0 2472.1 2488.0 8825.4 8966.2 9330.3 9499.6 11320.5 1664.1 1742.7 1774.8 1788.6 1791.2 65251.7 65792.3 67626.7 68754.0 68967.0 9821.1 9826.0 9826.5 9943.1 9978.4 13959.0 14052.6 14071.7 14104.0 14118.4 6834.8 6884.1 6934.4 7013.9 7044.0 6393.7 6420.6 6454.7 6509.6 6531.2 4289.1 4363.2 4370.2 4415.3 4433.8 1615.7 1697.7 1768.5 1828.0 1864.8 834.8 893.9 921.4 961.5 964.4 16257.3 16863.2 17108.5 17143.8 17563.4 873.3 879.9 907.2 917.5 932.7 9241.7 9326.5 9535.3 9650.7 9711.0 359879.0 371325.4 373635.0 374158.0 375122.0 77324.0 77519.2 78177.6 78319.6 78685.0 920.1 926.0 935.9 939.5 948.5 14867.9 14963.6 15127.2 15339.4 15462.8 24473.5 32954.7 33116.7 33378.0 34771.3 46861.8 49322.5 50135.2 50608.5 51563.0 5732.8 6950.4 7941.9 7946.8 8001.9 11535.7 11644.7 12020.5 12137.6 12138.6 9672.2 10350.2 10412.6 10508.5 10842.2 8033.3 10097.7 10195.2 10243.2 10260.0 9909.9 10129.4 10247.9 10688.2 10772.2 7251.9 7385.2 7459.8 7460.1 7485.9 8441.4 9722.4 9818.8 9845.7 9881.5 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | [#3] mootools.html Cycles:180 Average:5028.18 Median:5029.15 stddev:2817.91 (56.0%) stddev-sans-first:2811.59 04:40:01 INFO - PROCESS | 30080 | Values: 1259.9 1422.7 1461.0 1577.2 1744.3 6577.1 7513.0 7695.4 7695.8 7700.9 7390.9 7543.3 7544.3 7556.9 7562.5 1862.1 1930.1 1938.7 2195.1 2227.0 2185.3 2261.3 2261.5 2264.0 2264.9 2130.3 2138.8 2148.3 2150.0 2214.4 1735.3 2152.5 2169.8 2185.6 2187.3 2213.8 2233.9 2237.0 2242.5 2243.9 7443.5 7488.1 7497.4 7500.8 7507.3 4343.5 4467.9 4476.9 4487.0 4491.1 2758.4 2792.4 2863.8 2884.8 2900.5 915.5 943.7 957.0 961.0 963.6 10376.1 10399.2 10414.3 10423.9 10436.7 3982.8 4011.8 4056.8 4229.5 4233.3 8909.5 8929.9 8950.5 8951.6 8965.4 4489.3 4504.8 4515.8 4516.2 4524.0 3679.5 4036.9 4059.1 4083.0 4200.4 3610.8 3639.9 3699.9 3707.0 3759.3 1220.6 1221.1 1227.5 1243.0 1243.2 738.7 808.7 826.5 835.5 847.5 5054.4 5229.2 5276.8 5294.4 5304.8 386.9 394.8 395.3 410.2 414.4 3575.6 3628.6 3693.2 3715.5 3718.0 9254.3 9341.8 9707.0 9727.3 9732.7 9601.1 9631.9 9634.6 9640.6 9649.1 7195.4 7204.6 7273.7 7287.6 7293.6 5003.9 5091.3 5094.8 5149.5 5157.5 8479.9 8523.9 8587.7 8598.4 8818.1 8450.0 8674.3 8688.9 8707.7 8797.6 6078.7 6316.7 6319.3 6419.4 6489.5 6724.0 7187.1 7385.9 7402.6 7431.9 6558.4 6720.5 6734.8 6795.6 6831.1 6525.2 6578.3 6774.7 6813.3 6843.7 5994.5 6039.4 6058.0 6065.0 6156.1 4513.8 4579.8 4641.9 4671.3 4697.5 4446.9 4583.7 4602.0 4711.2 4717.5 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | [#4] prototype.html Cycles:180 Average:4428.92 Median:5083.56 stddev:1274.28 (25.1%) stddev-sans-first:1239.64 04:40:01 INFO - PROCESS | 30080 | Values: 301.9 313.6 318.9 320.6 321.4 5066.4 5100.7 5110.0 5154.1 5158.0 4789.8 4894.2 5045.6 5050.6 5056.4 3964.1 3967.7 3991.2 4008.6 4018.3 4000.3 4009.2 4009.6 4012.6 4014.7 3675.6 3819.2 3915.6 3926.3 3974.1 3933.0 3948.8 3950.3 3973.7 3980.9 3515.7 3526.9 3530.5 3531.9 3536.4 4781.2 4816.2 4849.2 4869.2 4880.6 4525.8 4547.1 4563.2 4565.4 4566.9 5283.8 5289.7 5295.3 5303.9 5346.9 3723.5 3855.3 3862.6 3863.2 3864.3 5571.3 5582.6 5588.2 5600.6 5618.4 3951.2 3955.3 3956.6 3962.7 3967.8 3912.9 4012.8 4019.3 4019.7 4024.2 4518.3 4536.5 4536.6 4547.0 4559.6 5296.6 5319.2 5327.0 5332.7 5350.1 1298.0 1317.0 1371.5 1392.5 1398.7 939.3 946.8 959.5 967.5 969.5 4637.4 4661.7 4666.3 4678.0 4682.2 5450.6 5452.6 5459.6 5466.3 5470.6 4460.6 4666.0 4669.2 4670.6 4684.5 2916.0 2924.5 2931.4 2932.1 2937.6 5182.5 5184.4 5194.8 5195.6 5199.5 5451.5 5593.5 5594.2 5603.6 5611.9 5173.0 5180.0 5182.6 5183.2 5190.9 5458.3 5458.8 5479.6 5487.3 5487.6 5149.9 5279.8 5292.2 5316.1 5361.8 5152.9 5171.1 5173.9 5179.4 5182.0 3942.2 3944.3 3945.7 3951.5 3953.9 5244.8 5275.5 5432.4 5439.5 5445.5 5225.2 5338.9 5346.1 5346.4 5352.1 5342.9 5355.8 5357.9 5373.3 5396.7 5145.6 5211.5 5247.9 5265.1 5273.2 5343.7 5354.4 5387.6 5389.7 5399.1 5245.4 5263.9 5281.2 5296.7 5302.5 04:40:01 INFO - PROCESS | 30080 | 04:40:01 INFO - PROCESS | 30080 | [#5] yui.html Cycles:180 Average:11944.71 Median:24068.41 stddev:13248.90 (55.0%) stddev-sans-first:13258.73 04:40:01 INFO - PROCESS | 30080 | Values: 611.0 684.3 689.7 692.1 698.7 11588.4 11932.4 11965.5 12649.6 12773.6 13050.5 13057.0 13073.9 13163.8 13171.3 644.5 793.9 813.1 821.1 829.7 801.6 806.0 806.1 807.9 812.4 838.5 842.1 843.1 844.3 844.9 661.9 677.8 678.5 802.3 838.5 605.8 606.0 608.6 610.8 613.2 12271.1 12288.3 12339.6 12417.2 12423.0 10379.2 10481.6 10613.2 10717.7 11001.5 9392.4 9488.4 9522.3 9743.1 9946.3 2915.0 2986.1 3134.8 3355.5 3381.3 49324.8 49794.8 50114.5 50932.5 51149.0 8995.8 9010.4 9092.9 10069.4 10183.2 17023.0 17446.9 17529.3 17553.7 17669.5 5873.4 5923.3 6147.4 6213.6 6385.2 3413.6 3465.8 3486.4 3492.5 3520.8 2679.8 2742.8 2746.5 2748.3 2748.5 492.1 498.9 500.5 503.9 507.5 487.3 497.5 543.8 573.6 581.8 7128.3 7317.6 7346.7 7476.9 7586.8 426.5 545.3 552.5 555.2 560.9 3488.5 3615.8 3675.1 3710.8 3716.8 41221.4 42638.6 47327.3 47464.0 47649.5 39129.6 39466.2 40181.0 40336.8 41077.4 35781.0 36035.5 36376.5 36978.3 37304.4 7726.0 7834.6 7984.8 7987.4 8193.6 24877.8 25285.0 26403.5 27329.6 27497.2 33663.5 34198.7 34441.3 34606.5 35446.0 9985.4 10205.9 10213.5 10639.1 11021.8 11931.2 12037.8 12093.0 12116.8 12679.4 10324.7 10519.6 10812.8 11190.3 11210.7 9975.7 10374.2 10434.8 10522.4 10662.3 9158.6 9625.4 9761.4 9870.1 9946.7 8981.3 9205.4 9214.5 9351.2 9581.0 8556.3 8971.4 9510.5 9548.3 9551.8 04:40:01 INFO - PROCESS | 30080 | -------- Summary: end -------- 04:40:01 INFO - PROCESS | 30080 | 04:40:02 INFO - TEST-INFO | 30080: exit 0 04:40:02 INFO - TEST-OK | dromaeo_css | took 1118980ms 04:40:02 INFO - TEST-START | kraken 04:40:02 INFO - operating with platform_type : linux_ 04:40:02 INFO - Initialising browser for kraken test... 04:40:02 INFO - TEST-INFO | started process 30255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNiMlLD/profile http://localhost:53047/getInfo.html) 04:40:07 INFO - PROCESS | 30255 | __metrics Screen width/height:1600/1200 04:40:07 INFO - PROCESS | 30255 | colorDepth:24 04:40:07 INFO - PROCESS | 30255 | Browser inner width/height: 1024/697 04:40:07 INFO - PROCESS | 30255 | __metrics 04:40:08 ERROR - PROCESS | 30255 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:40:08 INFO - TEST-INFO | 30255: exit 0 04:40:08 INFO - Browser initialized. 04:40:08 INFO - Running cycle 1/1 for kraken test... 04:40:08 INFO - TEST-INFO | started process 30337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNiMlLD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:20 INFO - PROCESS | 30337 | RSS: Main: 155258880 04:40:20 INFO - PROCESS | 30337 | 04:40:23 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:24 INFO - PROCESS | 30337 | RSS: Main: 209842176 04:40:24 INFO - PROCESS | 30337 | 04:40:27 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-dft) 04:40:27 INFO - PROCESS | 30337 | RSS: Main: 195149824 04:40:27 INFO - PROCESS | 30337 | 04:40:31 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-fft) 04:40:31 INFO - PROCESS | 30337 | RSS: Main: 265621504 04:40:31 INFO - PROCESS | 30337 | 04:40:33 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-oscillator) 04:40:34 INFO - PROCESS | 30337 | RSS: Main: 174628864 04:40:34 INFO - PROCESS | 30337 | 04:40:36 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:37 INFO - PROCESS | 30337 | RSS: Main: 179179520 04:40:37 INFO - PROCESS | 30337 | 04:40:40 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53047/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:40 INFO - PROCESS | 30337 | RSS: Main: 214347776 04:40:40 INFO - PROCESS | 30337 | 04:40:44 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53047/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:45 INFO - PROCESS | 30337 | RSS: Main: 212389888 04:40:45 INFO - PROCESS | 30337 | 04:40:47 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53047/tests/kraken/driver.html?testName=json-parse-financial) 04:40:48 INFO - PROCESS | 30337 | RSS: Main: 214245376 04:40:48 INFO - PROCESS | 30337 | 04:40:50 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:50 INFO - PROCESS | 30337 | RSS: Main: 201560064 04:40:50 INFO - PROCESS | 30337 | 04:40:52 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:53 INFO - PROCESS | 30337 | RSS: Main: 205983744 04:40:53 INFO - PROCESS | 30337 | 04:40:55 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:56 INFO - PROCESS | 30337 | RSS: Main: 218542080 04:40:56 INFO - PROCESS | 30337 | 04:40:58 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:59 INFO - PROCESS | 30337 | RSS: Main: 224706560 04:40:59 INFO - PROCESS | 30337 | 04:41:02 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:03 INFO - PROCESS | 30337 | RSS: Main: 219500544 04:41:03 INFO - PROCESS | 30337 | 04:41:04 INFO - PROCESS | 30337 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53047/tests/kraken/driver.html?testName=ai-astar) 04:41:05 INFO - PROCESS | 30337 | RSS: Main: 282730496 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | __start_tp_report 04:41:05 INFO - PROCESS | 30337 | _x_x_mozilla_page_load 04:41:05 INFO - PROCESS | 30337 | _x_x_mozilla_page_load_details 04:41:05 INFO - PROCESS | 30337 | |i|pagename|runs| 04:41:05 INFO - PROCESS | 30337 | |0;ai-astar;112;113;109;112;114;114;101;113;112;114 04:41:05 INFO - PROCESS | 30337 | |1;audio-beat-detection;163;131;158;189;133;166;170;135;192;133 04:41:05 INFO - PROCESS | 30337 | |2;audio-dft;161;161;162;162;162;161;163;166;161;162 04:41:05 INFO - PROCESS | 30337 | |3;audio-fft;74;74;124;104;74;74;74;122;104;77 04:41:05 INFO - PROCESS | 30337 | |4;audio-oscillator;94;95;145;94;94;94;139;93;94;140 04:41:05 INFO - PROCESS | 30337 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;116 04:41:05 INFO - PROCESS | 30337 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;147;145 04:41:05 INFO - PROCESS | 30337 | |7;imaging-desaturate;95;94;95;94;94;94;94;95;95;95 04:41:05 INFO - PROCESS | 30337 | |8;json-parse-financial;64;65;64;65;63;65;64;83;65;63 04:41:05 INFO - PROCESS | 30337 | |9;json-stringify-tinderbox;65;65;66;65;67;66;66;65;66;66 04:41:05 INFO - PROCESS | 30337 | |10;stanford-crypto-aes;81;81;79;79;79;81;80;80;88;81 04:41:05 INFO - PROCESS | 30337 | |11;stanford-crypto-ccm;137;133;141;134;130;133;139;139;172;132 04:41:05 INFO - PROCESS | 30337 | |12;stanford-crypto-pbkdf2;174;173;176;172;178;173;175;177;177;172 04:41:05 INFO - PROCESS | 30337 | |13;stanford-crypto-sha256-iterative;73;72;72;72;72;73;71;71;71;72 04:41:05 INFO - PROCESS | 30337 | __end_tp_report 04:41:05 INFO - PROCESS | 30337 | __start_cc_report 04:41:05 INFO - PROCESS | 30337 | _x_x_mozilla_cycle_collect,1885 04:41:05 INFO - PROCESS | 30337 | __end_cc_report 04:41:05 INFO - PROCESS | 30337 | __startTimestamp1461066065144__endTimestamp 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | ------- Summary: start ------- 04:41:05 INFO - PROCESS | 30337 | Number of tests: 14 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.95 (3.5%) stddev-sans-first:4.18 04:41:05 INFO - PROCESS | 30337 | Values: 112.0 113.0 109.0 112.0 114.0 114.0 101.0 113.0 112.0 114.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:164.50 stddev:23.21 (14.1%) stddev-sans-first:24.52 04:41:05 INFO - PROCESS | 30337 | Values: 163.0 131.0 158.0 189.0 133.0 166.0 170.0 135.0 192.0 133.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 04:41:05 INFO - PROCESS | 30337 | Values: 161.0 161.0 162.0 162.0 162.0 161.0 163.0 166.0 161.0 162.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#3] audio-fft Cycles:10 Average:90.10 Median:74.00 stddev:21.14 (28.6%) stddev-sans-first:21.60 04:41:05 INFO - PROCESS | 30337 | Values: 74.0 74.0 124.0 104.0 74.0 74.0 74.0 122.0 104.0 77.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.92 (24.4%) stddev-sans-first:23.73 04:41:05 INFO - PROCESS | 30337 | Values: 94.0 95.0 145.0 94.0 94.0 94.0 139.0 93.0 94.0 140.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:41:05 INFO - PROCESS | 30337 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:41:05 INFO - PROCESS | 30337 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 145.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:41:05 INFO - PROCESS | 30337 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:5.99 (9.2%) stddev-sans-first:6.30 04:41:05 INFO - PROCESS | 30337 | Values: 64.0 65.0 64.0 65.0 63.0 65.0 64.0 83.0 65.0 63.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 04:41:05 INFO - PROCESS | 30337 | Values: 65.0 65.0 66.0 65.0 67.0 66.0 66.0 65.0 66.0 66.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:2.64 (3.3%) stddev-sans-first:2.80 04:41:05 INFO - PROCESS | 30337 | Values: 81.0 81.0 79.0 79.0 79.0 81.0 80.0 80.0 88.0 81.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.00 stddev:12.13 (8.8%) stddev-sans-first:12.84 04:41:05 INFO - PROCESS | 30337 | Values: 137.0 133.0 141.0 134.0 130.0 133.0 139.0 139.0 172.0 132.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.50 stddev:2.21 (1.3%) stddev-sans-first:2.33 04:41:05 INFO - PROCESS | 30337 | Values: 174.0 173.0 176.0 172.0 178.0 173.0 175.0 177.0 177.0 172.0 04:41:05 INFO - PROCESS | 30337 | 04:41:05 INFO - PROCESS | 30337 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 04:41:05 INFO - PROCESS | 30337 | Values: 73.0 72.0 72.0 72.0 72.0 73.0 71.0 71.0 71.0 72.0 04:41:05 INFO - PROCESS | 30337 | -------- Summary: end -------- 04:41:05 INFO - PROCESS | 30337 | 04:41:06 INFO - TEST-INFO | 30337: exit 0 04:41:06 INFO - TEST-OK | kraken | took 63606ms 04:41:06 INFO - SUITE-END | took 1182s 04:41:06 INFO - Completed test suite (00:19:42) 04:41:06 INFO - javascript benchmark 04:41:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.9743602563976, 2645.1932160690994, 2651.535981203289, 2667.4531720997197, 2692.1654287170973, 4479.955200447995, 4567.748773817439, 4605.516420775816, 4607.35497030416, 4634.860954171376, 4622.375979242801, 4640.095181439612, 4694.835680751175, 4734.431868175824, 4754.429468463789, 4204.8738537843765, 4209.705320627558, 4231.788410579474, 4266.168097221043, 4327.567243275679, 4231.978840105795, 4328.523862375137, 4382.298832186851, 4399.164158809832, 4402.647788176954, 4306.870793876157, 4313.352997050436, 4355.346697995295, 4363.54182810805, 4419.690621656486, 4105.4662893823615, 4178.247915375231, 4190.392393103013, 4198.580141985807, 4203.76879271643, 4190.832366705328, 4234.343676730112, 4243.045314804175, 4245.150969806051, 4247.129338485603, 4490.461144662629, 4511.729296242203, 4535.659825513099, 4552.226121559343, 4566.794494247767, 4816.084943860656, 4940.90118197634, 4996.325496058022, 4998.300237966688, 4999.075171093359, 4975.179095449246, 5003.774830132653, 5003.924941125886, 5041.470645582198, 5069.645124841262, 4534.478534968455, 4626.1210370029585, 4675.7895894684825, 4677.970846413784, 4712.481627021025, 5113.769880355393, 5114.43741188469, 5114.897702045938, 5135.306733590917, 5165.173572228426, 4846.975765121152, 4913.361263035782, 4918.01639672067, 4923.113839508851, 4965.9751701241985, 4861.732604706775, 4904.0, 4973.52751488608, 4980.676256043345, 4988.0, 4969.627277954168, 4980.526849949249, 5004.724740139254, 5009.423916249605, 5065.037642847848, 4958.950410495849, 4974.303597496353, 4983.352164218701, 4992.400911890524, 5040.722760248148, 4036.8788936331957, 4108.77401742907, 4123.670106391482, 4179.435776170239, 4196.559361267084, 3576.2668652926086, 3587.7847329160336, 3602.4596310553625, 3632.164602141522, 3633.0554055945117, 4258.04194056341, 4263.360495925574, 4265.594768496988, 4269.210196113729, 4290.89272768177, 4744.335792988984, 4983.152864013126, 5020.146575082244, 5064.848054558369, 5071.5689166420525, 4283.635890949305, 4285.7000009999, 4302.9354559681005, 4303.677224208197, 4312.353147027971, 4310.116426132698, 4443.022535042285, 4445.4220951276775, 4448.710833795858, 4486.057927835126, 4695.413073365829, 4740.360051393018, 4742.7865746040825, 4781.450133234723, 4793.688410253322, 4961.1318019345745, 4993.500649935123, 4998.425181104074, 4999.450060493416, 5032.496750324938, 4562.452505699337, 4707.105649926503, 4726.338312636165, 4736.455307639528, 4785.665003449725, 4820.469748327751, 4845.224764037737, 4850.466448690711, 4867.537583929521, 4907.901841963069, 4910.263460480814, 4912.066707325596, 4913.950860491493, 4919.040787046635, 4955.45489996093, 4672.9532704673875, 4767.856964291077, 4786.2820576912345, 4789.090072886141, 4825.782839772289, 4811.0, 4833.419989601271, 4844.0554091951735, 4864.902701945871, 4880.682755620874, 4747.976260118678, 4769.785359658893, 4771.117343291502, 4771.284307353924, 4828.830990915301, 4652.162610730101, 4769.546893045155, 4803.519648035169, 4879.609631229564, 4891.315215869852, 4695.295705644181, 4749.05018996209, 4750.168720473835, 4757.643176761688, 4788.760561971818], "value": 4553.313365785929, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.9832905012851, 592.7480820651224, 600.3606159440193, 602.2712517853398, 609.5062998970836, 26335.868320658396, 27038.729612703868, 27066.729332706665, 27089.32276693079, 27098.864505677444, 26542.203733887967, 37311.25377492449, 38254.80872595633, 38285.80857095711, 38319.42520862189, 7710.306072453492, 7947.324477419397, 7950.4037197210155, 7950.960245198795, 7953.920460795404, 7708.768736937901, 7826.334761545276, 7834.882476762825, 7841.529508229524, 7841.725539606115, 7801.180876008023, 7867.6852925882895, 7870.134285228621, 7871.8032049198655, 7878.6848526059175, 7773.7279195228175, 7821.256980586835, 7832.608369581498, 7838.9216107838765, 7844.0, 7611.3910887128895, 7711.884321735179, 7721.806954826118, 7722.845543089163, 7726.072871255486, 37778.62221377779, 38391.0, 38405.61594384049, 38421.423678644845, 38486.0, 3106.3631955449077, 3216.3567286542784, 3244.5619841321354, 3286.2277364819247, 3290.0952238134464, 27985.30036749077, 28070.0, 28712.282192945135, 28790.42419151626, 28908.0, 3136.1375621703987, 3141.5130654748323, 3166.5250212468313, 3194.520821876714, 3225.741940644743, 233426.83286583627, 233797.0, 234278.0, 234330.0, 234866.0, 43958.340624890654, 44232.3365149523, 44270.77864610721, 49709.75145124324, 49965.500344996086, 51956.48043519592, 52457.47542524602, 52482.475175248524, 52520.212196817076, 52547.73726131345, 13216.537421190213, 13861.4455421782, 13870.237136957565, 13871.930640346734, 13879.653008674662, 9518.666846660333, 9571.0, 9615.951920240354, 9628.47043412619, 9670.371425857438, 17276.13619319029, 17345.3929112483, 17435.825641743675, 17488.213030413663, 17527.64944701099, 6455.870882582322, 6574.178227721535, 6593.439557637558, 6846.383825455733, 6863.142107236596, 867.5618812499647, 893.8257039877292, 896.7356028000488, 946.4274114160834, 1008.996048931318, 25882.6117608236, 26142.34644133912, 26474.6028809568, 27473.587896181172, 27601.0, 988.9159421449258, 993.5529011944653, 1006.7684432580547, 1030.685640879524, 1110.9388983605818, 14077.225752583501, 14699.191544464944, 14761.55715328542, 15006.099634021994, 15037.774433383507, 331202.0, 332574.0, 336920.0, 337353.0, 338246.0, 47433.0, 48185.5181448188, 48239.51760482421, 48317.0, 48344.51655483471, 1111.6553868300853, 1156.4217891054473, 1165.8600967883908, 1166.393475392791, 1248.0701877101435, 26221.34446638849, 27004.594931075655, 27097.0, 27365.0, 27626.0, 37381.439278410304, 37784.62215377811, 37834.81082594569, 37880.91654959004, 37898.242035159696, 223443.0, 224106.0, 225274.0, 225792.0, 226203.0, 24240.63639045451, 24668.259952201464, 36931.44602830906, 38464.2307153861, 38710.80644596759, 38210.0, 38502.42246366363, 38822.51877896661, 39307.6069239304, 39611.60388396194, 32944.34111317712, 33044.339113218084, 33174.83412582921, 33443.33113337768, 33738.49392259069, 32761.344773103927, 32987.67012329846, 33249.335013300086, 33434.33131337408, 33962.49056264207, 31576.0, 33596.0, 35394.0, 36125.0, 36772.63227367692, 29335.0, 29644.851775740983, 29985.400291994476, 30058.84970575133, 30259.546106808855, 23534.529309414058, 23544.529109418057, 23725.58028045177, 23820.285391438283, 24073.638895416934], "value": 16636.8134692476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1683438019167, 378.8636091007237, 385.75504554607835, 389.8849839297407, 392.29974495525494, 15846.920765396171, 16290.83709162908, 17138.914305428487, 17152.48542543726, 17176.0, 12668.366581670902, 14906.105633661988, 15595.1422671753, 15640.530784076467, 15665.295061722221, 4683.882902927428, 4909.754512274372, 4955.851324460272, 4957.380327459067, 4957.603391728653, 3424.777389469689, 5237.764300606463, 5574.219609254707, 5582.748776305056, 5595.356533998602, 5482.2873026506695, 5537.169424586325, 5554.472325129106, 5575.107982722765, 5580.414056524068, 5437.456254374551, 5564.221009058735, 5566.749496272678, 5575.0, 5584.0, 3341.114604629775, 3522.418800897849, 3526.1360966563097, 3526.34762568923, 3527.171114788023, 11908.16642835002, 12303.815442768366, 16137.789665775113, 18228.635427291512, 19489.122989465508, 1976.2984140630012, 2043.2439997200981, 2131.9659964917005, 2472.085328428475, 2488.042103790036, 8825.382223244376, 8966.193042626195, 9330.253579713606, 9499.620015199383, 11320.547178112865, 1664.0847533856331, 1742.712452445345, 1774.8136445673147, 1788.642271545696, 1791.1777810782764, 65251.673741631465, 65792.3420765791, 67626.66186669085, 68754.0, 68967.0, 9821.116099551075, 9826.0, 9826.508674566243, 9943.055409736064, 9978.351407158512, 13959.0, 14052.648683782987, 14071.71856562863, 14104.0, 14118.43526258938, 6834.829129271808, 6884.139482564679, 6934.410575101173, 7013.89479157813, 7043.964780176067, 6393.712282947278, 6420.646864422408, 6454.741810327629, 6509.609423434609, 6531.248906375828, 4289.0992891492515, 4363.192809330284, 4370.191514569815, 4415.337699345124, 4433.844815431445, 1615.6849414364085, 1697.7029019921465, 1768.4871387297796, 1827.950593786556, 1864.7855496618063, 834.7871292820413, 893.9284857211408, 921.4195057114109, 961.5432669481941, 964.3972517176765, 16257.268422920997, 16863.15684215809, 17108.48674539766, 17143.828561714225, 17563.38528151534, 873.3188113271658, 879.9340049496313, 907.2288554728428, 917.4724533393193, 932.7295084425441, 9241.722748317427, 9326.487043212688, 9535.332526723063, 9650.662226822027, 9711.0, 359879.0, 371325.43011854845, 373635.0, 374158.0, 375122.0, 77324.0, 77519.22480775233, 78177.60911195521, 78319.60840195762, 78685.0, 920.0661328751323, 925.9861102083474, 935.854942483916, 939.4973689076448, 948.4972964328916, 14867.92566037163, 14963.551093467213, 15127.243637817845, 15339.386424542894, 15462.768058479356, 24473.51052978966, 32954.67045329516, 33116.668833311356, 33378.0, 34771.304573908885, 46861.76569117133, 49322.50677493179, 50135.24797127973, 50608.493915060375, 51563.0, 5732.799352022659, 6950.374466298057, 7941.880871786812, 7946.801329966797, 8001.879971800311, 11535.711607209887, 11644.708882278012, 12020.459079341275, 12137.575184868487, 12138.575149870065, 9672.226221902372, 10350.22373322019, 10412.583496660049, 10508.527116279633, 10842.186835987175, 8033.277005069338, 10097.747556310856, 10195.184385249015, 10243.180545556188, 10260.0, 9909.851352229578, 10129.442880641636, 10247.897521024992, 10688.198385120992, 10772.192085593768, 7251.854962900607, 7385.187629360874, 7459.776206713807, 7460.104787425544, 7485.887711684438, 8441.409101362846, 9722.368046076983, 9818.803623927339, 9845.704628861145, 9881.50592470388], "value": 7956.9583602782495, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.9055070869688, 1422.743906096902, 1461.0, 1577.2271586922411, 1744.3197153110282, 6577.112089867873, 7512.962435187823, 7695.384369250461, 7695.846083078335, 7700.884486732696, 7390.8521829563515, 7543.3211011009, 7544.283293087148, 7556.886646700304, 7562.508436951608, 1862.0689655172414, 1930.1314408516155, 1938.7479627648386, 2195.056125865877, 2226.9888650556722, 2185.2897808212315, 2261.2537862505415, 2261.502469456717, 2263.954720905581, 2264.932052038433, 2130.2650585547963, 2138.8075073243403, 2148.2803260907613, 2150.0, 2214.3799736073925, 1735.305877648938, 2152.45112496314, 2169.8481106322483, 2185.63936950403, 2187.278198194592, 2213.8007579317937, 2233.8547994380474, 2237.026893301419, 2242.4505996031075, 2243.9214627488122, 7443.516171448839, 7488.101427828696, 7497.437692173109, 7500.8124796879965, 7507.3243408092985, 4343.478782546114, 4467.888302792424, 4476.93284600728, 4487.0352874131895, 4491.124230775, 2758.3517873299757, 2792.3577577157366, 2863.7565806906437, 2884.812487188326, 2900.463414268346, 915.4873270968279, 943.6508491858057, 956.9760755981087, 960.9855852162223, 963.6001059560274, 10376.118029967462, 10399.220058495568, 10414.323069000491, 10423.895761042368, 10436.739081523023, 3982.8008599569907, 4011.799410029487, 4056.8377264909664, 4229.450171477688, 4233.343831706091, 8909.5099769512, 8929.910700893039, 8950.462972221687, 8951.552422378854, 8965.417247878868, 4489.304157855538, 4504.752238626841, 4515.774211289488, 4516.209663308908, 4524.0, 3679.466477360821, 4036.899077523027, 4059.106996460774, 4083.0404854859084, 4200.432941552913, 3610.7833529988284, 3639.926221764586, 3699.9445008324897, 3706.9814650926573, 3759.342115129841, 1220.6277085489012, 1221.1146918484028, 1227.4660522672666, 1242.9564965226173, 1243.247835059794, 738.6823665823747, 808.7331180710352, 826.5123577089546, 835.4694768821842, 847.5296210603175, 5054.393472783216, 5229.241759944863, 5276.762545685377, 5294.41761406245, 5304.761285742151, 386.94582758413844, 394.80457173699205, 395.28848073467645, 410.18168753337284, 414.37429481482576, 3575.570931488186, 3628.6189950054863, 3693.1874987502706, 3715.535558055243, 3718.0, 9254.259659227246, 9341.813163736688, 9706.95146524277, 9727.319087663936, 9732.70801875945, 9601.135897769234, 9631.903680963242, 9634.614615415305, 9640.566174522164, 9649.131578158, 7195.352418282275, 7204.567725936356, 7273.709051637981, 7287.562746235137, 7293.562386256842, 5003.899922001612, 5091.312672789126, 5094.847154585368, 5149.536541711264, 5157.484251574812, 8479.915200847912, 8523.872141917753, 8587.699430519902, 8598.441101328393, 8818.074102219174, 8449.95775021121, 8674.262687671619, 8688.869666955126, 8707.695230666895, 8797.560121994004, 6078.665673388006, 6316.652584107918, 6319.304876463493, 6419.422251997343, 6489.480841532761, 6724.0, 7187.065681461377, 7385.9261407387385, 7402.555846649218, 7431.925680743123, 6558.409743123142, 6720.529562930548, 6734.831629209309, 6795.558288711218, 6831.11195544576, 6525.2169739631545, 6578.276389597237, 6774.729010839511, 6813.318668133147, 6843.657817109025, 5994.520438365008, 6039.365866583946, 6058.0, 6065.029595264737, 6156.107364432043, 4513.796879140381, 4579.816807327803, 4641.930371044505, 4671.346011558317, 4697.483276839476, 4446.933296000628, 4583.72497650142, 4601.953980460153, 4711.19909615373, 4717.481077081587], "value": 3995.9476943867962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.88377474672245, 313.64401404406, 318.90911090339245, 320.63127403486004, 321.4246498767207, 5066.36670416198, 5100.744962751857, 5110.003549307887, 5154.123798954178, 5158.019976204523, 4789.784459699314, 4894.167991441454, 5045.64680472367, 5050.64645474816, 5056.393232812058, 3964.1278918638, 3967.6627486663524, 3991.221711766214, 4008.6191811777835, 4018.2566225248274, 4000.2999475091888, 4009.1781184857036, 4009.558948515661, 4012.638862502374, 4014.7189696721243, 3675.577308609504, 3819.2361527694434, 3915.5888631693547, 3926.3325234710023, 3974.085960229149, 3933.0, 3948.7828169450668, 3950.348192548226, 3973.7417067890497, 3980.900477488057, 3515.6835884770494, 3526.8589256429714, 3530.5233793437815, 3531.858725650971, 3536.3811333016874, 4781.163296423112, 4816.229403295491, 4849.151398505247, 4869.245266983623, 4880.633952453581, 4525.773711314454, 4547.113312903985, 4563.224251877189, 4565.383673204141, 4566.862994110182, 5283.788648454057, 5289.682619042831, 5295.338082739658, 5303.946960530384, 5346.866328341784, 3723.5345581802276, 3855.267499175176, 3862.594427585091, 3863.150106976461, 3864.285107255139, 5571.303587051619, 5582.637128586629, 5588.161775733632, 5600.635958662674, 5618.381977982419, 3951.150502641946, 3955.3078211312904, 3956.6241207085855, 3962.7424217425773, 3967.8016099194924, 3912.921741565153, 4012.8194231259663, 4019.33680942647, 4019.738716983387, 4024.2353952748886, 4518.322251662277, 4536.523665015192, 4536.637069034536, 4546.954530454719, 4559.635229181657, 5296.602754793406, 5319.202119682079, 5326.97336513315, 5332.733363331896, 5350.117230656976, 1297.9740405191844, 1316.960491185266, 1371.4856928651755, 1392.5056604905315, 1398.6573289544126, 939.3096074385321, 946.8248374050822, 959.5154447004218, 967.4920666649924, 969.4522594734094, 4637.420322459692, 4661.7367842510375, 4666.32338310943, 4678.0410015946645, 4682.157211701926, 5450.591205659592, 5452.59105567084, 5459.590530710213, 5466.262054622654, 5470.56235501159, 4460.643148548108, 4665.95334046662, 4669.18289299378, 4670.556297151765, 4684.531546845288, 2915.9854200729283, 2924.4589750896153, 2931.4137172565574, 2932.135020169055, 2937.6327959005125, 5182.53357197854, 5184.403793563713, 5194.753259217836, 5195.558377537952, 5199.532042116228, 5451.509364157245, 5593.524550413179, 5594.1608758686525, 5603.551715862803, 5611.943880561143, 5172.974135129375, 5179.974100129551, 5182.637215394886, 5183.222516622537, 5190.92213616796, 5458.263134476795, 5458.754356054066, 5479.589030822624, 5487.341519017744, 5487.6158668894395, 5149.871253218699, 5279.788808447619, 5292.153255479105, 5316.149416093406, 5361.839144825662, 5152.922706159336, 5171.120909445328, 5173.870653233699, 5179.378474583074, 5181.974090129676, 3942.2115576885312, 3944.2900277950243, 3945.704072194654, 3951.545572259227, 3953.9011524712114, 5244.7902083916215, 5275.498827611371, 5432.375276843056, 5439.456054394529, 5445.53712934405, 5225.16397376418, 5338.919916201337, 5346.117890548016, 5346.43862394443, 5352.116900711339, 5342.893142137058, 5355.839324820262, 5357.946420535744, 5373.328333958255, 5396.676199428047, 5145.552479838442, 5211.530962213419, 5247.947520524746, 5265.104932161618, 5273.235380869675, 5343.65266257692, 5354.384245811626, 5387.649802762808, 5389.730513474389, 5399.136138217867, 5245.396779370269, 5263.947360526499, 5281.15501519755, 5296.735163241746, 5302.469753024667], "value": 4026.4377342148186, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.0406661541379, 684.3396122741557, 689.7137687859539, 692.0691669704246, 698.6506746626685, 11588.362640054804, 11932.403379831017, 11965.461554230069, 12649.557265495687, 12773.552925647604, 13050.543230986917, 13057.0, 13073.869261307384, 13163.80254296184, 13171.341432928339, 644.4618743349309, 793.9285464308211, 813.0812182234067, 821.1008945204991, 829.6971605364029, 801.587182600961, 806.0, 806.1173015547965, 807.8505476486839, 812.3704129299811, 838.4717627894418, 842.1326034184799, 843.1063073142489, 844.2907957315854, 844.9366297527679, 661.8577005943721, 677.7695583501584, 678.4775722693498, 802.3300544045729, 838.5052818836886, 605.7576969212306, 606.0182504342948, 608.5831205624162, 610.7587502936316, 613.2150846915955, 12271.07966902477, 12288.324142172178, 12339.568115116017, 12417.19288246261, 12423.0, 10379.221558383077, 10481.58073677052, 10613.150947924225, 10717.732056698567, 11001.504932278067, 9392.436453812794, 9488.430694158373, 9522.333436659437, 9743.123118919331, 9946.254030947708, 2915.0, 2986.074316961749, 3134.843257837099, 3355.4966754986704, 3381.2730262993327, 49324.753376233246, 49794.751026245, 50114.49885501171, 50932.49067509315, 51149.0, 8995.775105622412, 9010.41432306911, 9092.8636070459, 10069.395836249849, 10183.236257280734, 17023.0, 17446.912765436344, 17529.298828046736, 17553.736693949602, 17669.469915902544, 5873.412658734178, 5923.259592550931, 6147.44672979434, 6213.565050446426, 6385.233771947396, 3413.6245013048547, 3465.8267086645565, 3486.38988177068, 3492.5285086513504, 3520.7887526748477, 2679.812413131062, 2742.780577553791, 2746.4507098579966, 2748.3403983043927, 2748.491529067129, 492.11910679883323, 498.8603191106496, 500.4670026421849, 503.8639567316877, 507.4519518919558, 487.29585748592945, 497.53729032000587, 543.7661805423627, 573.5755540899787, 581.7585701933734, 7128.28717128283, 7317.634118294171, 7346.742863999734, 7476.850462990818, 7586.81032974169, 426.45413870246136, 545.2720617975048, 552.4889477233543, 555.2171438272097, 560.8698472577759, 3488.5464889564196, 3615.81920903959, 3675.1363429594026, 3710.7588006779474, 3716.8141592920247, 41221.38167927483, 42638.57361426408, 47327.29009064867, 47464.0, 47649.5235047652, 39129.6087039126, 39466.21067578632, 40181.0, 40336.79831600823, 41077.38383924244, 35781.0, 36035.459468108, 36376.45435318472, 36978.260434791155, 37304.44043339406, 7726.0, 7834.608269586612, 7984.84030319402, 7987.361011119213, 8193.631286592237, 24877.751222487543, 25285.0, 26403.471930561664, 27329.590056149573, 27497.17508474749, 33663.4950475748, 34198.65801342054, 34441.311173776885, 34606.480902785974, 35446.0, 9985.350952188084, 10205.948970255102, 10213.540390682585, 10639.095676867553, 11021.779564408827, 11931.224470409396, 12037.759244814879, 12093.0, 12116.818247726114, 12679.429425675682, 10324.690259292232, 10519.631812886511, 10812.783744325227, 11190.32858028521, 11210.719732006764, 9975.700728978143, 10374.22193335518, 10434.843477347695, 10522.368657880552, 10662.253642244968, 9158.633654653739, 9625.422474651543, 9761.365511241747, 9870.062344077302, 9946.651867184613, 8981.281497480055, 9205.447673139633, 9214.539273036455, 9351.158395744416, 9581.0, 8556.27271681914, 8971.372003959661, 9510.47692376926, 9548.283878709264, 9551.808963820824], "value": 5631.949617283033, "unit": "score"}], "name": "dromaeo_css", "value": 6159.779494873048, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 109.0, 112.0, 114.0, 114.0, 101.0, 113.0, 112.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 158.0, 189.0, 133.0, 166.0, 170.0, 135.0, 192.0, 133.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 166.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 124.0, 104.0, 74.0, 74.0, 74.0, 122.0, 104.0, 77.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 145.0, 94.0, 94.0, 94.0, 139.0, 93.0, 94.0, 140.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 63.0, 65.0, 64.0, 83.0, 65.0, 63.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 79.0, 79.0, 81.0, 80.0, 80.0, 88.0, 81.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 141.0, 134.0, 130.0, 133.0, 139.0, 139.0, 172.0, 132.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 176.0, 172.0, 178.0, 173.0, 175.0, 177.0, 177.0, 172.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 72.0, 73.0, 71.0, 71.0, 71.0, 72.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1584.5000000000002, "alertThreshold": 2.0}]} 04:41:06 INFO - Return code: 0 04:41:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:41:06 ERROR - # TBPL SUCCESS # 04:41:06 INFO - Running post-action listener: _resource_record_post_action 04:41:06 INFO - Running post-run listener: _resource_record_post_run 04:41:07 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 388362240; Read time: 0; Write time: 405072 04:41:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105308160; Read time: 0; Write time: 129416 04:41:07 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283054080; Read time: 0; Write time: 275656 04:41:07 INFO - Running post-run listener: _upload_blobber_files 04:41:07 INFO - Blob upload gear active. 04:41:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:41:07 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:41:07 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:41:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:08 INFO - (blobuploader) - INFO - Done attempting. 04:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:09 INFO - (blobuploader) - INFO - Done attempting. 04:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:09 INFO - Return code: 0 04:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21726be0d93c8f70769d80053e413c2c447d9a6128f0e9999ca203dfe47558674abd41c15623af8f194cc9060be72096ed75fada8c7bfa1a2c6ac8c82049614b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3741006a89f95e4486fc4dd507f989d11aa266f59093837fbcdecf2a9e1ae8685d267a543fe9bfa41378f553559f7d138a1b6c674dfe1a0976164d7953014e"} 04:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:09 INFO - Contents: 04:41:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21726be0d93c8f70769d80053e413c2c447d9a6128f0e9999ca203dfe47558674abd41c15623af8f194cc9060be72096ed75fada8c7bfa1a2c6ac8c82049614b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3741006a89f95e4486fc4dd507f989d11aa266f59093837fbcdecf2a9e1ae8685d267a543fe9bfa41378f553559f7d138a1b6c674dfe1a0976164d7953014e"} 04:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:09 INFO - Copying logs to upload dir... 04:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.200948 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-19 04:41:09.240509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:41:09.244570) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21726be0d93c8f70769d80053e413c2c447d9a6128f0e9999ca203dfe47558674abd41c15623af8f194cc9060be72096ed75fada8c7bfa1a2c6ac8c82049614b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3741006a89f95e4486fc4dd507f989d11aa266f59093837fbcdecf2a9e1ae8685d267a543fe9bfa41378f553559f7d138a1b6c674dfe1a0976164d7953014e"} build_url:https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/b0hTnQhfT3mkG39NFGoD_w/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/Firefox-Non-PGO/sha512/21726be0d93c8f70769d80053e413c2c447d9a6128f0e9999ca203dfe47558674abd41c15623af8f194cc9060be72096ed75fada8c7bfa1a2c6ac8c82049614b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3741006a89f95e4486fc4dd507f989d11aa266f59093837fbcdecf2a9e1ae8685d267a543fe9bfa41378f553559f7d138a1b6c674dfe1a0976164d7953014e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:41:09.269839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:41:09.270261) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461064701.391649-1449006892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:41:09.355091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:41:09.355590) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:41:09.356129) ========= ========= Total master_lag: 0.17 =========