builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1462022195.35 results: success (0) buildid: 20160430045635 builduid: c610b8f01baf4518912417324f62b585 revision: 1461a4071341c282afcf7b72e33036412d2251d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.352889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.353354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.353633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.378375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.378714) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-30 06:16:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-04-30 06:16:35 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123416 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.517610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.518166) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018552 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.568007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:35.568382) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1461a4071341c282afcf7b72e33036412d2251d4 --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 1461a4071341c282afcf7b72e33036412d2251d4 --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=edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-30 06:16:35,654 truncating revision to first 12 chars 2016-04-30 06:16:35,654 Setting DEBUG logging. 2016-04-30 06:16:35,654 attempt 1/10 2016-04-30 06:16:35,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1461a4071341?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-30 06:16:35,886 unpacking tar archive at: mozilla-central-1461a4071341/testing/mozharness/ program finished with exit code 0 elapsedTime=0.502090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:36.083896) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:36.084284) ========= script_repo_revision: 1461a4071341c282afcf7b72e33036412d2251d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:36.084694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:36.084989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 06:16:36.096905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-30 06:16:36.097319) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:16:36 INFO - MultiFileLogger online at 20160430 06:16:36 in /builds/slave/test 06:16:36 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 06:16:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:16:36 INFO - {'append_to_log': False, 06:16:36 INFO - 'base_work_dir': '/builds/slave/test', 06:16:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:16:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:16:36 INFO - 'branch': 'Firefox-Non-PGO', 06:16:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:16:36 INFO - 'config_files': ('talos/linux_config.py',), 06:16:36 INFO - 'default_actions': ('clobber', 06:16:36 INFO - 'read-buildbot-config', 06:16:36 INFO - 'download-and-extract', 06:16:36 INFO - 'populate-webroot', 06:16:36 INFO - 'create-virtualenv', 06:16:36 INFO - 'install', 06:16:36 INFO - 'run-tests'), 06:16:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:16:36 INFO - 'download_minidump_stackwalk': True, 06:16:36 INFO - 'download_symbols': 'ondemand', 06:16:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:16:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:16:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:16:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:16:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:16:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:16:36 INFO - 'installer_path': 'installer.exe', 06:16:36 INFO - 'log_level': 'info', 06:16:36 INFO - 'log_name': 'talos', 06:16:36 INFO - 'log_to_console': True, 06:16:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:16:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:16:36 INFO - 'opt_config_files': (), 06:16:36 INFO - 'pip_index': False, 06:16:36 INFO - 'sps_profile': False, 06:16:36 INFO - 'sps_profile_interval': 0, 06:16:36 INFO - 'suite': 'dromaeojs', 06:16:36 INFO - 'system_bits': '32', 06:16:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:16:36 INFO - 'title': 'talos-linux64-ix-033', 06:16:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:16:36 INFO - 'use_talos_json': True, 06:16:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:16:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:16:36 INFO - 'work_dir': 'build'} 06:16:36 INFO - ##### 06:16:36 INFO - ##### Running clobber step. 06:16:36 INFO - ##### 06:16:36 INFO - Running pre-action listener: _resource_record_pre_action 06:16:36 INFO - Running main action method: clobber 06:16:36 INFO - rmtree: /builds/slave/test/build 06:16:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:16:36 INFO - Running post-action listener: _resource_record_post_action 06:16:36 INFO - ##### 06:16:36 INFO - ##### Running read-buildbot-config step. 06:16:36 INFO - ##### 06:16:36 INFO - Running pre-action listener: _resource_record_pre_action 06:16:36 INFO - Running main action method: read_buildbot_config 06:16:36 INFO - Using buildbot properties: 06:16:36 INFO - { 06:16:36 INFO - "project": "", 06:16:36 INFO - "product": "firefox", 06:16:36 INFO - "script_repo_revision": "production", 06:16:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:16:36 INFO - "repository": "", 06:16:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:16:36 INFO - "buildid": "20160430045635", 06:16:36 INFO - "pgo_build": "False", 06:16:36 INFO - "basedir": "/builds/slave/test", 06:16:36 INFO - "buildnumber": 492, 06:16:36 INFO - "slavename": "talos-linux64-ix-033", 06:16:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:16:36 INFO - "platform": "ubuntu64_hw", 06:16:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:16:36 INFO - "branch": "mozilla-central", 06:16:36 INFO - "repo_path": "mozilla-central", 06:16:36 INFO - "revision": "1461a4071341c282afcf7b72e33036412d2251d4", 06:16:36 INFO - "stage_platform": "linux64", 06:16:36 INFO - "builduid": "c610b8f01baf4518912417324f62b585", 06:16:36 INFO - "slavebuilddir": "test" 06:16:36 INFO - } 06:16:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:16:36 INFO - Running post-action listener: _resource_record_post_action 06:16:36 INFO - ##### 06:16:36 INFO - ##### Running download-and-extract step. 06:16:36 INFO - ##### 06:16:36 INFO - Running pre-action listener: _resource_record_pre_action 06:16:36 INFO - Running main action method: download_and_extract 06:16:36 INFO - mkdir: /builds/slave/test/build/tests 06:16:36 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')]} 06:16:36 INFO - https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:16:38 INFO - Downloaded 1361 bytes. 06:16:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:16:38 INFO - Using the following test package requirements: 06:16:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:16:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:16:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:16:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'jsshell-linux-x86_64.zip'], 06:16:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:16:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:16:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:16:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:16:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:16:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:16:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:38 INFO - https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:16:40 INFO - Downloaded 22304286 bytes. 06:16:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:16:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:16:41 INFO - Return code: 0 06:16:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:41 INFO - https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:16:57 INFO - Downloaded 22304286 bytes. 06:16:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:16:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:16:59 INFO - Return code: 0 06:16:59 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')]} 06:16:59 INFO - https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:17:00 INFO - Downloaded 10840152 bytes. 06:17:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:17:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:17:00 INFO - Return code: 0 06:17: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')]} 06:17:00 INFO - https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:17:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:17:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:17:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:17:01 INFO - Downloaded 54913231 bytes. 06:17:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:17:01 INFO - mkdir: /builds/slave/test/properties 06:17:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:17:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:17:01 INFO - Contents: 06:17:01 INFO - build_url:https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:17:02 INFO - Running post-action listener: _resource_record_post_action 06:17:02 INFO - Running post-action listener: set_extra_try_arguments 06:17:02 INFO - ##### 06:17:02 INFO - ##### Running populate-webroot step. 06:17:02 INFO - ##### 06:17:02 INFO - Running pre-action listener: _resource_record_pre_action 06:17:02 INFO - Running main action method: populate_webroot 06:17:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:17:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:17:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:17:02 INFO - '--tppagecycles', 06:17:02 INFO - '7'], 06:17:02 INFO - 'tests': ['tsvgm']}}, 06:17:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:17:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:17:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:17:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:17:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['damp', 'tps']}, 06:17:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'tests': ['damp', 'tps']}, 06:17:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['dromaeo_dom']}, 06:17:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:17:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['a11yr', 06:17:02 INFO - 'ts_paint', 06:17:02 INFO - 'tpaint', 06:17:02 INFO - 'sessionrestore', 06:17:02 INFO - 'sessionrestore_no_auto_restore', 06:17:02 INFO - 'tabpaint']}, 06:17:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:17:02 INFO - 'ts_paint', 06:17:02 INFO - 'tpaint', 06:17:02 INFO - 'sessionrestore', 06:17:02 INFO - 'sessionrestore_no_auto_restore', 06:17:02 INFO - 'tabpaint']}, 06:17:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:17:02 INFO - 'ts_paint', 06:17:02 INFO - 'tpaint', 06:17:02 INFO - 'sessionrestore', 06:17:02 INFO - 'sessionrestore_no_auto_restore', 06:17:02 INFO - 'tabpaint']}, 06:17:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:17:02 INFO - 'ts_paint', 06:17:02 INFO - 'tpaint', 06:17:02 INFO - 'sessionrestore', 06:17:02 INFO - 'sessionrestore_no_auto_restore', 06:17:02 INFO - 'tabpaint']}, 06:17:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['a11yr', 06:17:02 INFO - 'ts_paint', 06:17:02 INFO - 'tpaint', 06:17:02 INFO - 'sessionrestore', 06:17:02 INFO - 'sessionrestore_no_auto_restore', 06:17:02 INFO - 'tabpaint']}, 06:17:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['a11yr', 06:17:02 INFO - 'ts_paint', 06:17:02 INFO - 'tpaint', 06:17:02 INFO - 'sessionrestore', 06:17:02 INFO - 'sessionrestore_no_auto_restore', 06:17:02 INFO - 'tabpaint']}, 06:17:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['tsvgx', 06:17:02 INFO - 'tsvgr_opacity', 06:17:02 INFO - 'tart', 06:17:02 INFO - 'tscrollx', 06:17:02 INFO - 'cart']}, 06:17:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:17:02 INFO - 'tsvgr_opacity', 06:17:02 INFO - 'tart', 06:17:02 INFO - 'tscrollx', 06:17:02 INFO - 'cart']}, 06:17:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'talos_options': ['--disable-e10s'], 06:17:02 INFO - 'tests': ['tp5o']}, 06:17:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'tests': ['tp5o']}, 06:17:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'talos_options': ['--disable-e10s', 06:17:02 INFO - '--xperf_path', 06:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:02 INFO - 'tests': ['tp5n']}, 06:17:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:02 INFO - 'talos_options': ['--xperf_path', 06:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:02 INFO - 'tests': ['tp5n']}}, 06:17:02 INFO - 'talos.zip': {'path': '', 06:17:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:17:02 INFO - Running post-action listener: _resource_record_post_action 06:17:02 INFO - ##### 06:17:02 INFO - ##### Running create-virtualenv step. 06:17:02 INFO - ##### 06:17:02 INFO - Running pre-action listener: _resource_record_pre_action 06:17:02 INFO - Running main action method: create_virtualenv 06:17:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:17:02 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 06:17:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:17:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:17:02 INFO - Using real prefix '/usr' 06:17:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:17:03 INFO - Installing distribute.............................................................................................................................................................................................done. 06:17:05 INFO - Installing pip.................done. 06:17:05 INFO - Return code: 0 06:17:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:17:05 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')]} 06:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:05 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')]} 06:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:05 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:05 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 06:17:05 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 06:17:05 INFO - Using env: {'DISPLAY': ':0', 06:17:05 INFO - 'HOME': '/home/cltbld', 06:17:05 INFO - 'LANG': 'en_US.UTF-8', 06:17:05 INFO - 'LANGUAGE': 'en_US:en', 06:17:05 INFO - 'LOGNAME': 'cltbld', 06:17:05 INFO - 'MAIL': '/var/mail/cltbld', 06:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:05 INFO - 'MOZ_NO_REMOTE': '1', 06:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:05 INFO - 'NO_EM_RESTART': '1', 06:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:05 INFO - 'PWD': '/builds/slave/test', 06:17:05 INFO - 'SHELL': '/bin/bash', 06:17:05 INFO - 'SHLVL': '1', 06:17:05 INFO - 'TERM': 'linux', 06:17:05 INFO - 'TMOUT': '86400', 06:17:05 INFO - 'USER': 'cltbld', 06:17:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:05 INFO - '_': '/tools/buildbot/bin/python'} 06:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:05 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 06:17:05 INFO - Cleaning up... 06:17:05 INFO - Return code: 0 06:17:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:17:05 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')]} 06:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:05 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')]} 06:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:05 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:05 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 06:17:05 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 06:17:05 INFO - Using env: {'DISPLAY': ':0', 06:17:05 INFO - 'HOME': '/home/cltbld', 06:17:05 INFO - 'LANG': 'en_US.UTF-8', 06:17:05 INFO - 'LANGUAGE': 'en_US:en', 06:17:05 INFO - 'LOGNAME': 'cltbld', 06:17:05 INFO - 'MAIL': '/var/mail/cltbld', 06:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:05 INFO - 'MOZ_NO_REMOTE': '1', 06:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:05 INFO - 'NO_EM_RESTART': '1', 06:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:05 INFO - 'PWD': '/builds/slave/test', 06:17:05 INFO - 'SHELL': '/bin/bash', 06:17:05 INFO - 'SHLVL': '1', 06:17:05 INFO - 'TERM': 'linux', 06:17:05 INFO - 'TMOUT': '86400', 06:17:05 INFO - 'USER': 'cltbld', 06:17:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:05 INFO - '_': '/tools/buildbot/bin/python'} 06:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:05 INFO - Downloading/unpacking psutil>=0.7.1 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:07 INFO - Installing collected packages: psutil 06:17:07 INFO - Running setup.py install for psutil 06:17:07 INFO - building 'psutil._psutil_linux' extension 06:17:07 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 06:17:07 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 06:17:07 INFO - building 'psutil._psutil_posix' extension 06:17:07 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 06:17:07 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 06:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:08 INFO - Successfully installed psutil 06:17:08 INFO - Cleaning up... 06:17:08 INFO - Return code: 0 06:17:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:17:08 INFO - Using env: {'DISPLAY': ':0', 06:17:08 INFO - 'HOME': '/home/cltbld', 06:17:08 INFO - 'LANG': 'en_US.UTF-8', 06:17:08 INFO - 'LANGUAGE': 'en_US:en', 06:17:08 INFO - 'LOGNAME': 'cltbld', 06:17:08 INFO - 'MAIL': '/var/mail/cltbld', 06:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:08 INFO - 'MOZ_NO_REMOTE': '1', 06:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:08 INFO - 'NO_EM_RESTART': '1', 06:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:08 INFO - 'PWD': '/builds/slave/test', 06:17:08 INFO - 'SHELL': '/bin/bash', 06:17:08 INFO - 'SHLVL': '1', 06:17:08 INFO - 'TERM': 'linux', 06:17:08 INFO - 'TMOUT': '86400', 06:17:08 INFO - 'USER': 'cltbld', 06:17:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:08 INFO - '_': '/tools/buildbot/bin/python'} 06:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:17:08 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 06:17:08 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 06:17:08 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 06:17:08 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 06:17:08 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 06:17:08 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 06:17:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:17:10 INFO - Installing collected packages: mozsystemmonitor 06:17:10 INFO - Running setup.py install for mozsystemmonitor 06:17:10 INFO - Successfully installed mozsystemmonitor 06:17:10 INFO - Cleaning up... 06:17:10 INFO - Return code: 0 06:17:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:17:10 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')]} 06:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:10 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')]} 06:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:10 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:10 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 06:17:10 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 06:17:10 INFO - Using env: {'DISPLAY': ':0', 06:17:10 INFO - 'HOME': '/home/cltbld', 06:17:10 INFO - 'LANG': 'en_US.UTF-8', 06:17:10 INFO - 'LANGUAGE': 'en_US:en', 06:17:10 INFO - 'LOGNAME': 'cltbld', 06:17:10 INFO - 'MAIL': '/var/mail/cltbld', 06:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:10 INFO - 'MOZ_NO_REMOTE': '1', 06:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:10 INFO - 'NO_EM_RESTART': '1', 06:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:10 INFO - 'PWD': '/builds/slave/test', 06:17:10 INFO - 'SHELL': '/bin/bash', 06:17:10 INFO - 'SHLVL': '1', 06:17:10 INFO - 'TERM': 'linux', 06:17:10 INFO - 'TMOUT': '86400', 06:17:10 INFO - 'USER': 'cltbld', 06:17:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:10 INFO - '_': '/tools/buildbot/bin/python'} 06:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:17:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:17:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 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 06:17:12 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 06:17:13 INFO - Downloading docopt-0.6.1.tar.gz 06:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:17:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:17:13 INFO - Running setup.py install for blobuploader 06:17:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:17:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:17:13 INFO - Running setup.py install for requests 06:17:13 INFO - Running setup.py install for docopt 06:17:13 INFO - Successfully installed blobuploader requests docopt 06:17:13 INFO - Cleaning up... 06:17:13 INFO - Return code: 0 06:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:13 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')]} 06:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:13 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')]} 06:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:13 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:13 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 06:17:13 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 06:17:13 INFO - Using env: {'DISPLAY': ':0', 06:17:13 INFO - 'HOME': '/home/cltbld', 06:17:13 INFO - 'LANG': 'en_US.UTF-8', 06:17:13 INFO - 'LANGUAGE': 'en_US:en', 06:17:13 INFO - 'LOGNAME': 'cltbld', 06:17:13 INFO - 'MAIL': '/var/mail/cltbld', 06:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:13 INFO - 'MOZ_NO_REMOTE': '1', 06:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:13 INFO - 'NO_EM_RESTART': '1', 06:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:13 INFO - 'PWD': '/builds/slave/test', 06:17:13 INFO - 'SHELL': '/bin/bash', 06:17:13 INFO - 'SHLVL': '1', 06:17:13 INFO - 'TERM': 'linux', 06:17:13 INFO - 'TMOUT': '86400', 06:17:13 INFO - 'USER': 'cltbld', 06:17:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:13 INFO - '_': '/tools/buildbot/bin/python'} 06:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:14 INFO - Running setup.py (path:/tmp/pip-JVPTCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:14 INFO - Running setup.py (path:/tmp/pip-vJyUIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:14 INFO - Running setup.py (path:/tmp/pip-xEMpvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:14 INFO - Running setup.py (path:/tmp/pip-wYtyJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:14 INFO - Running setup.py (path:/tmp/pip-WqRByz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:14 INFO - Running setup.py (path:/tmp/pip-Qy_f7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:14 INFO - Running setup.py (path:/tmp/pip-i2H7zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:14 INFO - Running setup.py (path:/tmp/pip-TWXXKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:14 INFO - Running setup.py (path:/tmp/pip-t5ylgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:14 INFO - Running setup.py (path:/tmp/pip-wDovl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:14 INFO - Running setup.py (path:/tmp/pip-EO80jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:14 INFO - Running setup.py (path:/tmp/pip-v8o5bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:14 INFO - Running setup.py (path:/tmp/pip-lKSrtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:14 INFO - Running setup.py (path:/tmp/pip-bv0SCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:15 INFO - Running setup.py (path:/tmp/pip-HK94FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:15 INFO - Running setup.py (path:/tmp/pip-J5mIIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:15 INFO - Running setup.py (path:/tmp/pip-JJ458w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:17:15 INFO - Running setup.py install for manifestparser 06:17:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:17:15 INFO - Running setup.py install for mozcrash 06:17:15 INFO - Running setup.py install for mozdebug 06:17:15 INFO - Running setup.py install for mozdevice 06:17:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:17:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:17:15 INFO - Running setup.py install for mozfile 06:17:15 INFO - Running setup.py install for mozhttpd 06:17:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:17:15 INFO - Running setup.py install for mozinfo 06:17:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:17:15 INFO - Running setup.py install for mozInstall 06:17:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Running setup.py install for mozleak 06:17:16 INFO - Running setup.py install for mozlog 06:17:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Running setup.py install for moznetwork 06:17:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Running setup.py install for mozprocess 06:17:16 INFO - Running setup.py install for mozprofile 06:17:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Running setup.py install for mozrunner 06:17:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Running setup.py install for mozscreenshot 06:17:16 INFO - Running setup.py install for moztest 06:17:16 INFO - Running setup.py install for mozversion 06:17:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:17:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:17:16 INFO - Cleaning up... 06:17:17 INFO - Return code: 0 06:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:17 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:17 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 06:17:17 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 06:17:17 INFO - Using env: {'DISPLAY': ':0', 06:17:17 INFO - 'HOME': '/home/cltbld', 06:17:17 INFO - 'LANG': 'en_US.UTF-8', 06:17:17 INFO - 'LANGUAGE': 'en_US:en', 06:17:17 INFO - 'LOGNAME': 'cltbld', 06:17:17 INFO - 'MAIL': '/var/mail/cltbld', 06:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:17 INFO - 'MOZ_NO_REMOTE': '1', 06:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:17 INFO - 'NO_EM_RESTART': '1', 06:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:17 INFO - 'PWD': '/builds/slave/test', 06:17:17 INFO - 'SHELL': '/bin/bash', 06:17:17 INFO - 'SHLVL': '1', 06:17:17 INFO - 'TERM': 'linux', 06:17:17 INFO - 'TMOUT': '86400', 06:17:17 INFO - 'USER': 'cltbld', 06:17:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:17 INFO - '_': '/tools/buildbot/bin/python'} 06:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:17 INFO - Running setup.py (path:/tmp/pip-FeHL1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:17 INFO - Running setup.py (path:/tmp/pip-ClkrHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:17 INFO - Running setup.py (path:/tmp/pip-oo0ON9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:17 INFO - Running setup.py (path:/tmp/pip-7KtD3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:17 INFO - Running setup.py (path:/tmp/pip-7XCc0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:17 INFO - Running setup.py (path:/tmp/pip-_1teXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:17 INFO - Running setup.py (path:/tmp/pip-xOsy30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:17 INFO - Running setup.py (path:/tmp/pip-wK3e4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:17 INFO - Running setup.py (path:/tmp/pip-sItQxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:17 INFO - Running setup.py (path:/tmp/pip-iN3Ltl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:17 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)) 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:17 INFO - Running setup.py (path:/tmp/pip-4SpR00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:18 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)) 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:18 INFO - Running setup.py (path:/tmp/pip-cgetVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:18 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)) 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:18 INFO - Running setup.py (path:/tmp/pip-sQg7sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:18 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)) 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:18 INFO - Running setup.py (path:/tmp/pip-CwJkrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:18 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)) 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:18 INFO - Running setup.py (path:/tmp/pip-LYMcG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:18 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)) 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:18 INFO - Running setup.py (path:/tmp/pip-27AK1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:18 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)) 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:18 INFO - Running setup.py (path:/tmp/pip-AKHFz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:18 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)) 06:17:18 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)) 06:17:18 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)) 06:17:18 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)) 06:17:18 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)) 06:17:18 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)) 06:17:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:17:18 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 06:17:18 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 06:17:18 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 06:17:18 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 06:17:18 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 06:17:18 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 06:17:20 INFO - Downloading blessings-1.6.tar.gz 06:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:17:20 INFO - Installing collected packages: blessings 06:17:20 INFO - Running setup.py install for blessings 06:17:20 INFO - Successfully installed blessings 06:17:20 INFO - Cleaning up... 06:17:20 INFO - Return code: 0 06:17:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:20 INFO - Reading from file tmpfile_stdout 06:17:20 INFO - Current package versions: 06:17:20 INFO - argparse == 1.2.1 06:17:20 INFO - blessings == 1.6 06:17:20 INFO - blobuploader == 1.2.4 06:17:20 INFO - docopt == 0.6.1 06:17:20 INFO - manifestparser == 1.1 06:17:20 INFO - mozInstall == 1.12 06:17:20 INFO - mozcrash == 0.17 06:17:20 INFO - mozdebug == 0.1 06:17:20 INFO - mozdevice == 0.48 06:17:20 INFO - mozfile == 1.2 06:17:20 INFO - mozhttpd == 0.7 06:17:20 INFO - mozinfo == 0.9 06:17:20 INFO - mozleak == 0.1 06:17:20 INFO - mozlog == 3.1 06:17:20 INFO - moznetwork == 0.27 06:17:20 INFO - mozprocess == 0.22 06:17:20 INFO - mozprofile == 0.28 06:17:20 INFO - mozrunner == 6.11 06:17:20 INFO - mozscreenshot == 0.1 06:17:20 INFO - mozsystemmonitor == 0.0 06:17:20 INFO - moztest == 0.7 06:17:20 INFO - mozversion == 1.4 06:17:20 INFO - psutil == 3.1.1 06:17:20 INFO - requests == 1.2.3 06:17:20 INFO - wsgiref == 0.1.2 06:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:20 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:20 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 06:17:20 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 06:17:20 INFO - Using env: {'DISPLAY': ':0', 06:17:20 INFO - 'HOME': '/home/cltbld', 06:17:20 INFO - 'LANG': 'en_US.UTF-8', 06:17:20 INFO - 'LANGUAGE': 'en_US:en', 06:17:20 INFO - 'LOGNAME': 'cltbld', 06:17:20 INFO - 'MAIL': '/var/mail/cltbld', 06:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:20 INFO - 'MOZ_NO_REMOTE': '1', 06:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:20 INFO - 'NO_EM_RESTART': '1', 06:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:20 INFO - 'PWD': '/builds/slave/test', 06:17:20 INFO - 'SHELL': '/bin/bash', 06:17:20 INFO - 'SHLVL': '1', 06:17:20 INFO - 'TERM': 'linux', 06:17:20 INFO - 'TMOUT': '86400', 06:17:20 INFO - 'USER': 'cltbld', 06:17:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:20 INFO - '_': '/tools/buildbot/bin/python'} 06:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 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)) 06:17:21 INFO - Cleaning up... 06:17:21 INFO - Return code: 0 06:17:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:17:21 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')]} 06:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:21 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')]} 06:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:21 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:21 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 06:17:21 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 06:17:21 INFO - Using env: {'DISPLAY': ':0', 06:17:21 INFO - 'HOME': '/home/cltbld', 06:17:21 INFO - 'LANG': 'en_US.UTF-8', 06:17:21 INFO - 'LANGUAGE': 'en_US:en', 06:17:21 INFO - 'LOGNAME': 'cltbld', 06:17:21 INFO - 'MAIL': '/var/mail/cltbld', 06:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:21 INFO - 'MOZ_NO_REMOTE': '1', 06:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:21 INFO - 'NO_EM_RESTART': '1', 06:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:21 INFO - 'PWD': '/builds/slave/test', 06:17:21 INFO - 'SHELL': '/bin/bash', 06:17:21 INFO - 'SHLVL': '1', 06:17:21 INFO - 'TERM': 'linux', 06:17:21 INFO - 'TMOUT': '86400', 06:17:21 INFO - 'USER': 'cltbld', 06:17:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:21 INFO - '_': '/tools/buildbot/bin/python'} 06:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:21 INFO - Downloading/unpacking jsonschema 06:17:21 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 06:17:21 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 06:17:21 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 06:17:21 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 06:17:21 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 06:17:21 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 06:17:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:17:23 INFO - Downloading/unpacking functools32 (from jsonschema) 06:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:23 INFO - Downloading functools32-3.2.3-2.tar.gz 06:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:17:23 INFO - warning: no files found matching '*.txt' 06:17:23 INFO - no previously-included directories found matching 'build' 06:17:23 INFO - no previously-included directories found matching 'dist' 06:17:23 INFO - no previously-included directories found matching '.git*' 06:17:23 INFO - Installing collected packages: jsonschema, functools32 06:17:23 INFO - Running setup.py install for functools32 06:17:23 INFO - warning: no files found matching '*.txt' 06:17:23 INFO - no previously-included directories found matching 'build' 06:17:23 INFO - no previously-included directories found matching 'dist' 06:17:23 INFO - no previously-included directories found matching '.git*' 06:17:23 INFO - Successfully installed jsonschema functools32 06:17:23 INFO - Cleaning up... 06:17:23 INFO - Return code: 0 06:17:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:17:23 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')]} 06:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:23 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')]} 06:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:23 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 0x7f2bdd90ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', '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 06:17:23 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 06:17:23 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 06:17:23 INFO - Using env: {'DISPLAY': ':0', 06:17:23 INFO - 'HOME': '/home/cltbld', 06:17:23 INFO - 'LANG': 'en_US.UTF-8', 06:17:23 INFO - 'LANGUAGE': 'en_US:en', 06:17:23 INFO - 'LOGNAME': 'cltbld', 06:17:23 INFO - 'MAIL': '/var/mail/cltbld', 06:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:23 INFO - 'MOZ_NO_REMOTE': '1', 06:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:23 INFO - 'NO_EM_RESTART': '1', 06:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:23 INFO - 'PWD': '/builds/slave/test', 06:17:23 INFO - 'SHELL': '/bin/bash', 06:17:23 INFO - 'SHLVL': '1', 06:17:23 INFO - 'TERM': 'linux', 06:17:23 INFO - 'TMOUT': '86400', 06:17:23 INFO - 'USER': 'cltbld', 06:17:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:23 INFO - '_': '/tools/buildbot/bin/python'} 06:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:23 INFO - Downloading/unpacking flake8 06:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:17:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:17:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:17:26 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 06:17:26 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 06:17:26 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 06:17:26 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 06:17:26 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 06:17:26 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 06:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:17:26 INFO - no previously-included directories found matching 'docs/_build' 06:17:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:17:26 INFO - Running setup.py install for pep8 06:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:17:26 INFO - no previously-included directories found matching 'docs/_build' 06:17:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:17:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:17:26 INFO - Cleaning up... 06:17:26 INFO - Return code: 0 06:17:26 INFO - Running post-action listener: _resource_record_post_action 06:17:26 INFO - Running post-action listener: _start_resource_monitoring 06:17:26 INFO - Starting resource monitoring. 06:17:26 INFO - ##### 06:17:26 INFO - ##### Running install step. 06:17:26 INFO - ##### 06:17:26 INFO - Running pre-action listener: _resource_record_pre_action 06:17:26 INFO - Running main action method: install 06:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:26 INFO - Reading from file tmpfile_stdout 06:17:26 INFO - Detecting whether we're running mozinstall >=1.0... 06:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:17:26 INFO - Reading from file tmpfile_stdout 06:17:26 INFO - Output received: 06:17:26 INFO - Usage: mozinstall [options] installer 06:17:26 INFO - Options: 06:17:26 INFO - -h, --help show this help message and exit 06:17:26 INFO - -d DEST, --destination=DEST 06:17:26 INFO - Directory to install application into. [default: 06:17:26 INFO - "/builds/slave/test"] 06:17:26 INFO - --app=APP Application being installed. [default: firefox] 06:17:26 INFO - mkdir: /builds/slave/test/build/application 06:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:17:42 INFO - Reading from file tmpfile_stdout 06:17:42 INFO - Output received: 06:17:42 INFO - /builds/slave/test/build/application/firefox/firefox 06:17:42 INFO - Running post-action listener: _resource_record_post_action 06:17:42 INFO - ##### 06:17:42 INFO - ##### Running run-tests step. 06:17:42 INFO - ##### 06:17:42 INFO - Running pre-action listener: _resource_record_pre_action 06:17:42 INFO - Running main action method: run_tests 06:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:17:42 INFO - Python 2.7.3 06:17:42 INFO - Return code: 0 06:17:42 INFO - grabbing minidump binary from tooltool 06:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:42 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 0x212c410>, '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 0x212d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:17:42 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 06:17:42 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 06:17:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:17:42 INFO - Return code: 0 06:17:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:17:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:17:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:17:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:17:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:17:43 INFO - Return code: 0 06:17:43 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/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 06:17:43 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/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 06:17:43 INFO - Using env: {'DISPLAY': ':0', 06:17:43 INFO - 'HOME': '/home/cltbld', 06:17:43 INFO - 'LANG': 'en_US.UTF-8', 06:17:43 INFO - 'LANGUAGE': 'en_US:en', 06:17:43 INFO - 'LOGNAME': 'cltbld', 06:17:43 INFO - 'MAIL': '/var/mail/cltbld', 06:17:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:17:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:43 INFO - 'MOZ_NO_REMOTE': '1', 06:17:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:43 INFO - 'NO_EM_RESTART': '1', 06:17:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:43 INFO - 'PWD': '/builds/slave/test', 06:17:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:17:43 INFO - 'SHELL': '/bin/bash', 06:17:43 INFO - 'SHLVL': '1', 06:17:43 INFO - 'TERM': 'linux', 06:17:43 INFO - 'TMOUT': '86400', 06:17:43 INFO - 'USER': 'cltbld', 06:17:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323', 06:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:43 INFO - '_': '/tools/buildbot/bin/python'} 06:17:43 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/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 06:17:44 INFO - mozversion application_buildid: 20160430045635 06:17:44 INFO - mozversion application_changeset: 1461a4071341c282afcf7b72e33036412d2251d4 06:17:44 INFO - mozversion application_display_name: Nightly 06:17:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:17:44 INFO - mozversion application_name: Firefox 06:17:44 INFO - mozversion application_remotingname: firefox 06:17:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:17:44 INFO - mozversion application_vendor: Mozilla 06:17:44 INFO - mozversion application_version: 49.0a1 06:17:44 INFO - mozversion platform_buildid: 20160430045635 06:17:44 INFO - mozversion platform_changeset: 1461a4071341c282afcf7b72e33036412d2251d4 06:17:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:17:44 INFO - mozversion platform_version: 49.0a1 06:17:44 INFO - using testdate: 1462022264 06:17:44 INFO - actual date: 1462022264 06:17:44 INFO - starting webserver on 'localhost:55170' 06:17:44 INFO - SUITE-START | Running 2 tests 06:17:44 INFO - TEST-START | dromaeo_css 06:17:44 INFO - operating with platform_type : linux_ 06:17:44 INFO - Initialising browser for dromaeo_css test... 06:17:44 INFO - TEST-INFO | started process 16111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tSpBO/profile http://localhost:55170/getInfo.html) 06:17:48 INFO - PROCESS | 16111 | __metrics Screen width/height:1600/1200 06:17:48 INFO - PROCESS | 16111 | colorDepth:24 06:17:48 INFO - PROCESS | 16111 | Browser inner width/height: 1024/697 06:17:48 INFO - PROCESS | 16111 | __metrics 06:17:50 ERROR - PROCESS | 16111 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:51 INFO - TEST-INFO | 16111: exit 0 06:17:51 INFO - Browser initialized. 06:17:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:17:51 INFO - TEST-INFO | started process 16193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tSpBO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:02 INFO - PROCESS | 16193 | RSS: Main: 155914240 06:18:02 INFO - PROCESS | 16193 | 06:18:54 INFO - PROCESS | 16193 | 1462022334482 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] 06:21:06 INFO - PROCESS | 16193 | Cycle 1(1): loaded http://localhost:55170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55170/tests/dromaeo/cssquery-ext.html) 06:21:07 INFO - PROCESS | 16193 | RSS: Main: 244097024 06:21:07 INFO - PROCESS | 16193 | 06:24:09 INFO - PROCESS | 16193 | Cycle 1(1): loaded http://localhost:55170/tests/dromaeo/cssquery-ext.html (next: http://localhost:55170/tests/dromaeo/cssquery-jquery.html) 06:24:10 INFO - PROCESS | 16193 | RSS: Main: 232833024 06:24:10 INFO - PROCESS | 16193 | 06:27:12 INFO - PROCESS | 16193 | Cycle 1(1): loaded http://localhost:55170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55170/tests/dromaeo/cssquery-mootools.html) 06:27:12 INFO - PROCESS | 16193 | RSS: Main: 236105728 06:27:12 INFO - PROCESS | 16193 | 06:30:14 INFO - PROCESS | 16193 | Cycle 1(1): loaded http://localhost:55170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55170/tests/dromaeo/cssquery-prototype.html) 06:30:15 INFO - PROCESS | 16193 | RSS: Main: 236765184 06:30:15 INFO - PROCESS | 16193 | 06:33:18 INFO - PROCESS | 16193 | Cycle 1(1): loaded http://localhost:55170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55170/tests/dromaeo/cssquery-yui.html) 06:33:19 INFO - PROCESS | 16193 | RSS: Main: 214441984 06:33:19 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | Cycle 1(1): loaded http://localhost:55170/tests/dromaeo/cssquery-yui.html (next: http://localhost:55170/tests/dromaeo/cssquery-dojo.html) 06:36:21 INFO - PROCESS | 16193 | RSS: Main: 269230080 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | __start_tp_report 06:36:21 INFO - PROCESS | 16193 | _x_x_mozilla_page_load 06:36:21 INFO - PROCESS | 16193 | _x_x_mozilla_page_load_details 06:36:21 INFO - PROCESS | 16193 | |i|pagename|runs| 06:36:21 INFO - PROCESS | 16193 | |0;dojo.html;2611.986940065299;2677.7456141666535;2685.22128582711;2690.4484580660965;2707.4179051503925;4604.838830640928;4633.096546173498;4635.072985402916;4642.721436713795;4661.673682842203;4658.440987081546;4691.577758001779;4706.74112923789;4737.810487580493;4738.241881298993;4223.577642235768;4252.829886804532;4280.229558679436;4297.806598703066;4440.666949978765;4352.151330490556;4395.934060989071;4406.317020861771;4425.579569940851;4438.800253988562;4232.873013809591;4235.174141042467;4299.484061912591;4301.956980430187;4303.203907277164;4266.914661706748;4305.5694430557005;4306.483222013347;4316.6978311518205;4341.630961368288;4260.126674031816;4297.78511074445;4309.396684464177;4311;4348.130373925228;4564.680472366936;4592.724436533818;4633.30500424939;4656.790444430008;4671.182543054952;5019.3976722793495;5025.899482010376;5042.798288068473;5050.595952323805;5084.389873215201;5033.697978121324;5052.776778217572;5068.543831055223;5070.670406423571;5079.009593129341;4565.269556870951;4717.716936983792;4731.33761273422;4768.332433459318;4805.831795887128;5145.687849598404;5161.174212126042;5162.096633089194;5171.534561889448;5206.219067139959;4934.407871055496;4935.728534930541;4936.111499929975;4941.45643979162;4985.351904252424;4956;4995.100881841231;5016.623753218523;5099.59203263738;5100;4936.753162341868;4951.876203094879;4959.82640607577;4960.479149689303;5023.070731914608;4945.826896058693;4948.727819969936;4952.479989601112;4954.256861470736;5032.647714660012;4109.794510274474;4201.957980420157;4203.26442872496;4205.642520385741;4207.789610519461;3724.2179142380405;3727.049602351383;3740.214554943438;3741.551013878352;3744.0078379229526;4262.190183865056;4310.956890431118;4394.274944634163;4395.1868904252815;4395.780210989437;5063.746812659352;5079.466656001141;5081.18701007837;5082.186850103965;5122.564582010496;4348.28253338202;4350.456192975878;4350.651947844165;4357.54245804186;4380.342948557742;4449.310356894686;4470.284754439339;4521.231390663595;4564.383808185852;4571.291449825282;4719.457262414798;4721.315409265706;4722.858314250578;4730.692504987165;4781.306710527024;4976.850694479172;4984.700917944935;5028.698278103326;5040.6219533534395;5088.542031217208;4677.929831052469;4711.411073615798;4711.528847115261;4736.928946065743;4758.809647614056;4932.975335123301;4970.130227210296;4973.35346404965;5016.874578135576;5018.146915024382;4942.3327850741125;4999.425066117443;5045.520675535819;5065.39215294167;5109.9744501277255;4855.854324370274;4876.122297986255;4881.29221262922;4884.633652476007;4930.40835099776;4872.366592342973;4873.975630121827;4876.609871210224;4883.145449546244;4934.629902757236;4749.881252968704;4772.284157376283;4808.663393562557;4865.58642515376;4888.731119788304;4893.290472881341;4916.385451818523;4919.262110683283;4951.678140920829;4962.082014827269;4801.087793319258;4805.567498925114;4806.831760888352;4815.6147508198555;4856.295837103529 06:36:21 INFO - PROCESS | 16193 | |1;ext.html;577.428345937522;604.6613896218118;626.1296797451544;630.3727790848106;633.9112524246606;28123.43753124936;28801;28815.423691526157;28837.567436488443;28869.278268043257;34899;35151.47272790904;35156.12109697259;35184.12039699009;35309.2938141237;7404.518706284074;7615.390768738488;7616.3906887448875;7621.733239336624;7621.885671714928;7216.963915180443;7432.256774322578;7591.772246832604;7593.582352970584;9395.248380129608;9802.166815820663;9897;9914.107730304271;9925;9927.652532161375;9720.562574684122;9814.06766357195;9821.066998635119;9824.950875245579;9833.950830245874;7188.748393806244;9291.48896810675;9514.38156519824;9618.182454491307;9737.513124343825;33738.32523349544;34318.313633727186;34382.82808585966;34389.31221375584;34425;3060.617422822147;3163.3198862244726;3176.3647270545753;3493.3886569850174;3736.0846592584717;29166.854165729037;29601.407971840657;29758.85120574383;29804.552931706043;30043.849780750956;3308.801471911669;3349.246419555605;3388.15296175956;3448.4654878493875;3468.8959331220103;233857;234165;234755;234982.99999999828;235078;54270.72864635652;54616.180757288676;54619.45380546223;54623;54683.72658136684;57272.42727572754;57444.13833792497;57460.71269643625;57499.42500575024;57542;14687.853121468648;15030.17334046616;15030.32363543643;15049.097054176784;15053.473128440452;11417.771644567229;11488.080953523699;11497.425128743529;11504.194706370641;11512.079033677286;13804.654883627989;15666.686666266838;16014.519564413085;16092.517224483285;16840.494785156465;5523.1991361253195;5702.515286200636;5756.675964528182;5826;5877.5322559689985;912.0833562270009;953.7710949372239;963.4363897120263;985.5860538573817;1038.390790957107;25566.87216563905;28026;28186.85906570454;28375.57436638452;29090;973.5570315506427;991.5240684471494;993.7267251505893;996.7308826616918;1051.7948999944938;14131.222782747047;14638.268086595628;14742.63143421423;15003.949723519248;15011.474598389223;355893;361455.57816632773;362108;363084;363889;49239.50760492349;49792;49818.50181498211;49916;49967;1243.2851110611434;1245.850497940253;1249.0881656390886;1254.8807863252794;1259.571745606498;26701;27673.828134743195;27982.11452473667;28055.298617534725;28144;38520;38681.41977870391;38788.224235514564;43101.181340518626;43157.352639711055;316651;317739;317851;320518;320572;20167.79832201659;22961;24582.016719331026;25012.499750005263;25112.497750045262;36642.26715465729;36703;36882;37596.2480750378;37808.43287350637;30774.384512310076;31848.52227216547;32024.359512809147;32862.83568582142;32927.67072329246;31435.214119646276;32569.511457328634;32787;34812.82593587016;35191.648083518834;33351.666483334855;33849.32301354008;34011.95928244313;34244.315113697085;34736.82631586826;30184.396312074074;30958.69041309558;31389.686103138676;31412.842935785175;31498.842505787325;23652.88173559121;24148.87925560361;24393.51212975766;24591.631125532775;24757.381065473506 06:36:21 INFO - PROCESS | 16193 | |2;jquery.html;369.5509955404184;373.7906772207562;378.3851241732187;380.39896962798775;387.685974360768;15957.68084638308;16059.839401605981;16327.59181020475;16360.263788129532;16381.508554743346;15326.846731532682;15429.537113886601;15820.76268855968;15953.282102305395;15959.680806383894;4947.455779864212;5173.767180476869;5207.3490813648295;5222.138347172731;5222.242774797652;3759.398496240602;3964.405339199114;5121.692698438105;5680.573956953224;5946;5888.5289176865745;5898.026825573776;5922.763089476416;5923.200367950336;5923.407659234063;5896.64620122794;6080.331163572004;6083.057126145432;6084.96957515214;6087.847803804896;3451.8274086295582;5082.771275292621;5237.895242095175;5325.334333208349;5332.200169974535;19352.129154188096;19352.903235483875;19461.318853840046;21259.255926042668;21298;2026.3211824038965;2135.1886283212434;2229.665550167472;2251.223327951854;2411.7347091819884;12700.555480558229;13298.601041968757;13409.798853017213;13683.11059781111;13846.723065538734;1678.3286685325845;1766.3994241957796;1801.7567628370134;1804.927802887883;1845.2157832920955;66072.66963665151;67174.66412667955;67222.32777672258;68165.31834681639;69736.6513167436;9385.5307234638;9635.421874687541;9838.262130340254;10017.899821001842;10019;14040.666136716996;14084.15495070299;14119.858801411854;14122.788158177636;14142;7234.24040475753;7336.486445948839;7414.295641914009;7498.812529686692;7508;6976.790696279119;6983.406410455168;7010.70496866472;7108.8933665995055;7112.110986126734;6233.407826256498;6249.156363890907;6271.560990730696;6437.259715132726;6477.352264773485;1619.3765400320726;1636.2800367838113;1683.1079527850259;1750.0511637890195;1783.4649605118414;865.3942240431722;894.7449976756593;921.3412410126791;973.4451362723321;973.5570315506569;15730.9213453932;16467.917660411622;16628;16671.083090430144;17156.571085722957;864.5763575847915;889.5063239901916;900.1538553759445;911.9452832830051;933.1415098109755;9937;10020.148287395654;10074.899251007542;10114.494275286206;10123.341982771097;408641;417866;420348;423136;425879;65526;66467.66766166138;68684.31315686779;69177.65411173012;71128;957.3298690916387;979.4612962870393;990.4404011733347;993.344392700814;993.3543196922059;15284.235788210768;16049.759253610971;16056.598585035468;16140.515784526482;16304.527036816608;36559.45160822537;36720.26559468849;36851.63148368482;36960.63039369572;36969;50237.74881125571;51271.74364128155;51792.964140717726;52263.46853202374;53056.73471632617;7222.89165662526;7324.4140468763435;7378.557286562824;7489.28851759082;7515.774526764206;8718.43330183536;10830.296030757976;10872.402017889091;10884.78230435371;11016.559337626406;8661.740147795575;8699.652013919373;8858;8973.730788076367;9010.5945232466;9389.671361502315;9415.81168376615;9563.61745530171;9590.616375344907;9618.086281803218;8867.201951824367;9103.772405689911;9219.26245900313;9346.672866449642;9460.716178514656;7296.270372962661;7440.330370266702;7449.5902725350625;7504.362129219077;7677.117131529722;8348.373871959506;8444.408891377545;8544.67557528584;8891.73324800257;8954.686585969459 06:36:21 INFO - PROCESS | 16193 | |3;mootools.html;1230.9938450307748;1386.7919812028197;1411.0686946615233;1510.7960425342576;1727.3263427263369;7229.819254518639;7590.658420371083;7591.4306427018055;7596.316331530161;7606.6957321707205;7385.076865391826;7534.773956781291;7535.811604709885;7559.39524838013;7568.356689681384;1912.540990162365;1979.8416126709828;1984.3848406993807;2115.6614941609346;2133.615949129156;2197.263916587945;2277.39648993017;2279.7036385269894;2280.600894843404;2281.087564974007;2120.3638908327516;2124.1821898569005;2142.1538492295535;2143.4641339665086;2163.080690706451;1875.1749230338608;2116.9153233870625;2161.124744478481;2182.3562049195525;2185.6065908136607;2230.966535501969;2254.966175507369;2256.0750092462013;2256.6615007748806;2259.367377134405;7455.813604659873;7512.474126811126;7518.736844210426;7534.8116297092465;7543.057117860268;4386.144701783153;4495.775211239457;4501.099780043972;4558.977205113986;4559.977200113978;2647.8676066196613;2743.917682469529;2829.108830718317;2830.4622121796997;2838.3471801485775;860.6299291304737;868.9782755431102;871.8561437362828;912.3339961827836;913.4747520175926;10396.064354208082;10396.22028347877;10398.844017339747;10423.530941107669;10454.268201225917;4090.4068910008477;4201.810918508674;4253.383259427365;4283.593058659485;4289.485261768546;8963.551822408854;8987;9005.774855628531;9024.774380640536;9033.232175265044;4707.388039554904;4735.59747421473;4735.83424580138;4739.312799644033;4744.193487107131;3752.4746535485056;4100.7334523255895;4258.978705106455;4263.829446822155;4326.091520780608;3637.472566477899;3680.9079773005888;3712.832922518493;3716;3784.413415920537;1180.3331117918349;1205.5238180918664;1212.2362911365783;1220.6948262934266;1231.6489800406841;798.0861913109458;830.2735106781566;849.6898631999276;869.752120645613;886.233408102;5075.543201111917;5199.168133098686;5201.765920533585;5245.26566280721;5290.047791397586;405.36965019394535;405.38584045171586;408.13068164808766;409.1061031645804;416.37959440433536;3566.7324950628285;3576.088097535112;3647.434647629622;3686.7972261525874;3716.7212459065677;8999.910000900038;9253.676121335855;9385.296102792317;9508.144267016001;9521.333506654606;9282.814343713222;9361.672341468016;9378.577963991636;9394.624215031323;9427.858582121273;7127.4298056155385;7178.8205294867;7214.891776623354;7223.241559636268;7307.7807665770115;5305.761240744253;5319.813806516753;5329.307190065267;5390.407055224001;5474.42518535564;8536.871946920677;8624.78438039054;8676.739697809076;8751.956240218758;8757.649694012169;8686.087960764029;8687.39188256816;8783.692570759993;8784.472931624123;8856.202941735275;6416.294207637249;6440.098386225838;6586.571872828251;6615.437687796399;6616.536842420985;7209.315115064061;7214.062171917617;7255;7257.673404696696;7291.197968223385;6634.800955971328;6728.562643428358;6735.090762746966;6821.147356580427;6924.238333783381;6124.724387402666;6125.356837532173;6235.282942461675;6397.808065758035;6713.597184168965;5986.6707331097205;6020.668863212565;6031.24609423822;6041.78853740117;6096.9390306096375;4674.813007479663;4696.765161741968;4702.48272689997;4719.905601888012;4777.3311736356245;4730.929036064531;4740.265258884879;4796.56830885222;4852.417709874838;4874.975625121851 06:36:21 INFO - PROCESS | 16193 | |4;prototype.html;306.3979280713398;308.1787037544942;310.4814959018439;310.92693217093966;314.97480201583875;4810.567048965592;4820.638452116093;4841.661083724141;4846.636502262331;4906.264060390943;4788;4802.927956080662;4804.951950480503;4829.203181475061;4875.829345972883;3569.607343192253;3731.4962480065115;3736.2725210596145;3849.2493963677093;3873.709471789613;3756.0609847538117;3773.2831561639387;3804.448354988525;3815.5039844820135;3845.5000849889475;3561.982190089046;3797.4873392092127;3801.1257410795533;3802.9809850950846;3810.733248672594;3663.3955397359405;3774.6036666150208;3787.1289603391374;3803.7827895073588;3805.2389522095555;3371.393149233137;3383.7462190335823;3392.3554524640485;3395.5246265522846;3404.69357757803;4609.8156073757345;4615;4616.330632058366;4623.722576645412;4657.998530315998;4213.789310534492;4340.500842403132;4341.80461879213;4354.7604881731495;4396.538363471821;5042.243663450475;5043.52086551777;5071;5078.289039534468;5093.439721630618;3724.4599533067826;3729.2914346274392;3739.5886452490204;3741.8316175772156;3744.700423966076;5021.221710634857;5313.203019547061;5329.280547126166;5334.466553344673;5349.465053494659;3672.008557689462;3681.9079523011605;3696.2237930034994;3701.0932321581386;3704.129529560551;3736.159364143046;3741.3639681254253;3750.624937506282;3757.49273848027;3765.811709414518;4270.231358355526;4272.060146767706;4285.571442855689;4288.807003684841;4292.163028209469;4847.830325938646;5078.5175408336145;5100.846974590768;5119.950410165907;5130.79476820923;1348.7167694784205;1364.2632978191666;1365.2491129878726;1365.8429280632656;1366.3782978744648;834.9104418733612;890.581426729449;902.3457992955055;912.2565109435789;914.6021480655936;4718.787654555554;4720.716756994591;4746.477887432379;4747.643926705511;4783.330333753208;5604.719764011783;5621.915671264935;5630.74661640219;5632.915506267409;5641.210230567642;4497.887552811206;4660.370849935215;4674.182018146811;4677.6257899367965;4738.384010078667;2935.486289899259;2949.8495586721197;2963.5554666800153;2966.5401862711315;2991.8055326403714;5155.02054609623;5165.405978312542;5168.664036837594;5200.2199670049795;5202.7918883245;5145.845624631267;5379.515843574019;5436.646617969898;5437.809676661377;5650.74571644277;4986.526280003394;4995.375578052671;5000.224965130411;5023.372078490189;5030.270610761419;5312.990531798946;5314.441983591667;5318.388385335736;5331.573474122139;5337.599680024091;4917.188663870565;5153.484651534816;5180.021487644694;5221.138512145453;5222.895542089061;4962.305277261258;4982.053409852117;4996.675216110941;5010.899782004267;5020.171671674133;3643.617420170844;3684.3736564784585;3687.8567644030436;3695.6119607440833;3702.278055779097;5148.382194136728;5265.0259701955265;5311.176767601028;5349.304590403378;5381.434949330264;5107.770150343318;5118.820841270538;5134.306868572695;5152.9742351288005;5158.561522270649;5020.268007537394;5122.769475373542;5126.4360920297995;5154.381474223117;5171;4753.762311884323;5045.2432135180015;5064.620153488429;5087.2623469595965;5101.489851015017;5012.79692873715;5160.845174644766;5201.271821945006;5205.58355331565;5246.737663116905;5046.545810877039;5068.543831055223;5090.363704536933;5094.7962081516325;5113.79544818218 06:36:21 INFO - PROCESS | 16193 | |5;yui.html;669.5146019136125;684.0928581697044;685.6331862453588;691.754427178352;696.3837004251236;11430.25703329283;11768.764624707512;11786.941065294683;11796.469158887849;11805.586804461835;11281;11377;11391.088712902969;11398.202125851172;11415.54337826488;631.8767840271149;648.2609824799732;650.4438704907307;771.4946709905021;788.2275370137269;641.0480436551717;767.9385649148055;787.3268355556003;789.1634867040926;792.9960350198241;828.5318794880873;834.9707760228393;835.2941764209233;836.8702851058096;841.4110122913954;828.3207769628907;828.5857071464268;829.1873963515789;830.3606223208126;836.393614629395;488.4431747807502;592.4934181275034;598.4793229890023;614.1831364285534;615.1910238037012;11266.943665281704;11274.605388811435;11280.2667826591;11290.774184516264;11327.320360778298;11096.667099987013;11599.362035088066;11655.475503602358;11718.472668729843;12105.09211809118;9546.331756777028;9605.615775368977;9662.75843103921;9827.754306142404;9861.309708320421;3157.952630710541;3199.6160460744627;3203.8398080095903;3204.4872820348864;3261.5596894419186;40474.39288410676;41059.178816423504;41895.79052104751;43554;44229.55770442286;9555.378900371454;9588.137067663944;9600.615975361046;9695.51522423876;9765.560549775135;16236.675266494603;16315.428959986344;16353.672926541403;16394.672106557802;16420.507384778477;6525.543211975116;6577.572457790228;6597.901031484532;6665.166854143232;6669.199696036507;3647;3677.595464498903;3697.0942119180436;3707.6663100321102;3711.628837116267;2770.4874598198994;2805.424887897976;2807.2560771395597;2817.690054094048;2819.3515491436674;496.7292825410088;496.81866118866355;509.943906170321;519.1252739134495;524.3550432967395;475.66465641722505;487.61722048192;523.1551045062197;533.2214966149465;582.1606505098866;7192.352688258082;7236.38490728294;7425.85148297031;7477.738279160203;7590.430717696195;452.91621050105175;468.68363854398825;477.3412690487175;484.54095465512665;486.70311110222735;3238.449463591148;3371.5279860819505;3390.7287417006582;3450.4306789379975;3500.5974312954336;49856.50143498591;50546.241806372935;51985.7400712994;52032;52234;44017;44897.32654010192;45824;46212.53787462082;46685.76657116761;40817.387739183934;40937.59062409338;41551.58448415538;41970.790146049076;42185.36721949173;6616;6787.253402125663;6862.759803406857;6871.931280687129;6962.23415424313;26187;27657.72342276632;28394.43211135807;28505.28736781597;28619.14142575726;34182;35396.46905296474;37816.81091594524;38189.809050954565;38463.423048653734;8491.065982742017;8600.440971336842;8605.827883442422;8616.526091065052;8752;8797.780055498408;8870.778230544289;9064.954675226581;9116.042815504277;9190.908090919005;7793.805154870946;8617.396782225183;8650.610722517376;9002.954985225031;9932.404055756677;9240.584173712334;9312.255019598551;9555.856662149934;9574.952125239608;9624.133827955518;9334.813303734023;9404.905950940403;9415.482148481899;9479;9686.370385924893;8017.959910200411;8086.797830054295;8212.917870821215;8265.504069755834;8400.705975290835;7913.881291780743;8424.578771061544;8440.746777596682;8477.660893564434;8504.957475212585 06:36:21 INFO - PROCESS | 16193 | __end_tp_report 06:36:21 INFO - PROCESS | 16193 | __start_cc_report 06:36:21 INFO - PROCESS | 16193 | _x_x_mozilla_cycle_collect,901 06:36:21 INFO - PROCESS | 16193 | __end_cc_report 06:36:21 INFO - PROCESS | 16193 | __startTimestamp1462023381879__endTimestamp 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | ------- Summary: start ------- 06:36:21 INFO - PROCESS | 16193 | Number of tests: 6 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | [#0] dojo.html Cycles:165 Average:4642.34 Median:4758.81 stddev:482.47 (10.1%) stddev-sans-first:456.90 06:36:21 INFO - PROCESS | 16193 | Values: 2612.0 2677.7 2685.2 2690.4 2707.4 4604.8 4633.1 4635.1 4642.7 4661.7 4658.4 4691.6 4706.7 4737.8 4738.2 4223.6 4252.8 4280.2 4297.8 4440.7 4352.2 4395.9 4406.3 4425.6 4438.8 4232.9 4235.2 4299.5 4302.0 4303.2 4266.9 4305.6 4306.5 4316.7 4341.6 4260.1 4297.8 4309.4 4311.0 4348.1 4564.7 4592.7 4633.3 4656.8 4671.2 5019.4 5025.9 5042.8 5050.6 5084.4 5033.7 5052.8 5068.5 5070.7 5079.0 4565.3 4717.7 4731.3 4768.3 4805.8 5145.7 5161.2 5162.1 5171.5 5206.2 4934.4 4935.7 4936.1 4941.5 4985.4 4956.0 4995.1 5016.6 5099.6 5100.0 4936.8 4951.9 4959.8 4960.5 5023.1 4945.8 4948.7 4952.5 4954.3 5032.6 4109.8 4202.0 4203.3 4205.6 4207.8 3724.2 3727.0 3740.2 3741.6 3744.0 4262.2 4311.0 4394.3 4395.2 4395.8 5063.7 5079.5 5081.2 5082.2 5122.6 4348.3 4350.5 4350.7 4357.5 4380.3 4449.3 4470.3 4521.2 4564.4 4571.3 4719.5 4721.3 4722.9 4730.7 4781.3 4976.9 4984.7 5028.7 5040.6 5088.5 4677.9 4711.4 4711.5 4736.9 4758.8 4933.0 4970.1 4973.4 5016.9 5018.1 4942.3 4999.4 5045.5 5065.4 5110.0 4855.9 4876.1 4881.3 4884.6 4930.4 4872.4 4874.0 4876.6 4883.1 4934.6 4749.9 4772.3 4808.7 4865.6 4888.7 4893.3 4916.4 4919.3 4951.7 4962.1 4801.1 4805.6 4806.8 4815.6 4856.3 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | [#1] ext.html Cycles:180 Average:45359.42 Median:34281.31 stddev:81392.17 (237.4%) stddev-sans-first:81551.04 06:36:21 INFO - PROCESS | 16193 | Values: 577.4 604.7 626.1 630.4 633.9 28123.4 28801.0 28815.4 28837.6 28869.3 34899.0 35151.5 35156.1 35184.1 35309.3 7404.5 7615.4 7616.4 7621.7 7621.9 7217.0 7432.3 7591.8 7593.6 9395.2 9802.2 9897.0 9914.1 9925.0 9927.7 9720.6 9814.1 9821.1 9825.0 9834.0 7188.7 9291.5 9514.4 9618.2 9737.5 33738.3 34318.3 34382.8 34389.3 34425.0 3060.6 3163.3 3176.4 3493.4 3736.1 29166.9 29601.4 29758.9 29804.6 30043.8 3308.8 3349.2 3388.2 3448.5 3468.9 233857.0 234165.0 234755.0 234983.0 235078.0 54270.7 54616.2 54619.5 54623.0 54683.7 57272.4 57444.1 57460.7 57499.4 57542.0 14687.9 15030.2 15030.3 15049.1 15053.5 11417.8 11488.1 11497.4 11504.2 11512.1 13804.7 15666.7 16014.5 16092.5 16840.5 5523.2 5702.5 5756.7 5826.0 5877.5 912.1 953.8 963.4 985.6 1038.4 25566.9 28026.0 28186.9 28375.6 29090.0 973.6 991.5 993.7 996.7 1051.8 14131.2 14638.3 14742.6 15003.9 15011.5 355893.0 361455.6 362108.0 363084.0 363889.0 49239.5 49792.0 49818.5 49916.0 49967.0 1243.3 1245.9 1249.1 1254.9 1259.6 26701.0 27673.8 27982.1 28055.3 28144.0 38520.0 38681.4 38788.2 43101.2 43157.4 316651.0 317739.0 317851.0 320518.0 320572.0 20167.8 22961.0 24582.0 25012.5 25112.5 36642.3 36703.0 36882.0 37596.2 37808.4 30774.4 31848.5 32024.4 32862.8 32927.7 31435.2 32569.5 32787.0 34812.8 35191.6 33351.7 33849.3 34012.0 34244.3 34736.8 30184.4 30958.7 31389.7 31412.8 31498.8 23652.9 24148.9 24393.5 24591.6 24757.4 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | [#2] jquery.html Cycles:180 Average:24819.83 Median:29191.03 stddev:68850.58 (235.9%) stddev-sans-first:69019.25 06:36:21 INFO - PROCESS | 16193 | Values: 369.6 373.8 378.4 380.4 387.7 15957.7 16059.8 16327.6 16360.3 16381.5 15326.8 15429.5 15820.8 15953.3 15959.7 4947.5 5173.8 5207.3 5222.1 5222.2 3759.4 3964.4 5121.7 5680.6 5946.0 5888.5 5898.0 5922.8 5923.2 5923.4 5896.6 6080.3 6083.1 6085.0 6087.8 3451.8 5082.8 5237.9 5325.3 5332.2 19352.1 19352.9 19461.3 21259.3 21298.0 2026.3 2135.2 2229.7 2251.2 2411.7 12700.6 13298.6 13409.8 13683.1 13846.7 1678.3 1766.4 1801.8 1804.9 1845.2 66072.7 67174.7 67222.3 68165.3 69736.7 9385.5 9635.4 9838.3 10017.9 10019.0 14040.7 14084.2 14119.9 14122.8 14142.0 7234.2 7336.5 7414.3 7498.8 7508.0 6976.8 6983.4 7010.7 7108.9 7112.1 6233.4 6249.2 6271.6 6437.3 6477.4 1619.4 1636.3 1683.1 1750.1 1783.5 865.4 894.7 921.3 973.4 973.6 15730.9 16467.9 16628.0 16671.1 17156.6 864.6 889.5 900.2 911.9 933.1 9937.0 10020.1 10074.9 10114.5 10123.3 408641.0 417866.0 420348.0 423136.0 425879.0 65526.0 66467.7 68684.3 69177.7 71128.0 957.3 979.5 990.4 993.3 993.4 15284.2 16049.8 16056.6 16140.5 16304.5 36559.5 36720.3 36851.6 36960.6 36969.0 50237.7 51271.7 51793.0 52263.5 53056.7 7222.9 7324.4 7378.6 7489.3 7515.8 8718.4 10830.3 10872.4 10884.8 11016.6 8661.7 8699.7 8858.0 8973.7 9010.6 9389.7 9415.8 9563.6 9590.6 9618.1 8867.2 9103.8 9219.3 9346.7 9460.7 7296.3 7440.3 7449.6 7504.4 7677.1 8348.4 8444.4 8544.7 8891.7 8954.7 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | [#3] mootools.html Cycles:180 Average:5044.52 Median:5137.36 stddev:2803.31 (54.6%) stddev-sans-first:2796.53 06:36:21 INFO - PROCESS | 16193 | Values: 1231.0 1386.8 1411.1 1510.8 1727.3 7229.8 7590.7 7591.4 7596.3 7606.7 7385.1 7534.8 7535.8 7559.4 7568.4 1912.5 1979.8 1984.4 2115.7 2133.6 2197.3 2277.4 2279.7 2280.6 2281.1 2120.4 2124.2 2142.2 2143.5 2163.1 1875.2 2116.9 2161.1 2182.4 2185.6 2231.0 2255.0 2256.1 2256.7 2259.4 7455.8 7512.5 7518.7 7534.8 7543.1 4386.1 4495.8 4501.1 4559.0 4560.0 2647.9 2743.9 2829.1 2830.5 2838.3 860.6 869.0 871.9 912.3 913.5 10396.1 10396.2 10398.8 10423.5 10454.3 4090.4 4201.8 4253.4 4283.6 4289.5 8963.6 8987.0 9005.8 9024.8 9033.2 4707.4 4735.6 4735.8 4739.3 4744.2 3752.5 4100.7 4259.0 4263.8 4326.1 3637.5 3680.9 3712.8 3716.0 3784.4 1180.3 1205.5 1212.2 1220.7 1231.6 798.1 830.3 849.7 869.8 886.2 5075.5 5199.2 5201.8 5245.3 5290.0 405.4 405.4 408.1 409.1 416.4 3566.7 3576.1 3647.4 3686.8 3716.7 8999.9 9253.7 9385.3 9508.1 9521.3 9282.8 9361.7 9378.6 9394.6 9427.9 7127.4 7178.8 7214.9 7223.2 7307.8 5305.8 5319.8 5329.3 5390.4 5474.4 8536.9 8624.8 8676.7 8752.0 8757.6 8686.1 8687.4 8783.7 8784.5 8856.2 6416.3 6440.1 6586.6 6615.4 6616.5 7209.3 7214.1 7255.0 7257.7 7291.2 6634.8 6728.6 6735.1 6821.1 6924.2 6124.7 6125.4 6235.3 6397.8 6713.6 5986.7 6020.7 6031.2 6041.8 6096.9 4674.8 4696.8 4702.5 4719.9 4777.3 4730.9 4740.3 4796.6 4852.4 4875.0 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | [#4] prototype.html Cycles:180 Average:4278.16 Median:4824.92 stddev:1241.99 (25.7%) stddev-sans-first:1209.17 06:36:21 INFO - PROCESS | 16193 | Values: 306.4 308.2 310.5 310.9 315.0 4810.6 4820.6 4841.7 4846.6 4906.3 4788.0 4802.9 4805.0 4829.2 4875.8 3569.6 3731.5 3736.3 3849.2 3873.7 3756.1 3773.3 3804.4 3815.5 3845.5 3562.0 3797.5 3801.1 3803.0 3810.7 3663.4 3774.6 3787.1 3803.8 3805.2 3371.4 3383.7 3392.4 3395.5 3404.7 4609.8 4615.0 4616.3 4623.7 4658.0 4213.8 4340.5 4341.8 4354.8 4396.5 5042.2 5043.5 5071.0 5078.3 5093.4 3724.5 3729.3 3739.6 3741.8 3744.7 5021.2 5313.2 5329.3 5334.5 5349.5 3672.0 3681.9 3696.2 3701.1 3704.1 3736.2 3741.4 3750.6 3757.5 3765.8 4270.2 4272.1 4285.6 4288.8 4292.2 4847.8 5078.5 5100.8 5120.0 5130.8 1348.7 1364.3 1365.2 1365.8 1366.4 834.9 890.6 902.3 912.3 914.6 4718.8 4720.7 4746.5 4747.6 4783.3 5604.7 5621.9 5630.7 5632.9 5641.2 4497.9 4660.4 4674.2 4677.6 4738.4 2935.5 2949.8 2963.6 2966.5 2991.8 5155.0 5165.4 5168.7 5200.2 5202.8 5145.8 5379.5 5436.6 5437.8 5650.7 4986.5 4995.4 5000.2 5023.4 5030.3 5313.0 5314.4 5318.4 5331.6 5337.6 4917.2 5153.5 5180.0 5221.1 5222.9 4962.3 4982.1 4996.7 5010.9 5020.2 3643.6 3684.4 3687.9 3695.6 3702.3 5148.4 5265.0 5311.2 5349.3 5381.4 5107.8 5118.8 5134.3 5153.0 5158.6 5020.3 5122.8 5126.4 5154.4 5171.0 4753.8 5045.2 5064.6 5087.3 5101.5 5012.8 5160.8 5201.3 5205.6 5246.7 5046.5 5068.5 5090.4 5094.8 5113.8 06:36:21 INFO - PROCESS | 16193 | 06:36:21 INFO - PROCESS | 16193 | [#5] yui.html Cycles:180 Average:11907.25 Median:587.33 stddev:13957.67 (2376.5%) stddev-sans-first:13971.32 06:36:21 INFO - PROCESS | 16193 | Values: 669.5 684.1 685.6 691.8 696.4 11430.3 11768.8 11786.9 11796.5 11805.6 11281.0 11377.0 11391.1 11398.2 11415.5 631.9 648.3 650.4 771.5 788.2 641.0 767.9 787.3 789.2 793.0 828.5 835.0 835.3 836.9 841.4 828.3 828.6 829.2 830.4 836.4 488.4 592.5 598.5 614.2 615.2 11266.9 11274.6 11280.3 11290.8 11327.3 11096.7 11599.4 11655.5 11718.5 12105.1 9546.3 9605.6 9662.8 9827.8 9861.3 3158.0 3199.6 3203.8 3204.5 3261.6 40474.4 41059.2 41895.8 43554.0 44229.6 9555.4 9588.1 9600.6 9695.5 9765.6 16236.7 16315.4 16353.7 16394.7 16420.5 6525.5 6577.6 6597.9 6665.2 6669.2 3647.0 3677.6 3697.1 3707.7 3711.6 2770.5 2805.4 2807.3 2817.7 2819.4 496.7 496.8 509.9 519.1 524.4 475.7 487.6 523.2 533.2 582.2 7192.4 7236.4 7425.9 7477.7 7590.4 452.9 468.7 477.3 484.5 486.7 3238.4 3371.5 3390.7 3450.4 3500.6 49856.5 50546.2 51985.7 52032.0 52234.0 44017.0 44897.3 45824.0 46212.5 46685.8 40817.4 40937.6 41551.6 41970.8 42185.4 6616.0 6787.3 6862.8 6871.9 6962.2 26187.0 27657.7 28394.4 28505.3 28619.1 34182.0 35396.5 37816.8 38189.8 38463.4 8491.1 8600.4 8605.8 8616.5 8752.0 8797.8 8870.8 9065.0 9116.0 9190.9 7793.8 8617.4 8650.6 9003.0 9932.4 9240.6 9312.3 9555.9 9575.0 9624.1 9334.8 9404.9 9415.5 9479.0 9686.4 8018.0 8086.8 8212.9 8265.5 8400.7 7913.9 8424.6 8440.7 8477.7 8505.0 06:36:21 INFO - PROCESS | 16193 | -------- Summary: end -------- 06:36:21 INFO - PROCESS | 16193 | 06:36:22 INFO - TEST-INFO | 16193: exit 0 06:36:22 INFO - TEST-OK | dromaeo_css | took 1118658ms 06:36:22 INFO - TEST-START | kraken 06:36:22 INFO - operating with platform_type : linux_ 06:36:22 INFO - Initialising browser for kraken test... 06:36:22 INFO - TEST-INFO | started process 16372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlBzHC/profile http://localhost:55170/getInfo.html) 06:36:27 INFO - PROCESS | 16372 | __metrics Screen width/height:1600/1200 06:36:27 INFO - PROCESS | 16372 | colorDepth:24 06:36:27 INFO - PROCESS | 16372 | Browser inner width/height: 1024/697 06:36:27 INFO - PROCESS | 16372 | __metrics 06:36:28 ERROR - PROCESS | 16372 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:36:29 INFO - TEST-INFO | 16372: exit 0 06:36:29 INFO - Browser initialized. 06:36:29 INFO - Running cycle 1/1 for kraken test... 06:36:29 INFO - TEST-INFO | started process 16454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlBzHC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:41 INFO - PROCESS | 16454 | RSS: Main: 155680768 06:36:41 INFO - PROCESS | 16454 | 06:36:44 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55170/tests/kraken/driver.html?testName=audio-beat-detection) 06:36:45 INFO - PROCESS | 16454 | RSS: Main: 210841600 06:36:45 INFO - PROCESS | 16454 | 06:36:48 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55170/tests/kraken/driver.html?testName=audio-dft) 06:36:48 INFO - PROCESS | 16454 | RSS: Main: 197177344 06:36:48 INFO - PROCESS | 16454 | 06:36:52 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55170/tests/kraken/driver.html?testName=audio-fft) 06:36:52 INFO - PROCESS | 16454 | RSS: Main: 266932224 06:36:52 INFO - PROCESS | 16454 | 06:36:54 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55170/tests/kraken/driver.html?testName=audio-oscillator) 06:36:55 INFO - PROCESS | 16454 | RSS: Main: 175501312 06:36:55 INFO - PROCESS | 16454 | 06:36:57 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:36:58 INFO - PROCESS | 16454 | RSS: Main: 179748864 06:36:58 INFO - PROCESS | 16454 | 06:37:01 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55170/tests/kraken/driver.html?testName=imaging-darkroom) 06:37:02 INFO - PROCESS | 16454 | RSS: Main: 215105536 06:37:02 INFO - PROCESS | 16454 | 06:37:05 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55170/tests/kraken/driver.html?testName=imaging-desaturate) 06:37:06 INFO - PROCESS | 16454 | RSS: Main: 213291008 06:37:06 INFO - PROCESS | 16454 | 06:37:09 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55170/tests/kraken/driver.html?testName=json-parse-financial) 06:37:09 INFO - PROCESS | 16454 | RSS: Main: 214433792 06:37:09 INFO - PROCESS | 16454 | 06:37:11 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:37:12 INFO - PROCESS | 16454 | RSS: Main: 200966144 06:37:12 INFO - PROCESS | 16454 | 06:37:13 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:37:14 INFO - PROCESS | 16454 | RSS: Main: 200060928 06:37:14 INFO - PROCESS | 16454 | 06:37:16 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:37:17 INFO - PROCESS | 16454 | RSS: Main: 214892544 06:37:17 INFO - PROCESS | 16454 | 06:37:20 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:37:20 INFO - PROCESS | 16454 | RSS: Main: 225198080 06:37:20 INFO - PROCESS | 16454 | 06:37:23 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:37:24 INFO - PROCESS | 16454 | RSS: Main: 220106752 06:37:24 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | Cycle 1(1): loaded http://localhost:55170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55170/tests/kraken/driver.html?testName=ai-astar) 06:37:26 INFO - PROCESS | 16454 | RSS: Main: 283738112 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | __start_tp_report 06:37:26 INFO - PROCESS | 16454 | _x_x_mozilla_page_load 06:37:26 INFO - PROCESS | 16454 | _x_x_mozilla_page_load_details 06:37:26 INFO - PROCESS | 16454 | |i|pagename|runs| 06:37:26 INFO - PROCESS | 16454 | |0;ai-astar;111;114;108;112;117;117;103;114;114;114 06:37:26 INFO - PROCESS | 16454 | |1;audio-beat-detection;165;135;169;187;135;170;158;145;202;133 06:37:26 INFO - PROCESS | 16454 | |2;audio-dft;161;162;161;163;162;165;162;163;162;162 06:37:26 INFO - PROCESS | 16454 | |3;audio-fft;76;76;114;109;78;76;78;115;111;77 06:37:26 INFO - PROCESS | 16454 | |4;audio-oscillator;96;95;153;95;94;94;146;94;95;147 06:37:26 INFO - PROCESS | 16454 | |5;imaging-gaussian-blur;118;118;117;117;116;118;118;117;117;116 06:37:26 INFO - PROCESS | 16454 | |6;imaging-darkroom;146;147;146;146;147;146;147;146;146;147 06:37:26 INFO - PROCESS | 16454 | |7;imaging-desaturate;94;95;96;95;96;96;95;96;95;96 06:37:26 INFO - PROCESS | 16454 | |8;json-parse-financial;69;69;68;67;68;68;69;80;66;67 06:37:26 INFO - PROCESS | 16454 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;66;66;66 06:37:26 INFO - PROCESS | 16454 | |10;stanford-crypto-aes;81;81;82;82;84;83;82;81;89;83 06:37:26 INFO - PROCESS | 16454 | |11;stanford-crypto-ccm;142;131;132;131;129;129;134;131;165;132 06:37:26 INFO - PROCESS | 16454 | |12;stanford-crypto-pbkdf2;180;187;180;180;179;177;178;178;182;177 06:37:26 INFO - PROCESS | 16454 | |13;stanford-crypto-sha256-iterative;73;74;74;73;74;73;72;72;74;74 06:37:26 INFO - PROCESS | 16454 | __end_tp_report 06:37:26 INFO - PROCESS | 16454 | __start_cc_report 06:37:26 INFO - PROCESS | 16454 | _x_x_mozilla_cycle_collect,1908 06:37:26 INFO - PROCESS | 16454 | __end_cc_report 06:37:26 INFO - PROCESS | 16454 | __startTimestamp1462023446516__endTimestamp 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | ------- Summary: start ------- 06:37:26 INFO - PROCESS | 16454 | Number of tests: 14 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:4.25 (3.7%) stddev-sans-first:4.48 06:37:26 INFO - PROCESS | 16454 | Values: 111.0 114.0 108.0 112.0 117.0 117.0 103.0 114.0 114.0 114.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#1] audio-beat-detection Cycles:10 Average:159.90 Median:167.00 stddev:23.35 (14.0%) stddev-sans-first:24.69 06:37:26 INFO - PROCESS | 16454 | Values: 165.0 135.0 169.0 187.0 135.0 170.0 158.0 145.0 202.0 133.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 06:37:26 INFO - PROCESS | 16454 | Values: 161.0 162.0 161.0 163.0 162.0 165.0 162.0 163.0 162.0 162.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#3] audio-fft Cycles:10 Average:91.00 Median:76.00 stddev:18.37 (24.2%) stddev-sans-first:18.67 06:37:26 INFO - PROCESS | 16454 | Values: 76.0 76.0 114.0 109.0 78.0 76.0 78.0 115.0 111.0 77.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.50 stddev:26.13 (27.7%) stddev-sans-first:27.15 06:37:26 INFO - PROCESS | 16454 | Values: 96.0 95.0 153.0 95.0 94.0 94.0 146.0 94.0 95.0 147.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 06:37:26 INFO - PROCESS | 16454 | Values: 118.0 118.0 117.0 117.0 116.0 118.0 118.0 117.0 117.0 116.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:37:26 INFO - PROCESS | 16454 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 06:37:26 INFO - PROCESS | 16454 | Values: 94.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:68.50 stddev:3.96 (5.8%) stddev-sans-first:4.20 06:37:26 INFO - PROCESS | 16454 | Values: 69.0 69.0 68.0 67.0 68.0 68.0 69.0 80.0 66.0 67.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 06:37:26 INFO - PROCESS | 16454 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.39 (2.9%) stddev-sans-first:2.45 06:37:26 INFO - PROCESS | 16454 | Values: 81.0 81.0 82.0 82.0 84.0 83.0 82.0 81.0 89.0 83.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:132.00 stddev:10.98 (8.3%) stddev-sans-first:11.40 06:37:26 INFO - PROCESS | 16454 | Values: 142.0 131.0 132.0 131.0 129.0 129.0 134.0 131.0 165.0 132.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:180.00 stddev:2.97 (1.7%) stddev-sans-first:3.15 06:37:26 INFO - PROCESS | 16454 | Values: 180.0 187.0 180.0 180.0 179.0 177.0 178.0 178.0 182.0 177.0 06:37:26 INFO - PROCESS | 16454 | 06:37:26 INFO - PROCESS | 16454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 06:37:26 INFO - PROCESS | 16454 | Values: 73.0 74.0 74.0 73.0 74.0 73.0 72.0 72.0 74.0 74.0 06:37:26 INFO - PROCESS | 16454 | -------- Summary: end -------- 06:37:26 INFO - PROCESS | 16454 | 06:37:27 INFO - TEST-INFO | 16454: exit 0 06:37:27 INFO - TEST-OK | kraken | took 65204ms 06:37:27 INFO - SUITE-END | took 1183s 06:37:28 INFO - Completed test suite (00:19:44) 06:37:28 INFO - javascript benchmark 06:37:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.986940065299, 2677.7456141666535, 2685.22128582711, 2690.4484580660965, 2707.4179051503925, 4604.838830640928, 4633.096546173498, 4635.072985402916, 4642.721436713795, 4661.673682842203, 4658.440987081546, 4691.577758001779, 4706.74112923789, 4737.810487580493, 4738.241881298993, 4223.577642235768, 4252.829886804532, 4280.229558679436, 4297.806598703066, 4440.666949978765, 4352.151330490556, 4395.934060989071, 4406.317020861771, 4425.579569940851, 4438.800253988562, 4232.873013809591, 4235.174141042467, 4299.484061912591, 4301.956980430187, 4303.203907277164, 4266.914661706748, 4305.5694430557005, 4306.483222013347, 4316.6978311518205, 4341.630961368288, 4260.126674031816, 4297.78511074445, 4309.396684464177, 4311.0, 4348.130373925228, 4564.680472366936, 4592.724436533818, 4633.30500424939, 4656.790444430008, 4671.182543054952, 5019.3976722793495, 5025.899482010376, 5042.798288068473, 5050.595952323805, 5084.389873215201, 5033.697978121324, 5052.776778217572, 5068.543831055223, 5070.670406423571, 5079.009593129341, 4565.269556870951, 4717.716936983792, 4731.33761273422, 4768.332433459318, 4805.831795887128, 5145.687849598404, 5161.174212126042, 5162.096633089194, 5171.534561889448, 5206.219067139959, 4934.407871055496, 4935.728534930541, 4936.111499929975, 4941.45643979162, 4985.351904252424, 4956.0, 4995.100881841231, 5016.623753218523, 5099.59203263738, 5100.0, 4936.753162341868, 4951.876203094879, 4959.82640607577, 4960.479149689303, 5023.070731914608, 4945.826896058693, 4948.727819969936, 4952.479989601112, 4954.256861470736, 5032.647714660012, 4109.794510274474, 4201.957980420157, 4203.26442872496, 4205.642520385741, 4207.789610519461, 3724.2179142380405, 3727.049602351383, 3740.214554943438, 3741.551013878352, 3744.0078379229526, 4262.190183865056, 4310.956890431118, 4394.274944634163, 4395.1868904252815, 4395.780210989437, 5063.746812659352, 5079.466656001141, 5081.18701007837, 5082.186850103965, 5122.564582010496, 4348.28253338202, 4350.456192975878, 4350.651947844165, 4357.54245804186, 4380.342948557742, 4449.310356894686, 4470.284754439339, 4521.231390663595, 4564.383808185852, 4571.291449825282, 4719.457262414798, 4721.315409265706, 4722.858314250578, 4730.692504987165, 4781.306710527024, 4976.850694479172, 4984.700917944935, 5028.698278103326, 5040.6219533534395, 5088.542031217208, 4677.929831052469, 4711.411073615798, 4711.528847115261, 4736.928946065743, 4758.809647614056, 4932.975335123301, 4970.130227210296, 4973.35346404965, 5016.874578135576, 5018.146915024382, 4942.3327850741125, 4999.425066117443, 5045.520675535819, 5065.39215294167, 5109.9744501277255, 4855.854324370274, 4876.122297986255, 4881.29221262922, 4884.633652476007, 4930.40835099776, 4872.366592342973, 4873.975630121827, 4876.609871210224, 4883.145449546244, 4934.629902757236, 4749.881252968704, 4772.284157376283, 4808.663393562557, 4865.58642515376, 4888.731119788304, 4893.290472881341, 4916.385451818523, 4919.262110683283, 4951.678140920829, 4962.082014827269, 4801.087793319258, 4805.567498925114, 4806.831760888352, 4815.6147508198555, 4856.295837103529], "value": 4612.1301611508725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.428345937522, 604.6613896218118, 626.1296797451544, 630.3727790848106, 633.9112524246606, 28123.43753124936, 28801.0, 28815.423691526157, 28837.567436488443, 28869.278268043257, 34899.0, 35151.47272790904, 35156.12109697259, 35184.12039699009, 35309.2938141237, 7404.518706284074, 7615.390768738488, 7616.3906887448875, 7621.733239336624, 7621.885671714928, 7216.963915180443, 7432.256774322578, 7591.772246832604, 7593.582352970584, 9395.248380129608, 9802.166815820663, 9897.0, 9914.107730304271, 9925.0, 9927.652532161375, 9720.562574684122, 9814.06766357195, 9821.066998635119, 9824.950875245579, 9833.950830245874, 7188.748393806244, 9291.48896810675, 9514.38156519824, 9618.182454491307, 9737.513124343825, 33738.32523349544, 34318.313633727186, 34382.82808585966, 34389.31221375584, 34425.0, 3060.617422822147, 3163.3198862244726, 3176.3647270545753, 3493.3886569850174, 3736.0846592584717, 29166.854165729037, 29601.407971840657, 29758.85120574383, 29804.552931706043, 30043.849780750956, 3308.801471911669, 3349.246419555605, 3388.15296175956, 3448.4654878493875, 3468.8959331220103, 233857.0, 234165.0, 234755.0, 234982.99999999828, 235078.0, 54270.72864635652, 54616.180757288676, 54619.45380546223, 54623.0, 54683.72658136684, 57272.42727572754, 57444.13833792497, 57460.71269643625, 57499.42500575024, 57542.0, 14687.853121468648, 15030.17334046616, 15030.32363543643, 15049.097054176784, 15053.473128440452, 11417.771644567229, 11488.080953523699, 11497.425128743529, 11504.194706370641, 11512.079033677286, 13804.654883627989, 15666.686666266838, 16014.519564413085, 16092.517224483285, 16840.494785156465, 5523.1991361253195, 5702.515286200636, 5756.675964528182, 5826.0, 5877.5322559689985, 912.0833562270009, 953.7710949372239, 963.4363897120263, 985.5860538573817, 1038.390790957107, 25566.87216563905, 28026.0, 28186.85906570454, 28375.57436638452, 29090.0, 973.5570315506427, 991.5240684471494, 993.7267251505893, 996.7308826616918, 1051.7948999944938, 14131.222782747047, 14638.268086595628, 14742.63143421423, 15003.949723519248, 15011.474598389223, 355893.0, 361455.57816632773, 362108.0, 363084.0, 363889.0, 49239.50760492349, 49792.0, 49818.50181498211, 49916.0, 49967.0, 1243.2851110611434, 1245.850497940253, 1249.0881656390886, 1254.8807863252794, 1259.571745606498, 26701.0, 27673.828134743195, 27982.11452473667, 28055.298617534725, 28144.0, 38520.0, 38681.41977870391, 38788.224235514564, 43101.181340518626, 43157.352639711055, 316651.0, 317739.0, 317851.0, 320518.0, 320572.0, 20167.79832201659, 22961.0, 24582.016719331026, 25012.499750005263, 25112.497750045262, 36642.26715465729, 36703.0, 36882.0, 37596.2480750378, 37808.43287350637, 30774.384512310076, 31848.52227216547, 32024.359512809147, 32862.83568582142, 32927.67072329246, 31435.214119646276, 32569.511457328634, 32787.0, 34812.82593587016, 35191.648083518834, 33351.666483334855, 33849.32301354008, 34011.95928244313, 34244.315113697085, 34736.82631586826, 30184.396312074074, 30958.69041309558, 31389.686103138676, 31412.842935785175, 31498.842505787325, 23652.88173559121, 24148.87925560361, 24393.51212975766, 24591.631125532775, 24757.381065473506], "value": 17238.83677217744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5509955404184, 373.7906772207562, 378.3851241732187, 380.39896962798775, 387.685974360768, 15957.68084638308, 16059.839401605981, 16327.59181020475, 16360.263788129532, 16381.508554743346, 15326.846731532682, 15429.537113886601, 15820.76268855968, 15953.282102305395, 15959.680806383894, 4947.455779864212, 5173.767180476869, 5207.3490813648295, 5222.138347172731, 5222.242774797652, 3759.398496240602, 3964.405339199114, 5121.692698438105, 5680.573956953224, 5946.0, 5888.5289176865745, 5898.026825573776, 5922.763089476416, 5923.200367950336, 5923.407659234063, 5896.64620122794, 6080.331163572004, 6083.057126145432, 6084.96957515214, 6087.847803804896, 3451.8274086295582, 5082.771275292621, 5237.895242095175, 5325.334333208349, 5332.200169974535, 19352.129154188096, 19352.903235483875, 19461.318853840046, 21259.255926042668, 21298.0, 2026.3211824038965, 2135.1886283212434, 2229.665550167472, 2251.223327951854, 2411.7347091819884, 12700.555480558229, 13298.601041968757, 13409.798853017213, 13683.11059781111, 13846.723065538734, 1678.3286685325845, 1766.3994241957796, 1801.7567628370134, 1804.927802887883, 1845.2157832920955, 66072.66963665151, 67174.66412667955, 67222.32777672258, 68165.31834681639, 69736.6513167436, 9385.5307234638, 9635.421874687541, 9838.262130340254, 10017.899821001842, 10019.0, 14040.666136716996, 14084.15495070299, 14119.858801411854, 14122.788158177636, 14142.0, 7234.24040475753, 7336.486445948839, 7414.295641914009, 7498.812529686692, 7508.0, 6976.790696279119, 6983.406410455168, 7010.70496866472, 7108.8933665995055, 7112.110986126734, 6233.407826256498, 6249.156363890907, 6271.560990730696, 6437.259715132726, 6477.352264773485, 1619.3765400320726, 1636.2800367838113, 1683.1079527850259, 1750.0511637890195, 1783.4649605118414, 865.3942240431722, 894.7449976756593, 921.3412410126791, 973.4451362723321, 973.5570315506569, 15730.9213453932, 16467.917660411622, 16628.0, 16671.083090430144, 17156.571085722957, 864.5763575847915, 889.5063239901916, 900.1538553759445, 911.9452832830051, 933.1415098109755, 9937.0, 10020.148287395654, 10074.899251007542, 10114.494275286206, 10123.341982771097, 408641.0, 417866.0, 420348.0, 423136.0, 425879.0, 65526.0, 66467.66766166138, 68684.31315686779, 69177.65411173012, 71128.0, 957.3298690916387, 979.4612962870393, 990.4404011733347, 993.344392700814, 993.3543196922059, 15284.235788210768, 16049.759253610971, 16056.598585035468, 16140.515784526482, 16304.527036816608, 36559.45160822537, 36720.26559468849, 36851.63148368482, 36960.63039369572, 36969.0, 50237.74881125571, 51271.74364128155, 51792.964140717726, 52263.46853202374, 53056.73471632617, 7222.89165662526, 7324.4140468763435, 7378.557286562824, 7489.28851759082, 7515.774526764206, 8718.43330183536, 10830.296030757976, 10872.402017889091, 10884.78230435371, 11016.559337626406, 8661.740147795575, 8699.652013919373, 8858.0, 8973.730788076367, 9010.5945232466, 9389.671361502315, 9415.81168376615, 9563.61745530171, 9590.616375344907, 9618.086281803218, 8867.201951824367, 9103.772405689911, 9219.26245900313, 9346.672866449642, 9460.716178514656, 7296.270372962661, 7440.330370266702, 7449.5902725350625, 7504.362129219077, 7677.117131529722, 8348.373871959506, 8444.408891377545, 8544.67557528584, 8891.73324800257, 8954.686585969459], "value": 8271.173200686366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.9938450307748, 1386.7919812028197, 1411.0686946615233, 1510.7960425342576, 1727.3263427263369, 7229.819254518639, 7590.658420371083, 7591.4306427018055, 7596.316331530161, 7606.6957321707205, 7385.076865391826, 7534.773956781291, 7535.811604709885, 7559.39524838013, 7568.356689681384, 1912.540990162365, 1979.8416126709828, 1984.3848406993807, 2115.6614941609346, 2133.615949129156, 2197.263916587945, 2277.39648993017, 2279.7036385269894, 2280.600894843404, 2281.087564974007, 2120.3638908327516, 2124.1821898569005, 2142.1538492295535, 2143.4641339665086, 2163.080690706451, 1875.1749230338608, 2116.9153233870625, 2161.124744478481, 2182.3562049195525, 2185.6065908136607, 2230.966535501969, 2254.966175507369, 2256.0750092462013, 2256.6615007748806, 2259.367377134405, 7455.813604659873, 7512.474126811126, 7518.736844210426, 7534.8116297092465, 7543.057117860268, 4386.144701783153, 4495.775211239457, 4501.099780043972, 4558.977205113986, 4559.977200113978, 2647.8676066196613, 2743.917682469529, 2829.108830718317, 2830.4622121796997, 2838.3471801485775, 860.6299291304737, 868.9782755431102, 871.8561437362828, 912.3339961827836, 913.4747520175926, 10396.064354208082, 10396.22028347877, 10398.844017339747, 10423.530941107669, 10454.268201225917, 4090.4068910008477, 4201.810918508674, 4253.383259427365, 4283.593058659485, 4289.485261768546, 8963.551822408854, 8987.0, 9005.774855628531, 9024.774380640536, 9033.232175265044, 4707.388039554904, 4735.59747421473, 4735.83424580138, 4739.312799644033, 4744.193487107131, 3752.4746535485056, 4100.7334523255895, 4258.978705106455, 4263.829446822155, 4326.091520780608, 3637.472566477899, 3680.9079773005888, 3712.832922518493, 3716.0, 3784.413415920537, 1180.3331117918349, 1205.5238180918664, 1212.2362911365783, 1220.6948262934266, 1231.6489800406841, 798.0861913109458, 830.2735106781566, 849.6898631999276, 869.752120645613, 886.233408102, 5075.543201111917, 5199.168133098686, 5201.765920533585, 5245.26566280721, 5290.047791397586, 405.36965019394535, 405.38584045171586, 408.13068164808766, 409.1061031645804, 416.37959440433536, 3566.7324950628285, 3576.088097535112, 3647.434647629622, 3686.7972261525874, 3716.7212459065677, 8999.910000900038, 9253.676121335855, 9385.296102792317, 9508.144267016001, 9521.333506654606, 9282.814343713222, 9361.672341468016, 9378.577963991636, 9394.624215031323, 9427.858582121273, 7127.4298056155385, 7178.8205294867, 7214.891776623354, 7223.241559636268, 7307.7807665770115, 5305.761240744253, 5319.813806516753, 5329.307190065267, 5390.407055224001, 5474.42518535564, 8536.871946920677, 8624.78438039054, 8676.739697809076, 8751.956240218758, 8757.649694012169, 8686.087960764029, 8687.39188256816, 8783.692570759993, 8784.472931624123, 8856.202941735275, 6416.294207637249, 6440.098386225838, 6586.571872828251, 6615.437687796399, 6616.536842420985, 7209.315115064061, 7214.062171917617, 7255.0, 7257.673404696696, 7291.197968223385, 6634.800955971328, 6728.562643428358, 6735.090762746966, 6821.147356580427, 6924.238333783381, 6124.724387402666, 6125.356837532173, 6235.282942461675, 6397.808065758035, 6713.597184168965, 5986.6707331097205, 6020.668863212565, 6031.24609423822, 6041.78853740117, 6096.9390306096375, 4674.813007479663, 4696.765161741968, 4702.48272689997, 4719.905601888012, 4777.3311736356245, 4730.929036064531, 4740.265258884879, 4796.56830885222, 4852.417709874838, 4874.975625121851], "value": 4009.9600563713466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.3979280713398, 308.1787037544942, 310.4814959018439, 310.92693217093966, 314.97480201583875, 4810.567048965592, 4820.638452116093, 4841.661083724141, 4846.636502262331, 4906.264060390943, 4788.0, 4802.927956080662, 4804.951950480503, 4829.203181475061, 4875.829345972883, 3569.607343192253, 3731.4962480065115, 3736.2725210596145, 3849.2493963677093, 3873.709471789613, 3756.0609847538117, 3773.2831561639387, 3804.448354988525, 3815.5039844820135, 3845.5000849889475, 3561.982190089046, 3797.4873392092127, 3801.1257410795533, 3802.9809850950846, 3810.733248672594, 3663.3955397359405, 3774.6036666150208, 3787.1289603391374, 3803.7827895073588, 3805.2389522095555, 3371.393149233137, 3383.7462190335823, 3392.3554524640485, 3395.5246265522846, 3404.69357757803, 4609.8156073757345, 4615.0, 4616.330632058366, 4623.722576645412, 4657.998530315998, 4213.789310534492, 4340.500842403132, 4341.80461879213, 4354.7604881731495, 4396.538363471821, 5042.243663450475, 5043.52086551777, 5071.0, 5078.289039534468, 5093.439721630618, 3724.4599533067826, 3729.2914346274392, 3739.5886452490204, 3741.8316175772156, 3744.700423966076, 5021.221710634857, 5313.203019547061, 5329.280547126166, 5334.466553344673, 5349.465053494659, 3672.008557689462, 3681.9079523011605, 3696.2237930034994, 3701.0932321581386, 3704.129529560551, 3736.159364143046, 3741.3639681254253, 3750.624937506282, 3757.49273848027, 3765.811709414518, 4270.231358355526, 4272.060146767706, 4285.571442855689, 4288.807003684841, 4292.163028209469, 4847.830325938646, 5078.5175408336145, 5100.846974590768, 5119.950410165907, 5130.79476820923, 1348.7167694784205, 1364.2632978191666, 1365.2491129878726, 1365.8429280632656, 1366.3782978744648, 834.9104418733612, 890.581426729449, 902.3457992955055, 912.2565109435789, 914.6021480655936, 4718.787654555554, 4720.716756994591, 4746.477887432379, 4747.643926705511, 4783.330333753208, 5604.719764011783, 5621.915671264935, 5630.74661640219, 5632.915506267409, 5641.210230567642, 4497.887552811206, 4660.370849935215, 4674.182018146811, 4677.6257899367965, 4738.384010078667, 2935.486289899259, 2949.8495586721197, 2963.5554666800153, 2966.5401862711315, 2991.8055326403714, 5155.02054609623, 5165.405978312542, 5168.664036837594, 5200.2199670049795, 5202.7918883245, 5145.845624631267, 5379.515843574019, 5436.646617969898, 5437.809676661377, 5650.74571644277, 4986.526280003394, 4995.375578052671, 5000.224965130411, 5023.372078490189, 5030.270610761419, 5312.990531798946, 5314.441983591667, 5318.388385335736, 5331.573474122139, 5337.599680024091, 4917.188663870565, 5153.484651534816, 5180.021487644694, 5221.138512145453, 5222.895542089061, 4962.305277261258, 4982.053409852117, 4996.675216110941, 5010.899782004267, 5020.171671674133, 3643.617420170844, 3684.3736564784585, 3687.8567644030436, 3695.6119607440833, 3702.278055779097, 5148.382194136728, 5265.0259701955265, 5311.176767601028, 5349.304590403378, 5381.434949330264, 5107.770150343318, 5118.820841270538, 5134.306868572695, 5152.9742351288005, 5158.561522270649, 5020.268007537394, 5122.769475373542, 5126.4360920297995, 5154.381474223117, 5171.0, 4753.762311884323, 5045.2432135180015, 5064.620153488429, 5087.2623469595965, 5101.489851015017, 5012.79692873715, 5160.845174644766, 5201.271821945006, 5205.58355331565, 5246.737663116905, 5046.545810877039, 5068.543831055223, 5090.363704536933, 5094.7962081516325, 5113.79544818218], "value": 3888.7751023256583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.5146019136125, 684.0928581697044, 685.6331862453588, 691.754427178352, 696.3837004251236, 11430.25703329283, 11768.764624707512, 11786.941065294683, 11796.469158887849, 11805.586804461835, 11281.0, 11377.0, 11391.088712902969, 11398.202125851172, 11415.54337826488, 631.8767840271149, 648.2609824799732, 650.4438704907307, 771.4946709905021, 788.2275370137269, 641.0480436551717, 767.9385649148055, 787.3268355556003, 789.1634867040926, 792.9960350198241, 828.5318794880873, 834.9707760228393, 835.2941764209233, 836.8702851058096, 841.4110122913954, 828.3207769628907, 828.5857071464268, 829.1873963515789, 830.3606223208126, 836.393614629395, 488.4431747807502, 592.4934181275034, 598.4793229890023, 614.1831364285534, 615.1910238037012, 11266.943665281704, 11274.605388811435, 11280.2667826591, 11290.774184516264, 11327.320360778298, 11096.667099987013, 11599.362035088066, 11655.475503602358, 11718.472668729843, 12105.09211809118, 9546.331756777028, 9605.615775368977, 9662.75843103921, 9827.754306142404, 9861.309708320421, 3157.952630710541, 3199.6160460744627, 3203.8398080095903, 3204.4872820348864, 3261.5596894419186, 40474.39288410676, 41059.178816423504, 41895.79052104751, 43554.0, 44229.55770442286, 9555.378900371454, 9588.137067663944, 9600.615975361046, 9695.51522423876, 9765.560549775135, 16236.675266494603, 16315.428959986344, 16353.672926541403, 16394.672106557802, 16420.507384778477, 6525.543211975116, 6577.572457790228, 6597.901031484532, 6665.166854143232, 6669.199696036507, 3647.0, 3677.595464498903, 3697.0942119180436, 3707.6663100321102, 3711.628837116267, 2770.4874598198994, 2805.424887897976, 2807.2560771395597, 2817.690054094048, 2819.3515491436674, 496.7292825410088, 496.81866118866355, 509.943906170321, 519.1252739134495, 524.3550432967395, 475.66465641722505, 487.61722048192, 523.1551045062197, 533.2214966149465, 582.1606505098866, 7192.352688258082, 7236.38490728294, 7425.85148297031, 7477.738279160203, 7590.430717696195, 452.91621050105175, 468.68363854398825, 477.3412690487175, 484.54095465512665, 486.70311110222735, 3238.449463591148, 3371.5279860819505, 3390.7287417006582, 3450.4306789379975, 3500.5974312954336, 49856.50143498591, 50546.241806372935, 51985.7400712994, 52032.0, 52234.0, 44017.0, 44897.32654010192, 45824.0, 46212.53787462082, 46685.76657116761, 40817.387739183934, 40937.59062409338, 41551.58448415538, 41970.790146049076, 42185.36721949173, 6616.0, 6787.253402125663, 6862.759803406857, 6871.931280687129, 6962.23415424313, 26187.0, 27657.72342276632, 28394.43211135807, 28505.28736781597, 28619.14142575726, 34182.0, 35396.46905296474, 37816.81091594524, 38189.809050954565, 38463.423048653734, 8491.065982742017, 8600.440971336842, 8605.827883442422, 8616.526091065052, 8752.0, 8797.780055498408, 8870.778230544289, 9064.954675226581, 9116.042815504277, 9190.908090919005, 7793.805154870946, 8617.396782225183, 8650.610722517376, 9002.954985225031, 9932.404055756677, 9240.584173712334, 9312.255019598551, 9555.856662149934, 9574.952125239608, 9624.133827955518, 9334.813303734023, 9404.905950940403, 9415.482148481899, 9479.0, 9686.370385924893, 8017.959910200411, 8086.797830054295, 8212.917870821215, 8265.504069755834, 8400.705975290835, 7913.881291780743, 8424.578771061544, 8440.746777596682, 8477.660893564434, 8504.957475212585], "value": 5451.183460435022, "unit": "score"}], "name": "dromaeo_css", "value": 6183.652383363804, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 108.0, 112.0, 117.0, 117.0, 103.0, 114.0, 114.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 135.0, 169.0, 187.0, 135.0, 170.0, 158.0, 145.0, 202.0, 133.0], "value": 159.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 163.0, 162.0, 165.0, 162.0, 163.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 114.0, 109.0, 78.0, 76.0, 78.0, 115.0, 111.0, 77.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 153.0, 95.0, 94.0, 94.0, 146.0, 94.0, 95.0, 147.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 80.0, 66.0, 67.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 82.0, 84.0, 83.0, 82.0, 81.0, 89.0, 83.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 132.0, 131.0, 129.0, 129.0, 134.0, 131.0, 165.0, 132.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 187.0, 180.0, 180.0, 179.0, 177.0, 178.0, 178.0, 182.0, 177.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 74.0, 73.0, 72.0, 72.0, 74.0, 74.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1601.9999999999998, "alertThreshold": 2.0}]} 06:37:28 INFO - Return code: 0 06:37:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:37:28 ERROR - # TBPL SUCCESS # 06:37:28 INFO - Running post-action listener: _resource_record_post_action 06:37:28 INFO - Running post-run listener: _resource_record_post_run 06:37:29 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 217088; Write bytes: 527249408; Read time: 44; Write time: 1187336 06:37:29 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 234958848; Read time: 0; Write time: 666780 06:37:29 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 217088; Write bytes: 292139008; Read time: 44; Write time: 520524 06:37:29 INFO - Running post-run listener: _upload_blobber_files 06:37:29 INFO - Blob upload gear active. 06:37:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:37:29 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 06:37:29 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'] 06:37:29 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 06:37:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:30 INFO - (blobuploader) - INFO - Done attempting. 06:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:31 INFO - (blobuploader) - INFO - Done attempting. 06:37:31 INFO - (blobuploader) - INFO - Iteration through files over. 06:37:31 INFO - Return code: 0 06:37:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:37:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:37:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8da07209e1f473de79df6661579034175eea3cdf7da8fc0d7a0676e573468eeaa2be44f864a0f4e92f4730868e565ff3e749ecf92150252473ab187a40c13898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee6ea5e6585b3da0837b76fe95ee19a64172e5f1079a112bc6013f817d28dfb122888425e0a8acd32d1ce6ac214028d5459535e2fd8ae4400a83e730583466dc"} 06:37:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:37:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:37:31 INFO - Contents: 06:37:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8da07209e1f473de79df6661579034175eea3cdf7da8fc0d7a0676e573468eeaa2be44f864a0f4e92f4730868e565ff3e749ecf92150252473ab187a40c13898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee6ea5e6585b3da0837b76fe95ee19a64172e5f1079a112bc6013f817d28dfb122888425e0a8acd32d1ce6ac214028d5459535e2fd8ae4400a83e730583466dc"} 06:37:31 INFO - Running post-run listener: copy_logs_to_upload_dir 06:37:31 INFO - Copying logs to upload dir... 06:37:31 INFO - mkdir: /builds/slave/test/build/upload/logs 06:37:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.130474 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-30 06:37:31.251738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 06:37:31.255524) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323 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/8da07209e1f473de79df6661579034175eea3cdf7da8fc0d7a0676e573468eeaa2be44f864a0f4e92f4730868e565ff3e749ecf92150252473ab187a40c13898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee6ea5e6585b3da0837b76fe95ee19a64172e5f1079a112bc6013f817d28dfb122888425e0a8acd32d1ce6ac214028d5459535e2fd8ae4400a83e730583466dc"} build_url:https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/UUmIIS21SxKSXPkrwYK6KA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8da07209e1f473de79df6661579034175eea3cdf7da8fc0d7a0676e573468eeaa2be44f864a0f4e92f4730868e565ff3e749ecf92150252473ab187a40c13898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee6ea5e6585b3da0837b76fe95ee19a64172e5f1079a112bc6013f817d28dfb122888425e0a8acd32d1ce6ac214028d5459535e2fd8ae4400a83e730583466dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 06:37:31.280215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:37:31.280625) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462022156.578926-1085474323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:37:31.364995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 06:37:31.365314) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 06:37:31.365645) ========= ========= Total master_lag: 0.18 =========