builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1465530982.18 results: success (0) buildid: 20160609181731 builduid: 941e9f95377947698b8167a397e39c95 revision: c5411e82e576319387b3cfe45cfcd5ac917d067b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.180168) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.181075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.181559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.198728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.199361) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 20:56:22-- 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% 110M=0s 2016-06-09 20:56:22 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.339642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.555182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.555757) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.606412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:22.606777) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c5411e82e576319387b3cfe45cfcd5ac917d067b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c5411e82e576319387b3cfe45cfcd5ac917d067b --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=5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 20:56:22,920 truncating revision to first 12 chars 2016-06-09 20:56:22,920 Setting DEBUG logging. 2016-06-09 20:56:22,920 attempt 1/10 2016-06-09 20:56:22,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c5411e82e576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 20:56:23,231 unpacking tar archive at: mozilla-beta-c5411e82e576/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654577 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:23.357424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:23.357740) ========= script_repo_revision: c5411e82e576319387b3cfe45cfcd5ac917d067b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:23.358127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:23.358422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 20:56:23.368819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-09 20:56:23.369211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:56:23 INFO - MultiFileLogger online at 20160609 20:56:23 in /builds/slave/test 20:56:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:56:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:56:23 INFO - {'append_to_log': False, 20:56:23 INFO - 'base_work_dir': '/builds/slave/test', 20:56:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:56:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:56:23 INFO - 'branch': 'Mozilla-Beta', 20:56:23 INFO - 'buildbot_json_path': 'buildprops.json', 20:56:23 INFO - 'config_files': ('talos/linux_config.py',), 20:56:23 INFO - 'default_actions': ('clobber', 20:56:23 INFO - 'read-buildbot-config', 20:56:23 INFO - 'download-and-extract', 20:56:23 INFO - 'populate-webroot', 20:56:23 INFO - 'create-virtualenv', 20:56:23 INFO - 'install', 20:56:23 INFO - 'run-tests'), 20:56:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:56:23 INFO - 'download_minidump_stackwalk': True, 20:56:23 INFO - 'download_symbols': 'ondemand', 20:56:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:56:23 INFO - 'tooltool.py': '/tools/tooltool.py', 20:56:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:56:23 INFO - '/tools/misc-python/virtualenv.py')}, 20:56:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:56:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:56:23 INFO - 'installer_path': 'installer.exe', 20:56:23 INFO - 'log_level': 'info', 20:56:23 INFO - 'log_name': 'talos', 20:56:23 INFO - 'log_to_console': True, 20:56:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:56:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:56:23 INFO - 'opt_config_files': (), 20:56:23 INFO - 'pip_index': False, 20:56:23 INFO - 'sps_profile': False, 20:56:23 INFO - 'sps_profile_interval': 0, 20:56:23 INFO - 'suite': 'dromaeojs', 20:56:23 INFO - 'system_bits': '32', 20:56:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:56:23 INFO - 'title': 'talos-linux64-ix-039', 20:56:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:56:23 INFO - 'use_talos_json': True, 20:56:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:56:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:56:23 INFO - 'work_dir': 'build'} 20:56:23 INFO - ##### 20:56:23 INFO - ##### Running clobber step. 20:56:23 INFO - ##### 20:56:23 INFO - Running pre-action listener: _resource_record_pre_action 20:56:23 INFO - Running main action method: clobber 20:56:23 INFO - rmtree: /builds/slave/test/build 20:56:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:56:24 INFO - Running post-action listener: _resource_record_post_action 20:56:24 INFO - ##### 20:56:24 INFO - ##### Running read-buildbot-config step. 20:56:24 INFO - ##### 20:56:24 INFO - Running pre-action listener: _resource_record_pre_action 20:56:24 INFO - Running main action method: read_buildbot_config 20:56:24 INFO - Using buildbot properties: 20:56:24 INFO - { 20:56:24 INFO - "project": "", 20:56:24 INFO - "product": "firefox", 20:56:24 INFO - "script_repo_revision": "production", 20:56:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 20:56:24 INFO - "repository": "", 20:56:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 20:56:24 INFO - "buildid": "20160609181731", 20:56:24 INFO - "pgo_build": "True", 20:56:24 INFO - "basedir": "/builds/slave/test", 20:56:24 INFO - "buildnumber": 127, 20:56:24 INFO - "slavename": "talos-linux64-ix-039", 20:56:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:56:24 INFO - "platform": "ubuntu64_hw", 20:56:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:56:24 INFO - "branch": "mozilla-beta", 20:56:24 INFO - "repo_path": "releases/mozilla-beta", 20:56:24 INFO - "revision": "c5411e82e576319387b3cfe45cfcd5ac917d067b", 20:56:24 INFO - "stage_platform": "linux64-pgo", 20:56:24 INFO - "builduid": "941e9f95377947698b8167a397e39c95", 20:56:24 INFO - "slavebuilddir": "test" 20:56:24 INFO - } 20:56:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 20:56:24 INFO - Running post-action listener: _resource_record_post_action 20:56:24 INFO - ##### 20:56:24 INFO - ##### Running download-and-extract step. 20:56:24 INFO - ##### 20:56:24 INFO - Running pre-action listener: _resource_record_pre_action 20:56:24 INFO - Running main action method: download_and_extract 20:56:24 INFO - mkdir: /builds/slave/test/build/tests 20:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:24 INFO - https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:56:26 INFO - Downloaded 1327 bytes. 20:56:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:56:26 INFO - Using the following test package requirements: 20:56:26 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 20:56:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:56:26 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 20:56:26 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'jsshell-linux-x86_64.zip'], 20:56:26 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:56:26 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 20:56:26 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 20:56:26 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 20:56:26 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:56:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:56:26 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:56:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:56:26 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')]} 20:56:26 INFO - https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:56:27 INFO - Downloaded 24178027 bytes. 20:56:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:56:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:56:29 INFO - Return code: 0 20:56:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:29 INFO - https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:56:44 INFO - Downloaded 24178027 bytes. 20:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:56:45 INFO - Return code: 0 20:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:45 INFO - https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 20:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 20:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 20:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:56:47 INFO - Downloaded 10840145 bytes. 20:56:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:56:47 INFO - Return code: 0 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:47 INFO - https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:56:48 INFO - Downloaded 56008819 bytes. 20:56:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:56:48 INFO - mkdir: /builds/slave/test/properties 20:56:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:56:48 INFO - Writing to file /builds/slave/test/properties/build_url 20:56:48 INFO - Contents: 20:56:48 INFO - build_url:https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:56:49 INFO - Running post-action listener: _resource_record_post_action 20:56:49 INFO - Running post-action listener: set_extra_try_arguments 20:56:49 INFO - ##### 20:56:49 INFO - ##### Running populate-webroot step. 20:56:49 INFO - ##### 20:56:49 INFO - Running pre-action listener: _resource_record_pre_action 20:56:49 INFO - Running main action method: populate_webroot 20:56:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:56:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:56:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:56:49 INFO - '--tppagecycles', 20:56:49 INFO - '7'], 20:56:49 INFO - 'tests': ['tsvgm']}}, 20:56:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:56:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:56:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:56:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:56:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['damp', 'tps']}, 20:56:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'tests': ['damp', 'tps']}, 20:56:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['dromaeo_dom']}, 20:56:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:56:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['a11yr', 20:56:49 INFO - 'ts_paint', 20:56:49 INFO - 'tpaint', 20:56:49 INFO - 'sessionrestore', 20:56:49 INFO - 'sessionrestore_no_auto_restore', 20:56:49 INFO - 'tabpaint']}, 20:56:49 INFO - 'other-e10s': {'tests': ['a11yr', 20:56:49 INFO - 'ts_paint', 20:56:49 INFO - 'tpaint', 20:56:49 INFO - 'sessionrestore', 20:56:49 INFO - 'sessionrestore_no_auto_restore', 20:56:49 INFO - 'tabpaint']}, 20:56:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:56:49 INFO - 'ts_paint', 20:56:49 INFO - 'tpaint', 20:56:49 INFO - 'sessionrestore', 20:56:49 INFO - 'sessionrestore_no_auto_restore', 20:56:49 INFO - 'tabpaint']}, 20:56:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:56:49 INFO - 'ts_paint', 20:56:49 INFO - 'tpaint', 20:56:49 INFO - 'sessionrestore', 20:56:49 INFO - 'sessionrestore_no_auto_restore', 20:56:49 INFO - 'tabpaint']}, 20:56:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['a11yr', 20:56:49 INFO - 'ts_paint', 20:56:49 INFO - 'tpaint', 20:56:49 INFO - 'sessionrestore', 20:56:49 INFO - 'sessionrestore_no_auto_restore', 20:56:49 INFO - 'tabpaint']}, 20:56:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['a11yr', 20:56:49 INFO - 'ts_paint', 20:56:49 INFO - 'tpaint', 20:56:49 INFO - 'sessionrestore', 20:56:49 INFO - 'sessionrestore_no_auto_restore', 20:56:49 INFO - 'tabpaint']}, 20:56:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['tsvgx', 20:56:49 INFO - 'tsvgr_opacity', 20:56:49 INFO - 'tart', 20:56:49 INFO - 'tscrollx', 20:56:49 INFO - 'cart']}, 20:56:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:56:49 INFO - 'tsvgr_opacity', 20:56:49 INFO - 'tart', 20:56:49 INFO - 'tscrollx', 20:56:49 INFO - 'cart']}, 20:56:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'talos_options': ['--disable-e10s'], 20:56:49 INFO - 'tests': ['tp5o']}, 20:56:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'tests': ['tp5o']}, 20:56:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'talos_options': ['--disable-e10s', 20:56:49 INFO - '--xperf_path', 20:56:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:49 INFO - 'tests': ['tp5n']}, 20:56:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:49 INFO - 'talos_options': ['--xperf_path', 20:56:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:49 INFO - 'tests': ['tp5n']}}, 20:56:49 INFO - 'talos.zip': {'path': '', 20:56:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:56:49 INFO - Running post-action listener: _resource_record_post_action 20:56:49 INFO - ##### 20:56:49 INFO - ##### Running create-virtualenv step. 20:56:49 INFO - ##### 20:56:49 INFO - Running pre-action listener: _resource_record_pre_action 20:56:49 INFO - Running main action method: create_virtualenv 20:56:49 INFO - Creating virtualenv /builds/slave/test/build/venv 20:56:49 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 20:56:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:56:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:56:49 INFO - Using real prefix '/usr' 20:56:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:56:49 INFO - Installing distribute.............................................................................................................................................................................................done. 20:56:51 INFO - Installing pip.................done. 20:56:51 INFO - Return code: 0 20:56:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:56:51 INFO - Using env: {'DISPLAY': ':0', 20:56:51 INFO - 'HOME': '/home/cltbld', 20:56:51 INFO - 'LANG': 'en_US.UTF-8', 20:56:51 INFO - 'LANGUAGE': 'en_US:en', 20:56:51 INFO - 'LOGNAME': 'cltbld', 20:56:51 INFO - 'MAIL': '/var/mail/cltbld', 20:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:51 INFO - 'MOZ_NO_REMOTE': '1', 20:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:51 INFO - 'NO_EM_RESTART': '1', 20:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:51 INFO - 'PWD': '/builds/slave/test', 20:56:51 INFO - 'SHELL': '/bin/bash', 20:56:51 INFO - 'SHLVL': '1', 20:56:51 INFO - 'TERM': 'linux', 20:56:51 INFO - 'TMOUT': '86400', 20:56:51 INFO - 'USER': 'cltbld', 20:56:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:51 INFO - '_': '/tools/buildbot/bin/python'} 20:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:52 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 20:56:52 INFO - Cleaning up... 20:56:52 INFO - Return code: 0 20:56:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:56:52 INFO - Using env: {'DISPLAY': ':0', 20:56:52 INFO - 'HOME': '/home/cltbld', 20:56:52 INFO - 'LANG': 'en_US.UTF-8', 20:56:52 INFO - 'LANGUAGE': 'en_US:en', 20:56:52 INFO - 'LOGNAME': 'cltbld', 20:56:52 INFO - 'MAIL': '/var/mail/cltbld', 20:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:52 INFO - 'MOZ_NO_REMOTE': '1', 20:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:52 INFO - 'NO_EM_RESTART': '1', 20:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:52 INFO - 'PWD': '/builds/slave/test', 20:56:52 INFO - 'SHELL': '/bin/bash', 20:56:52 INFO - 'SHLVL': '1', 20:56:52 INFO - 'TERM': 'linux', 20:56:52 INFO - 'TMOUT': '86400', 20:56:52 INFO - 'USER': 'cltbld', 20:56:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:52 INFO - '_': '/tools/buildbot/bin/python'} 20:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:52 INFO - Downloading/unpacking psutil>=0.7.1 20:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:54 INFO - Installing collected packages: psutil 20:56:54 INFO - Running setup.py install for psutil 20:56:54 INFO - building 'psutil._psutil_linux' extension 20:56:54 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 20:56:54 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 20:56:54 INFO - building 'psutil._psutil_posix' extension 20:56:54 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 20:56:54 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 20:56:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:54 INFO - Successfully installed psutil 20:56:54 INFO - Cleaning up... 20:56:54 INFO - Return code: 0 20:56:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:54 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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:56:54 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 20:56:54 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 20:56:54 INFO - Using env: {'DISPLAY': ':0', 20:56:54 INFO - 'HOME': '/home/cltbld', 20:56:54 INFO - 'LANG': 'en_US.UTF-8', 20:56:54 INFO - 'LANGUAGE': 'en_US:en', 20:56:54 INFO - 'LOGNAME': 'cltbld', 20:56:54 INFO - 'MAIL': '/var/mail/cltbld', 20:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:54 INFO - 'MOZ_NO_REMOTE': '1', 20:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:54 INFO - 'NO_EM_RESTART': '1', 20:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:54 INFO - 'PWD': '/builds/slave/test', 20:56:54 INFO - 'SHELL': '/bin/bash', 20:56:54 INFO - 'SHLVL': '1', 20:56:54 INFO - 'TERM': 'linux', 20:56:54 INFO - 'TMOUT': '86400', 20:56:54 INFO - 'USER': 'cltbld', 20:56:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:54 INFO - '_': '/tools/buildbot/bin/python'} 20:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:56:56 INFO - Installing collected packages: mozsystemmonitor 20:56:56 INFO - Running setup.py install for mozsystemmonitor 20:56:57 INFO - Successfully installed mozsystemmonitor 20:56:57 INFO - Cleaning up... 20:56:57 INFO - Return code: 0 20:56:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:56:57 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 20:56:57 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 20:56:57 INFO - Using env: {'DISPLAY': ':0', 20:56:57 INFO - 'HOME': '/home/cltbld', 20:56:57 INFO - 'LANG': 'en_US.UTF-8', 20:56:57 INFO - 'LANGUAGE': 'en_US:en', 20:56:57 INFO - 'LOGNAME': 'cltbld', 20:56:57 INFO - 'MAIL': '/var/mail/cltbld', 20:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:57 INFO - 'MOZ_NO_REMOTE': '1', 20:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:57 INFO - 'NO_EM_RESTART': '1', 20:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:57 INFO - 'PWD': '/builds/slave/test', 20:56:57 INFO - 'SHELL': '/bin/bash', 20:56:57 INFO - 'SHLVL': '1', 20:56:57 INFO - 'TERM': 'linux', 20:56:57 INFO - 'TMOUT': '86400', 20:56:57 INFO - 'USER': 'cltbld', 20:56:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:57 INFO - '_': '/tools/buildbot/bin/python'} 20:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:57 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 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 20:56:59 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:59 INFO - Downloading docopt-0.6.1.tar.gz 20:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:59 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:59 INFO - Running setup.py install for blobuploader 20:57:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:57:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:57:00 INFO - Running setup.py install for requests 20:57:00 INFO - Running setup.py install for docopt 20:57:00 INFO - Successfully installed blobuploader requests docopt 20:57:00 INFO - Cleaning up... 20:57:00 INFO - Return code: 0 20:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57: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')]} 20:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57: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')]} 20:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:00 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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:57:00 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 20:57:00 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 20:57:00 INFO - Using env: {'DISPLAY': ':0', 20:57:00 INFO - 'HOME': '/home/cltbld', 20:57:00 INFO - 'LANG': 'en_US.UTF-8', 20:57:00 INFO - 'LANGUAGE': 'en_US:en', 20:57:00 INFO - 'LOGNAME': 'cltbld', 20:57:00 INFO - 'MAIL': '/var/mail/cltbld', 20:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:00 INFO - 'MOZ_NO_REMOTE': '1', 20:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:00 INFO - 'NO_EM_RESTART': '1', 20:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:00 INFO - 'PWD': '/builds/slave/test', 20:57:00 INFO - 'SHELL': '/bin/bash', 20:57:00 INFO - 'SHLVL': '1', 20:57:00 INFO - 'TERM': 'linux', 20:57:00 INFO - 'TMOUT': '86400', 20:57:00 INFO - 'USER': 'cltbld', 20:57:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:00 INFO - '_': '/tools/buildbot/bin/python'} 20:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:00 INFO - Running setup.py (path:/tmp/pip-d6kMuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:00 INFO - Running setup.py (path:/tmp/pip-O2umdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:00 INFO - Running setup.py (path:/tmp/pip-FP1J7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:00 INFO - Running setup.py (path:/tmp/pip-8tbwEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:01 INFO - Running setup.py (path:/tmp/pip-5bANrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:01 INFO - Running setup.py (path:/tmp/pip-YQLUm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:01 INFO - Running setup.py (path:/tmp/pip-YF_Ves-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:01 INFO - Running setup.py (path:/tmp/pip-0cgaTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:01 INFO - Running setup.py (path:/tmp/pip-XzqUhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:01 INFO - Running setup.py (path:/tmp/pip-EYYIl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:01 INFO - Running setup.py (path:/tmp/pip-vFdTKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:01 INFO - Running setup.py (path:/tmp/pip-MMsncJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:01 INFO - Running setup.py (path:/tmp/pip-jJ71qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:01 INFO - Running setup.py (path:/tmp/pip-E_80ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:01 INFO - Running setup.py (path:/tmp/pip-d8Tjdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:01 INFO - Running setup.py (path:/tmp/pip-Wyt4n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:01 INFO - Running setup.py (path:/tmp/pip-WDVxsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:57:02 INFO - Running setup.py install for manifestparser 20:57:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Running setup.py install for mozcrash 20:57:02 INFO - Running setup.py install for mozdebug 20:57:02 INFO - Running setup.py install for mozdevice 20:57:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Running setup.py install for mozfile 20:57:02 INFO - Running setup.py install for mozhttpd 20:57:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Running setup.py install for mozinfo 20:57:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Running setup.py install for mozInstall 20:57:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Running setup.py install for mozleak 20:57:02 INFO - Running setup.py install for mozlog 20:57:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for moznetwork 20:57:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozprocess 20:57:03 INFO - Running setup.py install for mozprofile 20:57:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozrunner 20:57:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozscreenshot 20:57:03 INFO - Running setup.py install for moztest 20:57:03 INFO - Running setup.py install for mozversion 20:57:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:57:03 INFO - Cleaning up... 20:57:03 INFO - Return code: 0 20:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:03 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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:57:03 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 20:57:03 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 20:57:03 INFO - Using env: {'DISPLAY': ':0', 20:57:03 INFO - 'HOME': '/home/cltbld', 20:57:03 INFO - 'LANG': 'en_US.UTF-8', 20:57:03 INFO - 'LANGUAGE': 'en_US:en', 20:57:03 INFO - 'LOGNAME': 'cltbld', 20:57:03 INFO - 'MAIL': '/var/mail/cltbld', 20:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:03 INFO - 'MOZ_NO_REMOTE': '1', 20:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:03 INFO - 'NO_EM_RESTART': '1', 20:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:03 INFO - 'PWD': '/builds/slave/test', 20:57:03 INFO - 'SHELL': '/bin/bash', 20:57:03 INFO - 'SHLVL': '1', 20:57:03 INFO - 'TERM': 'linux', 20:57:03 INFO - 'TMOUT': '86400', 20:57:03 INFO - 'USER': 'cltbld', 20:57:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:03 INFO - '_': '/tools/buildbot/bin/python'} 20:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:04 INFO - Running setup.py (path:/tmp/pip-9aJpCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:04 INFO - Running setup.py (path:/tmp/pip-j7TajC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:04 INFO - Running setup.py (path:/tmp/pip-YVA2KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:04 INFO - Running setup.py (path:/tmp/pip-xtXKap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:04 INFO - Running setup.py (path:/tmp/pip-d6EFUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:04 INFO - Running setup.py (path:/tmp/pip-kl8So_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:04 INFO - Running setup.py (path:/tmp/pip-0MkG40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:04 INFO - Running setup.py (path:/tmp/pip-8dlQq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:04 INFO - Running setup.py (path:/tmp/pip-8pZfbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:04 INFO - Running setup.py (path:/tmp/pip-xYVdlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:04 INFO - Running setup.py (path:/tmp/pip-zErtJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:04 INFO - Running setup.py (path:/tmp/pip-OdkiaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:04 INFO - Running setup.py (path:/tmp/pip-VNWaVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:04 INFO - Running setup.py (path:/tmp/pip-HLpiE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:05 INFO - Running setup.py (path:/tmp/pip-6Wu1gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:05 INFO - Running setup.py (path:/tmp/pip-hRTzKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:05 INFO - Running setup.py (path:/tmp/pip-o_BzoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:05 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)) 20:57:05 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)) 20:57:05 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)) 20:57:05 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)) 20:57:05 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)) 20:57:05 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)) 20:57:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:07 INFO - Downloading blessings-1.6.tar.gz 20:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:07 INFO - Installing collected packages: blessings 20:57:07 INFO - Running setup.py install for blessings 20:57:07 INFO - Successfully installed blessings 20:57:07 INFO - Cleaning up... 20:57:07 INFO - Return code: 0 20:57:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:07 INFO - Reading from file tmpfile_stdout 20:57:07 INFO - Current package versions: 20:57:07 INFO - argparse == 1.2.1 20:57:07 INFO - blessings == 1.6 20:57:07 INFO - blobuploader == 1.2.4 20:57:07 INFO - docopt == 0.6.1 20:57:07 INFO - manifestparser == 1.1 20:57:07 INFO - mozInstall == 1.12 20:57:07 INFO - mozcrash == 0.17 20:57:07 INFO - mozdebug == 0.1 20:57:07 INFO - mozdevice == 0.48 20:57:07 INFO - mozfile == 1.2 20:57:07 INFO - mozhttpd == 0.7 20:57:07 INFO - mozinfo == 0.9 20:57:07 INFO - mozleak == 0.1 20:57:07 INFO - mozlog == 3.1 20:57:07 INFO - moznetwork == 0.27 20:57:07 INFO - mozprocess == 0.22 20:57:07 INFO - mozprofile == 0.28 20:57:07 INFO - mozrunner == 6.11 20:57:07 INFO - mozscreenshot == 0.1 20:57:07 INFO - mozsystemmonitor == 0.0 20:57:07 INFO - moztest == 0.7 20:57:07 INFO - mozversion == 1.4 20:57:07 INFO - psutil == 3.1.1 20:57:07 INFO - requests == 1.2.3 20:57:07 INFO - wsgiref == 0.1.2 20:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:07 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')]} 20:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:07 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')]} 20:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:07 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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:57:07 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 20:57:07 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 20:57:07 INFO - Using env: {'DISPLAY': ':0', 20:57:07 INFO - 'HOME': '/home/cltbld', 20:57:07 INFO - 'LANG': 'en_US.UTF-8', 20:57:07 INFO - 'LANGUAGE': 'en_US:en', 20:57:07 INFO - 'LOGNAME': 'cltbld', 20:57:07 INFO - 'MAIL': '/var/mail/cltbld', 20:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:07 INFO - 'MOZ_NO_REMOTE': '1', 20:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:07 INFO - 'NO_EM_RESTART': '1', 20:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:07 INFO - 'PWD': '/builds/slave/test', 20:57:07 INFO - 'SHELL': '/bin/bash', 20:57:07 INFO - 'SHLVL': '1', 20:57:07 INFO - 'TERM': 'linux', 20:57:07 INFO - 'TMOUT': '86400', 20:57:07 INFO - 'USER': 'cltbld', 20:57:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:07 INFO - '_': '/tools/buildbot/bin/python'} 20:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 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)) 20:57:07 INFO - Cleaning up... 20:57:07 INFO - Return code: 0 20:57:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57:07 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')]} 20:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:07 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')]} 20:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:07 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 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:57:07 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 20:57:07 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 20:57:07 INFO - Using env: {'DISPLAY': ':0', 20:57:07 INFO - 'HOME': '/home/cltbld', 20:57:07 INFO - 'LANG': 'en_US.UTF-8', 20:57:07 INFO - 'LANGUAGE': 'en_US:en', 20:57:07 INFO - 'LOGNAME': 'cltbld', 20:57:07 INFO - 'MAIL': '/var/mail/cltbld', 20:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:07 INFO - 'MOZ_NO_REMOTE': '1', 20:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:07 INFO - 'NO_EM_RESTART': '1', 20:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:07 INFO - 'PWD': '/builds/slave/test', 20:57:07 INFO - 'SHELL': '/bin/bash', 20:57:07 INFO - 'SHLVL': '1', 20:57:07 INFO - 'TERM': 'linux', 20:57:07 INFO - 'TMOUT': '86400', 20:57:07 INFO - 'USER': 'cltbld', 20:57:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:07 INFO - '_': '/tools/buildbot/bin/python'} 20:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:08 INFO - Downloading/unpacking jsonschema 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:57:10 INFO - Downloading/unpacking functools32 (from jsonschema) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:57:10 INFO - warning: no files found matching '*.txt' 20:57:10 INFO - no previously-included directories found matching 'build' 20:57:10 INFO - no previously-included directories found matching 'dist' 20:57:10 INFO - no previously-included directories found matching '.git*' 20:57:10 INFO - Installing collected packages: jsonschema, functools32 20:57:10 INFO - Running setup.py install for functools32 20:57:10 INFO - warning: no files found matching '*.txt' 20:57:10 INFO - no previously-included directories found matching 'build' 20:57:10 INFO - no previously-included directories found matching 'dist' 20:57:10 INFO - no previously-included directories found matching '.git*' 20:57:10 INFO - Successfully installed jsonschema functools32 20:57:10 INFO - Cleaning up... 20:57:10 INFO - Return code: 0 20:57:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:57: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')]} 20:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57: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')]} 20:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e3dd9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', '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 20:57: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', 'flake8'] in /builds/slave/test/build 20:57: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 flake8 20:57:10 INFO - Using env: {'DISPLAY': ':0', 20:57:10 INFO - 'HOME': '/home/cltbld', 20:57:10 INFO - 'LANG': 'en_US.UTF-8', 20:57:10 INFO - 'LANGUAGE': 'en_US:en', 20:57:10 INFO - 'LOGNAME': 'cltbld', 20:57:10 INFO - 'MAIL': '/var/mail/cltbld', 20:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:10 INFO - 'MOZ_NO_REMOTE': '1', 20:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:10 INFO - 'NO_EM_RESTART': '1', 20:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:10 INFO - 'PWD': '/builds/slave/test', 20:57:10 INFO - 'SHELL': '/bin/bash', 20:57:10 INFO - 'SHLVL': '1', 20:57:10 INFO - 'TERM': 'linux', 20:57:10 INFO - 'TMOUT': '86400', 20:57:10 INFO - 'USER': 'cltbld', 20:57:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:10 INFO - '_': '/tools/buildbot/bin/python'} 20:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:10 INFO - Downloading/unpacking flake8 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:57:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:57:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57: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 20:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:57:13 INFO - no previously-included directories found matching 'docs/_build' 20:57:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:57:13 INFO - Running setup.py install for pep8 20:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:57:13 INFO - no previously-included directories found matching 'docs/_build' 20:57:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:57:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:57:13 INFO - Cleaning up... 20:57:13 INFO - Return code: 0 20:57:13 INFO - Running post-action listener: _resource_record_post_action 20:57:13 INFO - Running post-action listener: _start_resource_monitoring 20:57:13 INFO - Starting resource monitoring. 20:57:13 INFO - ##### 20:57:13 INFO - ##### Running install step. 20:57:13 INFO - ##### 20:57:13 INFO - Running pre-action listener: _resource_record_pre_action 20:57:13 INFO - Running main action method: install 20:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:13 INFO - Reading from file tmpfile_stdout 20:57:13 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:13 INFO - Reading from file tmpfile_stdout 20:57:13 INFO - Output received: 20:57:13 INFO - Usage: mozinstall [options] installer 20:57:13 INFO - Options: 20:57:13 INFO - -h, --help show this help message and exit 20:57:13 INFO - -d DEST, --destination=DEST 20:57:13 INFO - Directory to install application into. [default: 20:57:13 INFO - "/builds/slave/test"] 20:57:13 INFO - --app=APP Application being installed. [default: firefox] 20:57:13 INFO - mkdir: /builds/slave/test/build/application 20:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:57:27 INFO - Reading from file tmpfile_stdout 20:57:27 INFO - Output received: 20:57:27 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:27 INFO - Running post-action listener: _resource_record_post_action 20:57:27 INFO - ##### 20:57:27 INFO - ##### Running run-tests step. 20:57:27 INFO - ##### 20:57:27 INFO - Running pre-action listener: _resource_record_pre_action 20:57:27 INFO - Running main action method: run_tests 20:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:27 INFO - Python 2.7.3 20:57:27 INFO - Return code: 0 20:57:27 INFO - grabbing minidump binary from tooltool 20:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:27 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 0x2689410>, '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 0x268a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:27 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 20:57:27 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 20:57:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:27 INFO - Return code: 0 20:57:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:57:28 INFO - Return code: 0 20:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 20:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 20:57:28 INFO - Using env: {'DISPLAY': ':0', 20:57:28 INFO - 'HOME': '/home/cltbld', 20:57:28 INFO - 'LANG': 'en_US.UTF-8', 20:57:28 INFO - 'LANGUAGE': 'en_US:en', 20:57:28 INFO - 'LOGNAME': 'cltbld', 20:57:28 INFO - 'MAIL': '/var/mail/cltbld', 20:57:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:28 INFO - 'MOZ_NO_REMOTE': '1', 20:57:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:28 INFO - 'NO_EM_RESTART': '1', 20:57:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:28 INFO - 'PWD': '/builds/slave/test', 20:57:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:28 INFO - 'SHELL': '/bin/bash', 20:57:28 INFO - 'SHLVL': '1', 20:57:28 INFO - 'TERM': 'linux', 20:57:28 INFO - 'TMOUT': '86400', 20:57:28 INFO - 'USER': 'cltbld', 20:57:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389', 20:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:28 INFO - '_': '/tools/buildbot/bin/python'} 20:57:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 20:57:28 INFO - mozversion application_buildid: 20160609181731 20:57:28 INFO - mozversion application_changeset: c5411e82e576319387b3cfe45cfcd5ac917d067b 20:57:28 INFO - mozversion application_display_name: Firefox 20:57:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:28 INFO - mozversion application_name: Firefox 20:57:28 INFO - mozversion application_remotingname: firefox 20:57:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:57:28 INFO - mozversion application_vendor: Mozilla 20:57:28 INFO - mozversion application_version: 48.0 20:57:28 INFO - mozversion platform_buildid: 20160609181731 20:57:28 INFO - mozversion platform_changeset: c5411e82e576319387b3cfe45cfcd5ac917d067b 20:57:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:57:28 INFO - mozversion platform_version: 48.0 20:57:28 INFO - using testdate: 1465531048 20:57:28 INFO - actual date: 1465531048 20:57:28 INFO - starting webserver on 'localhost:58564' 20:57:28 INFO - SUITE-START | Running 2 tests 20:57:28 INFO - TEST-START | dromaeo_css 20:57:28 INFO - operating with platform_type : linux_ 20:57:28 INFO - Initialising browser for dromaeo_css test... 20:57:28 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3VM5Ln/profile http://localhost:58564/getInfo.html) 20:57:32 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 20:57:32 INFO - PROCESS | 1660 | colorDepth:24 20:57:32 INFO - PROCESS | 1660 | Browser inner width/height: 1024/697 20:57:32 INFO - PROCESS | 1660 | __metrics 20:57:33 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:57:34 INFO - TEST-INFO | 1660: exit 0 20:57:34 INFO - Browser initialized. 20:57:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:57:34 INFO - TEST-INFO | started process 1750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3VM5Ln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:46 INFO - PROCESS | 1750 | RSS: Main: 141262848 20:57:46 INFO - PROCESS | 1750 | 20:58:37 INFO - PROCESS | 1750 | 1465531117820 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] 21:00:44 INFO - PROCESS | 1750 | Cycle 1(1): loaded http://localhost:58564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58564/tests/dromaeo/cssquery-ext.html) 21:00:45 INFO - PROCESS | 1750 | RSS: Main: 249999360 21:00:45 INFO - PROCESS | 1750 | 21:03:47 INFO - PROCESS | 1750 | Cycle 1(1): loaded http://localhost:58564/tests/dromaeo/cssquery-ext.html (next: http://localhost:58564/tests/dromaeo/cssquery-jquery.html) 21:03:48 INFO - PROCESS | 1750 | RSS: Main: 224161792 21:03:48 INFO - PROCESS | 1750 | 21:06:50 INFO - PROCESS | 1750 | Cycle 1(1): loaded http://localhost:58564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58564/tests/dromaeo/cssquery-mootools.html) 21:06:50 INFO - PROCESS | 1750 | RSS: Main: 222752768 21:06:50 INFO - PROCESS | 1750 | 21:09:52 INFO - PROCESS | 1750 | Cycle 1(1): loaded http://localhost:58564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58564/tests/dromaeo/cssquery-prototype.html) 21:09:53 INFO - PROCESS | 1750 | RSS: Main: 214761472 21:09:53 INFO - PROCESS | 1750 | 21:12:55 INFO - PROCESS | 1750 | Cycle 1(1): loaded http://localhost:58564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58564/tests/dromaeo/cssquery-yui.html) 21:12:56 INFO - PROCESS | 1750 | RSS: Main: 181116928 21:12:56 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | Cycle 1(1): loaded http://localhost:58564/tests/dromaeo/cssquery-yui.html (next: http://localhost:58564/tests/dromaeo/cssquery-dojo.html) 21:15:58 INFO - PROCESS | 1750 | RSS: Main: 244600832 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | __start_tp_report 21:15:58 INFO - PROCESS | 1750 | _x_x_mozilla_page_load 21:15:58 INFO - PROCESS | 1750 | _x_x_mozilla_page_load_details 21:15:58 INFO - PROCESS | 1750 | |i|pagename|runs| 21:15:58 INFO - PROCESS | 1750 | |0;dojo.html;3297.917552061198;3370.7808992415507;3375.409303371909;3399.456087026075;3440.243146507769;5595.3285605727315;5618.915716264249;5621.269234999455;5638.0415329394;5673.234113394686;5595.38450770415;5638.295213098363;5643.351014633318;5654.46282603153;5685.1756495308155;5140.383154021504;5144.279800827887;5171.120909445384;5240.554552863011;5286.207068939651;5151.4333423323405;5161.071007218699;5187.844364669066;5235.371755389358;5252.264682944391;5219.373675158986;5231.267622532849;5231.790728370861;5239.816606418776;5270.446603106676;5156.149235376159;5165.560927321182;5218.39988401333;5235;5241.187615919539;5001.974990125026;5098.158803797369;5135.563477104413;5167.870803229949;5167.948320516784;5569.331680198362;5590.692511911843;5593.161025846156;5595.21666966625;5611.186377975171;5910.793122240744;5974.850628734316;6089.543284253655;6094.177286066369;6100.45095941363;6100.938990610081;6101.328853826076;6107.358727333611;6109.991851344523;6117.724702388403;5702.914456283159;5708.286464191976;5710.914336284917;5711.971440142773;5748.338941021752;6116.755329786759;6141.07883817422;6164.321924588292;6206.813795586139;6221.968890155611;5984.790532331434;5993.011153159679;6018.187544681499;6038.154658347835;6040.728167232485;6084.239470066242;6087.421694938974;6087.573869829158;6088.726007329681;6092.695365231721;5992.790252341147;6022.3676513966275;6023.759049638053;6029.909551356734;6093.634381937098;6022.126791615191;6044.395560443921;6055.485283750842;6062.757489700451;6079.513638908877;4599.563041511051;4604.930926036112;4607.216773148572;4610.631149508032;4635.907281854412;4046.352583586612;4092.7953602319767;4099.938500922489;4103.5691252418665;4139.089400331922;5824.0390335595;5832.445917637818;5838.79564215259;5840.474357307863;5842.444967728059;6067.180930574316;6117.602355846856;6121.877562448726;6126.969365153146;6130.693465326716;5636.436356364413;5782.277215348082;5798.594098413155;5852.092925596539;5882.882342353215;5184.48155184486;5190.480951904855;5194.6104042196985;5200.6619569727845;5203.973980130151;6301.464375528039;6304.558680892385;6308.905366419507;6311.463525600284;6313.873722525524;5970.492508136857;5988.999999999913;6030.246219222598;6066.211392518944;6075.362086980804;6242.375762423721;6251.593646412968;6276.811695649138;6285.560010799383;6357.396047375492;5891.558133140117;6023.969880150747;6028.668423236764;6031.396860313934;6032.668203248688;6041.18444010053;6062.242219722535;6083.756649734138;6118.357572454828;6136.601120927304;5945.732442040032;5951.315598706031;5956.195913551615;5956.37458066914;5967.76128954837;5809.215755873072;5831.679257640871;5880.558958078076;5960.4635582797755;5969.671668058299;5789.45000224978;5812.331581868139;5820.563457740602;5822.039363504974;5846.6784326862435;5900.468957793819;5932.911006334994;5937.050071988461;5938.61399009063;5943.405659434022;5770.682612456355;5787.508061814793;5817.7963771267805;5857.50211232033;5875.764969401176 21:15:58 INFO - PROCESS | 1750 | |1;ext.html;669.42763936834;673.8854394752892;693.2235895796708;740.16361511492;762.1768490030768;31576.684233157663;32462.350752984956;40371.59628403719;40475.39286910699;40564.39153412694;42276.57723422765;42602.573974260245;42721.572784272146;42853.357199641956;42962;7950.4037197210155;8633.740987770378;8822.602982865787;8827.867581986244;8831.690890818823;8106.392020598479;10666.679999600025;10941.83587246192;10947.56209751609;10951.726206844813;10469.057784799366;10549.525271362769;10554.366737995706;10555.155587553016;10559.26085174038;10538.947305263462;10607.946960265226;10623.734406639818;10627.202959778047;10634.255602107856;10245.180385569136;10344.94827525865;10370.533326000348;10380.377177369382;10383.688489345257;43140.56859431428;43465.130697385874;43655.78172109151;43897.561024389666;43959;4033.193361327746;4117.958820411817;4136.6483848872585;4190;4397.956020439787;33508.83245583757;33671.831640841636;34000.48999265013;34350.656493434995;35114;4135.234981528397;4136.503619565641;4230.132822771325;4237.915241695149;4246.278132717445;228511;228958;230190;230260;231120.84439577864;39607.405888911686;39796.403053954215;39914.80042599768;64361.35638643554;64806;39554.60445395567;39585.2082958345;39587.40618890719;39732.40401393981;39760;16413.1793410329;16543.420980265873;16545.6690866182;16567;16569.83430165707;13601.727965440636;14985.775213371808;15108;15369.538913832603;15503.457378991907;9456.196223321094;9466.95266523663;9524.047595240421;9585.424874507413;9585.472798996123;3603.72972027099;3655.1044993976116;3750.2499500099543;3758.1168425420005;3769.7172712046704;1067.8024565455416;1116.843641890136;1132.3036332655358;1164.6214980131492;1217.2331431198288;33258;33875;33899;34309.31381372359;35097.47353789695;1223.7919553675897;1248.950041998328;1251;1253.2731016010691;1323.087069921751;17501.7374739379;17912.910435448;18054.638907222045;18438.539036523925;18488.907555462407;483917;488729;490629;490828;491794;59268.40731592715;60164.39835601588;60515.092273615934;60525.39474605286;60684.696576516835;1375.7592421326228;1460.3282490054694;1549.055076403393;1580.123031717408;1654.123314643241;31187.688123118478;32908.67091329056;33159.33681326408;33446;33698.32603347969;61640.691796540734;63326;63387;63428.36571634225;63478.68260658667;462921;473985;474026;474263;474524;40790.79604601958;49506.75246623744;50722.2391664118;51646.48353516417;52034.739826300625;48910.75544622254;49487.752561236965;49841;49913;50754.492455076455;40012;40519.59480405158;40569.59430405658;41137.38293925653;45533;44518;45182.54817451915;45640.771796140805;45792.54207458016;46279;44469.11061778811;44787;45104.548954510035;45218.32172517481;45494.77252613716;39886;40587.797061014506;40712.59287407206;41286;41594.37608435936;32828;35404.46893296654;35969.64030359663;36153.096172594844;36259.27481450409 21:15:58 INFO - PROCESS | 1750 | |2;jquery.html;437.79606083271005;440.56164116703843;440.77961019490255;449.2161178743093;453.8593036158791;18753.531161720948;18829;19438.90280548597;20249.797502024976;20322.18711251552;18698;19110.52223694408;19534.902325488387;19569.41291761246;19595.314164004263;5560.555155587544;5640.5487560995125;5793.594448388614;5797.478226959573;5801.303843538782;3903.8243279052367;5809.2738407699035;5809.73856176471;5844.357120716718;6095.573309868311;6084.269887613493;6126.724297406628;6131.693415329238;6132.26412830461;6135.631862088267;5859.589828711992;6036.758529658809;6050.667213303266;6056.000759874638;6059.848503787396;3831.3103641344546;5673.780137270506;5831.970840145815;5898.970505147489;5915.3788852170765;14475.493357732428;14556.344964476624;14655.047421917649;14713.632159196106;22198.11207551696;2535.150724507292;2554.1698947842024;2621.423286876884;2627.671541057368;2634.3677517395686;10088.54601542925;10775.191860610486;10789.406582637952;11184.944075279653;11263.380514071723;2010.3667344786345;2047.5495391014101;2080.219917530926;2100.726905502275;2174.6194415977143;73364;75870;76186.61906690487;76229;76738.23261767367;11717.12121590884;11868.347240901661;11934;11948.581799636971;12002.399880005965;16892.324307027826;16996.235169417407;17046.48860534186;17049.48851534456;17049.659006819795;8619.138086191331;8658.653653853902;8803.119688031275;9012.81974360509;9181.0818918109;8797;8804.383693141419;8843.46939183651;8907.643694252158;8915.465072095694;5103.157978933508;5110.7955681773055;5174.793008279702;5216.1393370094265;5277.683338999673;1935.419374187738;2054.4042227754085;2082.666773316262;2123.6708310211943;2206.8786216757912;1027.5376080763538;1074.854894589236;1086.5273605981424;1091.7270682329417;1132.592266783957;18853.52866178329;18964.620707586048;19026.143823527975;19231.230750769813;19622.509437263896;1045.8431235314763;1086.5870969031716;1089.199438412766;1110.245033377311;1167.1363191238422;10765.407902565434;10969.780604387868;11043.392613406178;11048.558057677603;11052.889471105185;473195;474790;477191;483758;486560;84833.57583212045;90182.99999999869;90957.54521227484;92058.53970730104;93073.53463232641;1062.3997441445713;1092.4646923007829;1144.6222746493638;1160.2980196980873;1164.0745607242263;17068.743968840725;17192.742108868126;17223;17257.827421725622;17417.738733918748;37186.814065929495;37267.62732372642;37750.43374349442;38618.84143475588;39114.2177156461;55347.16979245234;55642.72178639081;55773.721131394086;56768;57103.42896571147;8592.957035214784;8633.602936043393;8721.781955450911;8768.649254029768;9022.233110185707;9350.485723285012;12615.747685046432;13394.866051339362;13400.664983375493;13572;11666.358350290477;12087.818682719942;12141.453634586289;12234.143609947574;12331.506739730668;11581.82627260575;11729.237599556001;11895.702607434883;11898.940505297418;11974;12060.638180854588;12223.449944752685;12378.257304561756;12926.095173337777;12964.870351296366;9166;9226.9538652309;9439.056094390506;9450.574724137292;9480.436560984812;9332.533373331442;11779.528818847493;11957.282563046245;12309.44607492683;12592.622221333375 21:15:58 INFO - PROCESS | 1750 | |3;mootools.html;1394.1704685711998;1596.9840301596985;1606.9437569685062;1818.38175020493;1905.7713074431078;8225.670973161074;8325.125861784516;8343.12397198293;8345.958270208655;8358.414910956235;8274.95862520688;8520.19058189471;8545.871811922827;8559.44363616366;8569.828603427928;2376.3821406434363;2401.471676231235;2403.230966090852;2405.9518809623796;2406.939826504343;2446.3272600035043;2448.9387765305833;2486.403263216824;2499.52509023285;2500.9749902501017;2331.4987277735286;2337.8714170720605;2342.449524361782;2403.351095204294;2404.026369320428;2380.1193558383334;2419.1049311754764;2435.537247922889;2437.5368679950843;2438.9878050609723;2365.8935347909387;2433.9634905476432;2441.4994926040117;2442.364985103886;2442.6213936839818;7489.475736698433;7879.409044321699;8819.647214111428;8854.513001784899;8867.334949878785;5334.359876814807;5429.077056900336;5464.098423760075;5480.232767412565;5487.725613719338;3497.9125521862156;3576.052346128252;3610.0794297454245;3614.2771445710964;3625.655562721537;1220.6582156996055;1227.9079069069767;1238.5541205166132;1253.1979533098825;1267.9936600317033;11997.560292764836;12018.519259229708;12079.516819327304;12100.515979360815;12128.211666241667;4692.929606055912;4706.647001474835;4798.5441383068555;4812.06164797868;4819.469858315582;10348.637797677045;10369.377837329785;10369.948150259352;10373.118284945864;10417.218708596885;5545.584081193927;5547.972260138674;5549.472800083986;5554;5555.111182210908;4921.015796840575;4940.1601727706375;4987.60099192071;4988.551030407209;4995.900081998412;4077.8776636700945;4220.240356735756;4221.767802770815;4250.171216612731;4261.786910654455;1331.1613683379603;1368.6920442900466;1375.6010756880594;1380.365032085252;1380.861913808611;976.0971101731012;989.4360214677708;995.9900400996042;999.6051559633904;1008.1833714690977;5881.941180588139;5893.850699113717;5913.793017244376;5917.704114794243;6057.121717350959;477.26024661774113;479.1064664400867;480.0710624940751;482.79722516543137;492.1682356816968;3900.2199560088097;3979.3633018716864;3999.320115580358;4014.558398576154;4082.795860206978;10417.479126043667;10797.406142662072;10825.188110891557;10858.72853178661;10907.945460272807;10583.100436462986;10595.470226488645;10686.679399617868;10711;10714.303570267908;7932.365410767125;8169.142240064826;8309.169083091763;8350.66597336112;8377.916220837835;5851.853703657443;5899.528037757055;5905.379935106752;6000.849978750566;6015.909761353496;9342.205912497242;9377.953110234404;9391.107844754737;9431.669891554036;9600.75998100053;9579.856302155613;9592.08875156859;9978.700638980843;10006.349587276804;10076.748081298027;7806.92193078062;8040.356771458152;8082.393820463606;8087.393445491494;8131;8510.404271700922;8555.31557475413;8579.65681372763;8658.48049117055;8664.696735614223;7805.648745806338;7939.523628582304;7969.681212751425;8061.798455038671;8122.1065682776025;7273.636318184175;7341.192468828532;7740;7742.341900938483;7888.605569721606;7424.1462231844025;7437.702491900263;7503.88744168827;7505.136909255287;7535.773926782205;4754.50077741846;5163.845084647466;5180.7409629519125;5247.58019358458;5315.282436870973;5160.09698302803;5184.300119483822;5215.791368345223;5235.3717553893775;5261.657992230493 21:15:58 INFO - PROCESS | 1750 | |4;prototype.html;361.091853987222;363.20095789263627;364.0970393424308;366.3936185612812;368.10366756946837;6310.8106756797315;6321.652309123008;6356.07836863655;6368.3313252108555;6371.108044873716;5991.430814072667;6120.234970628671;6246.344133865947;6248.250209974809;6319.936800631992;4875.195592727196;4899.510048995107;4906.067847109038;4907.852764417074;4922.409310882699;4912.828051018198;4923.261510773395;4925.014997000596;4930.531599498042;4931.975340123312;4644.465886423054;4685.367475390813;4687.086018226447;4772;4792.784324705397;4777.808887644507;4781;4796.304535842283;4841.128596852565;4852.636052296057;4291.785410729451;4295.248331541968;4298.591633794785;4299.290617048183;4307.181635489247;6096.512279017668;6102.298235702907;6102.572819902609;6103.755849766004;6111.663858487781;5618.129189975561;5619.241402410663;5627.155926611;5634.323881134249;5636.774529018834;6492.285848556655;6622.569532980389;6625.536212465129;6634.137562116942;6635.900461493082;4643.117807616576;4662;4672.415948006499;4674.158651442739;4680.461746899082;6924.376806087476;6926.58440493572;6931.133608298963;6936.826579335507;6944.4444444444825;4778.665493415428;4779.808807647724;4786.210275304536;4788.162071637449;4788.281757736368;4846.030793841246;4846.539578740014;4851.175300198975;4851.587615052689;4853.927191092136;5451.536619387317;5568.582356323211;5604.019296623074;5606.60753747242;5611.494965453129;6659.567128136656;6678.365555272241;6683.431908287753;6692.230393504712;6693.230278517935;1616.3534586165629;1718.8195239499923;1735.9305627774747;1741.2251548061245;1741.2599645151013;1094.7372630568607;1107.2526044919648;1112.7607564373698;1117.899389054989;1190.3572071081692;6454.064160696673;6455.935440645533;6461.8061458156335;6470.09418681385;6472.223333199952;6849.280825513349;6851.862962740717;6855.897161542581;6859.108315918898;6862.348076932683;6458.321876203025;6459.09572659828;6464.838379040561;6466.062420948936;6473.320301368382;3622.5471816022996;3673.779573225615;3706.1475860552223;3711.2206436648066;3712.3317802795755;7084.539504932266;7096.787096387116;7100.289971002859;7104.964475177591;7110.146782386147;6932.341427564374;6936.722531098801;6946.5484743492525;6947.548409353376;6951.582905025714;7048.718051277891;7074.68163932614;7089.574625522485;7090.610016449042;7090.680919358641;6673.8998915015345;6826.180858297036;6827.1807383112355;6827.658617069226;6833;6698.330166983263;6716.5634233774645;6718.630475323904;6720.092787473824;6723.462123030244;7035.12060992376;7055.823604409726;7056.08270924797;7058.682359293947;7061.2232654409;4860.1008813369635;4864.586510146536;4867.513248675245;4869.391326084239;4869.902601947871;6795.762148324785;6804.285550017177;6805.2854450283985;6805.979103134569;6808.148981377328;6542.182227221598;6716.798496045127;6725.865482690221;6726.6972986216715;6729.798106056826;6670.866582668223;6704.966475167593;6710;6719.126513553402;6721.395074443323;6577.375149360803;6578.605283682994;6582.3746744059235;6584.934150658432;6589.4728421725185;6596.8350791230605;6736.73053077891;6739;6743.494237932076;6753.2909044549615;6579.309172536815;6615.206175259;6660.700268488026;6664.566803157779;6666.866662666623 21:15:58 INFO - PROCESS | 1750 | |5;yui.html;845.4208866926156;846.5894041389924;847.5973912391614;887.653815012145;919.5562271353588;14683.486077987272;15440.768388474182;15487.61280967975;15505.767413488793;15532.22338883057;14019.719605607881;14059.437622495088;14088;14146.221957792317;14189.574312770608;766.2682138557692;772.7256823827545;772.9884051739228;895.6327905558705;912.9817403651956;776.1733753552477;898.0301274623424;916.3539704508306;917.0554329041098;917.3761841947506;951.4101257220499;959.4531117263163;960.6445615122415;962.2686758063887;964.2286171063122;787.5038725602891;792.6591565626778;951.5242378810594;953.2421724728822;953.9236861051099;585.2333443189393;691.9688614012382;699.9370056694871;700.4361489001352;700.6671830880291;15086.698266034728;15120.924395377953;15139.848601514064;15167.24163791806;15174.089554626647;13856.792148117785;14328.426862925471;14387.78418323726;15053.623659408493;15214.08715477064;12003.699907502294;12034.578789742318;12105.878941210563;12242.143049986504;12628.68428289291;3976.4234186042863;3982.26328129297;4016.859409920639;4040.717149799515;4097.44684467599;57654;57717.422825771624;57852.71073644647;58006.41993580094;58467.122993155135;11699;12007.159498835172;12178.451969661386;12223.816642750366;12417.068719846047;21617.567648647255;21627.35117946464;21685.241016564345;21748.673769893463;21776.237831675815;8760.342974276955;8811.603477843513;8993.910060899307;8998.460092394478;9140.771480712903;4997.2254300582745;5019.387872224649;5076.187809950464;5078.7206703631655;5231.869203269873;3592.9281414371567;3604.2070744436182;3631.055925459347;3639.1266096137265;3653.232821107544;597.0626116996274;611.3977731934042;616.0635833533005;621.2886245249165;625.5371025441232;715.727109158324;822.5434883639638;829.618375547243;840.1514470384956;852.0797538658235;10073.59705611782;10408.47957602117;10440.68677939663;10608.522616482276;10696.732581685364;786.6302837666287;804.6097642643314;825.1130035212171;845.2688424512752;856.1823458597025;4644.8374306899095;4835.371401717754;4860.083227430124;4901;5009.649324547319;63177;66665.33334666688;67310.3268967304;67942.3205767936;67978;57392;58036;58626.82746345049;60245.397546024855;60519.39480605138;51791.741041294554;51933.22100168501;52062;53077;53632.46367536275;9637.18083962871;9668.613255469703;9719.56261968199;9724.367916085432;9889.703308900744;38260.426093609174;38860.6113938857;38917.02707432337;39676;39956.80021599874;47708.284375733696;50050.249246262065;50115.74942125266;50712.23931641102;50811.49188508068;12204.32876191818;12364.258144511357;12560.937195313965;12640.873591264337;12645.74708505843;14277.214753188258;14309.427622894967;14313.499027533986;14458.421663133357;14512.274386280855;13320.800187996994;13371.465141394236;13437.395317210945;13489.258090804708;13914;13743.862561374659;14429.350679219251;14482.855171448573;14687.118772873662;14700;13534.59396218115;13832.723345533233;13892.374843131882;14741.705165896836;14743.705125897637;11237.168017752445;11434.48544815502;11615.941920290683;11621;11760.35318057515;11256.662300131009;11582;11726.413679315829;11925.880741192477;11972.281663100242 21:15:58 INFO - PROCESS | 1750 | __end_tp_report 21:15:58 INFO - PROCESS | 1750 | __start_cc_report 21:15:58 INFO - PROCESS | 1750 | _x_x_mozilla_cycle_collect,828 21:15:58 INFO - PROCESS | 1750 | __end_cc_report 21:15:58 INFO - PROCESS | 1750 | __startTimestamp1465532158716__endTimestamp 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | ------- Summary: start ------- 21:15:58 INFO - PROCESS | 1750 | Number of tests: 6 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | [#0] dojo.html Cycles:165 Average:5641.62 Median:5846.68 stddev:631.82 (10.8%) stddev-sans-first:606.42 21:15:58 INFO - PROCESS | 1750 | Values: 3297.9 3370.8 3375.4 3399.5 3440.2 5595.3 5618.9 5621.3 5638.0 5673.2 5595.4 5638.3 5643.4 5654.5 5685.2 5140.4 5144.3 5171.1 5240.6 5286.2 5151.4 5161.1 5187.8 5235.4 5252.3 5219.4 5231.3 5231.8 5239.8 5270.4 5156.1 5165.6 5218.4 5235.0 5241.2 5002.0 5098.2 5135.6 5167.9 5167.9 5569.3 5590.7 5593.2 5595.2 5611.2 5910.8 5974.9 6089.5 6094.2 6100.5 6100.9 6101.3 6107.4 6110.0 6117.7 5702.9 5708.3 5710.9 5712.0 5748.3 6116.8 6141.1 6164.3 6206.8 6222.0 5984.8 5993.0 6018.2 6038.2 6040.7 6084.2 6087.4 6087.6 6088.7 6092.7 5992.8 6022.4 6023.8 6029.9 6093.6 6022.1 6044.4 6055.5 6062.8 6079.5 4599.6 4604.9 4607.2 4610.6 4635.9 4046.4 4092.8 4099.9 4103.6 4139.1 5824.0 5832.4 5838.8 5840.5 5842.4 6067.2 6117.6 6121.9 6127.0 6130.7 5636.4 5782.3 5798.6 5852.1 5882.9 5184.5 5190.5 5194.6 5200.7 5204.0 6301.5 6304.6 6308.9 6311.5 6313.9 5970.5 5989.0 6030.2 6066.2 6075.4 6242.4 6251.6 6276.8 6285.6 6357.4 5891.6 6024.0 6028.7 6031.4 6032.7 6041.2 6062.2 6083.8 6118.4 6136.6 5945.7 5951.3 5956.2 5956.4 5967.8 5809.2 5831.7 5880.6 5960.5 5969.7 5789.5 5812.3 5820.6 5822.0 5846.7 5900.5 5932.9 5937.1 5938.6 5943.4 5770.7 5787.5 5817.8 5857.5 5875.8 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | [#1] ext.html Cycles:180 Average:57253.89 Median:22022.60 stddev:109887.51 (499.0%) stddev-sans-first:110113.65 21:15:58 INFO - PROCESS | 1750 | Values: 669.4 673.9 693.2 740.2 762.2 31576.7 32462.4 40371.6 40475.4 40564.4 42276.6 42602.6 42721.6 42853.4 42962.0 7950.4 8633.7 8822.6 8827.9 8831.7 8106.4 10666.7 10941.8 10947.6 10951.7 10469.1 10549.5 10554.4 10555.2 10559.3 10538.9 10607.9 10623.7 10627.2 10634.3 10245.2 10344.9 10370.5 10380.4 10383.7 43140.6 43465.1 43655.8 43897.6 43959.0 4033.2 4118.0 4136.6 4190.0 4398.0 33508.8 33671.8 34000.5 34350.7 35114.0 4135.2 4136.5 4230.1 4237.9 4246.3 228511.0 228958.0 230190.0 230260.0 231120.8 39607.4 39796.4 39914.8 64361.4 64806.0 39554.6 39585.2 39587.4 39732.4 39760.0 16413.2 16543.4 16545.7 16567.0 16569.8 13601.7 14985.8 15108.0 15369.5 15503.5 9456.2 9467.0 9524.0 9585.4 9585.5 3603.7 3655.1 3750.2 3758.1 3769.7 1067.8 1116.8 1132.3 1164.6 1217.2 33258.0 33875.0 33899.0 34309.3 35097.5 1223.8 1249.0 1251.0 1253.3 1323.1 17501.7 17912.9 18054.6 18438.5 18488.9 483917.0 488729.0 490629.0 490828.0 491794.0 59268.4 60164.4 60515.1 60525.4 60684.7 1375.8 1460.3 1549.1 1580.1 1654.1 31187.7 32908.7 33159.3 33446.0 33698.3 61640.7 63326.0 63387.0 63428.4 63478.7 462921.0 473985.0 474026.0 474263.0 474524.0 40790.8 49506.8 50722.2 51646.5 52034.7 48910.8 49487.8 49841.0 49913.0 50754.5 40012.0 40519.6 40569.6 41137.4 45533.0 44518.0 45182.5 45640.8 45792.5 46279.0 44469.1 44787.0 45104.5 45218.3 45494.8 39886.0 40587.8 40712.6 41286.0 41594.4 32828.0 35404.5 35969.6 36153.1 36259.3 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | [#2] jquery.html Cycles:180 Average:28385.34 Median:2190.75 stddev:78862.87 (3599.8%) stddev-sans-first:79056.19 21:15:58 INFO - PROCESS | 1750 | Values: 437.8 440.6 440.8 449.2 453.9 18753.5 18829.0 19438.9 20249.8 20322.2 18698.0 19110.5 19534.9 19569.4 19595.3 5560.6 5640.5 5793.6 5797.5 5801.3 3903.8 5809.3 5809.7 5844.4 6095.6 6084.3 6126.7 6131.7 6132.3 6135.6 5859.6 6036.8 6050.7 6056.0 6059.8 3831.3 5673.8 5832.0 5899.0 5915.4 14475.5 14556.3 14655.0 14713.6 22198.1 2535.2 2554.2 2621.4 2627.7 2634.4 10088.5 10775.2 10789.4 11184.9 11263.4 2010.4 2047.5 2080.2 2100.7 2174.6 73364.0 75870.0 76186.6 76229.0 76738.2 11717.1 11868.3 11934.0 11948.6 12002.4 16892.3 16996.2 17046.5 17049.5 17049.7 8619.1 8658.7 8803.1 9012.8 9181.1 8797.0 8804.4 8843.5 8907.6 8915.5 5103.2 5110.8 5174.8 5216.1 5277.7 1935.4 2054.4 2082.7 2123.7 2206.9 1027.5 1074.9 1086.5 1091.7 1132.6 18853.5 18964.6 19026.1 19231.2 19622.5 1045.8 1086.6 1089.2 1110.2 1167.1 10765.4 10969.8 11043.4 11048.6 11052.9 473195.0 474790.0 477191.0 483758.0 486560.0 84833.6 90183.0 90957.5 92058.5 93073.5 1062.4 1092.5 1144.6 1160.3 1164.1 17068.7 17192.7 17223.0 17257.8 17417.7 37186.8 37267.6 37750.4 38618.8 39114.2 55347.2 55642.7 55773.7 56768.0 57103.4 8593.0 8633.6 8721.8 8768.6 9022.2 9350.5 12615.7 13394.9 13400.7 13572.0 11666.4 12087.8 12141.5 12234.1 12331.5 11581.8 11729.2 11895.7 11898.9 11974.0 12060.6 12223.4 12378.3 12926.1 12964.9 9166.0 9227.0 9439.1 9450.6 9480.4 9332.5 11779.5 11957.3 12309.4 12592.6 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | [#3] mootools.html Cycles:180 Average:5799.91 Median:4963.88 stddev:3206.04 (64.6%) stddev-sans-first:3197.93 21:15:58 INFO - PROCESS | 1750 | Values: 1394.2 1597.0 1606.9 1818.4 1905.8 8225.7 8325.1 8343.1 8346.0 8358.4 8275.0 8520.2 8545.9 8559.4 8569.8 2376.4 2401.5 2403.2 2406.0 2406.9 2446.3 2448.9 2486.4 2499.5 2501.0 2331.5 2337.9 2342.4 2403.4 2404.0 2380.1 2419.1 2435.5 2437.5 2439.0 2365.9 2434.0 2441.5 2442.4 2442.6 7489.5 7879.4 8819.6 8854.5 8867.3 5334.4 5429.1 5464.1 5480.2 5487.7 3497.9 3576.1 3610.1 3614.3 3625.7 1220.7 1227.9 1238.6 1253.2 1268.0 11997.6 12018.5 12079.5 12100.5 12128.2 4692.9 4706.6 4798.5 4812.1 4819.5 10348.6 10369.4 10369.9 10373.1 10417.2 5545.6 5548.0 5549.5 5554.0 5555.1 4921.0 4940.2 4987.6 4988.6 4995.9 4077.9 4220.2 4221.8 4250.2 4261.8 1331.2 1368.7 1375.6 1380.4 1380.9 976.1 989.4 996.0 999.6 1008.2 5881.9 5893.9 5913.8 5917.7 6057.1 477.3 479.1 480.1 482.8 492.2 3900.2 3979.4 3999.3 4014.6 4082.8 10417.5 10797.4 10825.2 10858.7 10907.9 10583.1 10595.5 10686.7 10711.0 10714.3 7932.4 8169.1 8309.2 8350.7 8377.9 5851.9 5899.5 5905.4 6000.8 6015.9 9342.2 9378.0 9391.1 9431.7 9600.8 9579.9 9592.1 9978.7 10006.3 10076.7 7806.9 8040.4 8082.4 8087.4 8131.0 8510.4 8555.3 8579.7 8658.5 8664.7 7805.6 7939.5 7969.7 8061.8 8122.1 7273.6 7341.2 7740.0 7742.3 7888.6 7424.1 7437.7 7503.9 7505.1 7535.8 4754.5 5163.8 5180.7 5247.6 5315.3 5160.1 5184.3 5215.8 5235.4 5261.7 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | [#4] prototype.html Cycles:180 Average:5593.08 Median:6455.00 stddev:1665.40 (25.8%) stddev-sans-first:1623.12 21:15:58 INFO - PROCESS | 1750 | Values: 361.1 363.2 364.1 366.4 368.1 6310.8 6321.7 6356.1 6368.3 6371.1 5991.4 6120.2 6246.3 6248.3 6319.9 4875.2 4899.5 4906.1 4907.9 4922.4 4912.8 4923.3 4925.0 4930.5 4932.0 4644.5 4685.4 4687.1 4772.0 4792.8 4777.8 4781.0 4796.3 4841.1 4852.6 4291.8 4295.2 4298.6 4299.3 4307.2 6096.5 6102.3 6102.6 6103.8 6111.7 5618.1 5619.2 5627.2 5634.3 5636.8 6492.3 6622.6 6625.5 6634.1 6635.9 4643.1 4662.0 4672.4 4674.2 4680.5 6924.4 6926.6 6931.1 6936.8 6944.4 4778.7 4779.8 4786.2 4788.2 4788.3 4846.0 4846.5 4851.2 4851.6 4853.9 5451.5 5568.6 5604.0 5606.6 5611.5 6659.6 6678.4 6683.4 6692.2 6693.2 1616.4 1718.8 1735.9 1741.2 1741.3 1094.7 1107.3 1112.8 1117.9 1190.4 6454.1 6455.9 6461.8 6470.1 6472.2 6849.3 6851.9 6855.9 6859.1 6862.3 6458.3 6459.1 6464.8 6466.1 6473.3 3622.5 3673.8 3706.1 3711.2 3712.3 7084.5 7096.8 7100.3 7105.0 7110.1 6932.3 6936.7 6946.5 6947.5 6951.6 7048.7 7074.7 7089.6 7090.6 7090.7 6673.9 6826.2 6827.2 6827.7 6833.0 6698.3 6716.6 6718.6 6720.1 6723.5 7035.1 7055.8 7056.1 7058.7 7061.2 4860.1 4864.6 4867.5 4869.4 4869.9 6795.8 6804.3 6805.3 6806.0 6808.1 6542.2 6716.8 6725.9 6726.7 6729.8 6670.9 6705.0 6710.0 6719.1 6721.4 6577.4 6578.6 6582.4 6584.9 6589.5 6596.8 6736.7 6739.0 6743.5 6753.3 6579.3 6615.2 6660.7 6664.6 6666.9 21:15:58 INFO - PROCESS | 1750 | 21:15:58 INFO - PROCESS | 1750 | [#5] yui.html Cycles:180 Average:16009.95 Median:26176.56 stddev:18353.69 (70.1%) stddev-sans-first:18369.84 21:15:58 INFO - PROCESS | 1750 | Values: 845.4 846.6 847.6 887.7 919.6 14683.5 15440.8 15487.6 15505.8 15532.2 14019.7 14059.4 14088.0 14146.2 14189.6 766.3 772.7 773.0 895.6 913.0 776.2 898.0 916.4 917.1 917.4 951.4 959.5 960.6 962.3 964.2 787.5 792.7 951.5 953.2 953.9 585.2 692.0 699.9 700.4 700.7 15086.7 15120.9 15139.8 15167.2 15174.1 13856.8 14328.4 14387.8 15053.6 15214.1 12003.7 12034.6 12105.9 12242.1 12628.7 3976.4 3982.3 4016.9 4040.7 4097.4 57654.0 57717.4 57852.7 58006.4 58467.1 11699.0 12007.2 12178.5 12223.8 12417.1 21617.6 21627.4 21685.2 21748.7 21776.2 8760.3 8811.6 8993.9 8998.5 9140.8 4997.2 5019.4 5076.2 5078.7 5231.9 3592.9 3604.2 3631.1 3639.1 3653.2 597.1 611.4 616.1 621.3 625.5 715.7 822.5 829.6 840.2 852.1 10073.6 10408.5 10440.7 10608.5 10696.7 786.6 804.6 825.1 845.3 856.2 4644.8 4835.4 4860.1 4901.0 5009.6 63177.0 66665.3 67310.3 67942.3 67978.0 57392.0 58036.0 58626.8 60245.4 60519.4 51791.7 51933.2 52062.0 53077.0 53632.5 9637.2 9668.6 9719.6 9724.4 9889.7 38260.4 38860.6 38917.0 39676.0 39956.8 47708.3 50050.2 50115.7 50712.2 50811.5 12204.3 12364.3 12560.9 12640.9 12645.7 14277.2 14309.4 14313.5 14458.4 14512.3 13320.8 13371.5 13437.4 13489.3 13914.0 13743.9 14429.4 14482.9 14687.1 14700.0 13534.6 13832.7 13892.4 14741.7 14743.7 11237.2 11434.5 11615.9 11621.0 11760.4 11256.7 11582.0 11726.4 11925.9 11972.3 21:15:58 INFO - PROCESS | 1750 | -------- Summary: end -------- 21:15:58 INFO - PROCESS | 1750 | 21:15:59 INFO - TEST-INFO | 1750: exit 0 21:15:59 INFO - TEST-OK | dromaeo_css | took 1110832ms 21:15:59 INFO - TEST-START | kraken 21:15:59 INFO - operating with platform_type : linux_ 21:15:59 INFO - Initialising browser for kraken test... 21:15:59 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5vljoJ/profile http://localhost:58564/getInfo.html) 21:16:02 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 21:16:02 INFO - PROCESS | 1939 | colorDepth:24 21:16:02 INFO - PROCESS | 1939 | Browser inner width/height: 1024/697 21:16:02 INFO - PROCESS | 1939 | __metrics 21:16:04 ERROR - PROCESS | 1939 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:16:04 INFO - TEST-INFO | 1939: exit 0 21:16:04 INFO - Browser initialized. 21:16:04 INFO - Running cycle 1/1 for kraken test... 21:16:04 INFO - TEST-INFO | started process 2032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5vljoJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:16 INFO - PROCESS | 2032 | RSS: Main: 140615680 21:16:16 INFO - PROCESS | 2032 | 21:16:19 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58564/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:19 INFO - PROCESS | 2032 | RSS: Main: 197603328 21:16:19 INFO - PROCESS | 2032 | 21:16:22 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58564/tests/kraken/driver.html?testName=audio-dft) 21:16:23 INFO - PROCESS | 2032 | RSS: Main: 183492608 21:16:23 INFO - PROCESS | 2032 | 21:16:25 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58564/tests/kraken/driver.html?testName=audio-fft) 21:16:26 INFO - PROCESS | 2032 | RSS: Main: 273190912 21:16:26 INFO - PROCESS | 2032 | 21:16:28 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58564/tests/kraken/driver.html?testName=audio-oscillator) 21:16:29 INFO - PROCESS | 2032 | RSS: Main: 179245056 21:16:29 INFO - PROCESS | 2032 | 21:16:31 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:16:31 INFO - PROCESS | 2032 | RSS: Main: 178724864 21:16:31 INFO - PROCESS | 2032 | 21:16:34 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58564/tests/kraken/driver.html?testName=imaging-darkroom) 21:16:35 INFO - PROCESS | 2032 | RSS: Main: 213094400 21:16:35 INFO - PROCESS | 2032 | 21:16:38 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58564/tests/kraken/driver.html?testName=imaging-desaturate) 21:16:39 INFO - PROCESS | 2032 | RSS: Main: 212729856 21:16:39 INFO - PROCESS | 2032 | 21:16:42 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58564/tests/kraken/driver.html?testName=json-parse-financial) 21:16:42 INFO - PROCESS | 2032 | RSS: Main: 212381696 21:16:42 INFO - PROCESS | 2032 | 21:16:44 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:44 INFO - PROCESS | 2032 | RSS: Main: 192876544 21:16:44 INFO - PROCESS | 2032 | 21:16:46 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:47 INFO - PROCESS | 2032 | RSS: Main: 193515520 21:16:47 INFO - PROCESS | 2032 | 21:16:49 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:49 INFO - PROCESS | 2032 | RSS: Main: 207966208 21:16:49 INFO - PROCESS | 2032 | 21:16:52 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:52 INFO - PROCESS | 2032 | RSS: Main: 218116096 21:16:52 INFO - PROCESS | 2032 | 21:16:55 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:56 INFO - PROCESS | 2032 | RSS: Main: 214528000 21:16:56 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | Cycle 1(1): loaded http://localhost:58564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58564/tests/kraken/driver.html?testName=ai-astar) 21:16:57 INFO - PROCESS | 2032 | RSS: Main: 274366464 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | __start_tp_report 21:16:57 INFO - PROCESS | 2032 | _x_x_mozilla_page_load 21:16:57 INFO - PROCESS | 2032 | _x_x_mozilla_page_load_details 21:16:57 INFO - PROCESS | 2032 | |i|pagename|runs| 21:16:57 INFO - PROCESS | 2032 | |0;ai-astar;111;110;111;111;111;111;105;109;109;109 21:16:57 INFO - PROCESS | 2032 | |1;audio-beat-detection;155;130;153;174;126;159;151;127;172;125 21:16:57 INFO - PROCESS | 2032 | |2;audio-dft;162;162;161;161;163;162;161;161;160;160 21:16:57 INFO - PROCESS | 2032 | |3;audio-fft;76;77;74;182;77;76;78;77;155;74 21:16:57 INFO - PROCESS | 2032 | |4;audio-oscillator;92;91;154;92;92;92;147;92;93;146 21:16:57 INFO - PROCESS | 2032 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;117;117;117 21:16:57 INFO - PROCESS | 2032 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;146;146 21:16:57 INFO - PROCESS | 2032 | |7;imaging-desaturate;94;95;94;95;94;95;95;95;94;95 21:16:57 INFO - PROCESS | 2032 | |8;json-parse-financial;55;53;52;53;53;52;54;76;50;51 21:16:57 INFO - PROCESS | 2032 | |9;json-stringify-tinderbox;57;59;57;58;58;57;57;58;59;57 21:16:57 INFO - PROCESS | 2032 | |10;stanford-crypto-aes;71;74;72;79;72;73;81;74;74;73 21:16:57 INFO - PROCESS | 2032 | |11;stanford-crypto-ccm;116;118;111;112;112;109;120;112;127;128 21:16:57 INFO - PROCESS | 2032 | |12;stanford-crypto-pbkdf2;159;156;186;157;159;158;155;157;157;161 21:16:57 INFO - PROCESS | 2032 | |13;stanford-crypto-sha256-iterative;66;65;67;66;66;67;65;66;67;65 21:16:57 INFO - PROCESS | 2032 | __end_tp_report 21:16:57 INFO - PROCESS | 2032 | __start_cc_report 21:16:57 INFO - PROCESS | 2032 | _x_x_mozilla_cycle_collect,1574 21:16:57 INFO - PROCESS | 2032 | __end_cc_report 21:16:57 INFO - PROCESS | 2032 | __startTimestamp1465532217936__endTimestamp 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | ------- Summary: start ------- 21:16:57 INFO - PROCESS | 2032 | Number of tests: 14 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:1.94 21:16:57 INFO - PROCESS | 2032 | Values: 111.0 110.0 111.0 111.0 111.0 111.0 105.0 109.0 109.0 109.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:154.00 stddev:18.94 (12.3%) stddev-sans-first:19.87 21:16:57 INFO - PROCESS | 2032 | Values: 155.0 130.0 153.0 174.0 126.0 159.0 151.0 127.0 172.0 125.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 21:16:57 INFO - PROCESS | 2032 | Values: 162.0 162.0 161.0 161.0 163.0 162.0 161.0 161.0 160.0 160.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:39.49 (51.6%) stddev-sans-first:41.30 21:16:57 INFO - PROCESS | 2032 | Values: 76.0 77.0 74.0 182.0 77.0 76.0 78.0 77.0 155.0 74.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:27.61 (30.0%) stddev-sans-first:28.59 21:16:57 INFO - PROCESS | 2032 | Values: 92.0 91.0 154.0 92.0 92.0 92.0 147.0 92.0 93.0 146.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:16:57 INFO - PROCESS | 2032 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:16:57 INFO - PROCESS | 2032 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 21:16:57 INFO - PROCESS | 2032 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:53.00 stddev:7.55 (14.2%) stddev-sans-first:8.01 21:16:57 INFO - PROCESS | 2032 | Values: 55.0 53.0 52.0 53.0 53.0 52.0 54.0 76.0 50.0 51.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 21:16:57 INFO - PROCESS | 2032 | Values: 57.0 59.0 57.0 58.0 58.0 57.0 57.0 58.0 59.0 57.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.00 stddev:3.20 (4.3%) stddev-sans-first:3.16 21:16:57 INFO - PROCESS | 2032 | Values: 71.0 74.0 72.0 79.0 72.0 73.0 81.0 74.0 74.0 73.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:117.00 stddev:6.70 (5.7%) stddev-sans-first:7.11 21:16:57 INFO - PROCESS | 2032 | Values: 116.0 118.0 111.0 112.0 112.0 109.0 120.0 112.0 127.0 128.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:158.50 stddev:9.12 (5.8%) stddev-sans-first:9.66 21:16:57 INFO - PROCESS | 2032 | Values: 159.0 156.0 186.0 157.0 159.0 158.0 155.0 157.0 157.0 161.0 21:16:57 INFO - PROCESS | 2032 | 21:16:57 INFO - PROCESS | 2032 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 21:16:57 INFO - PROCESS | 2032 | Values: 66.0 65.0 67.0 66.0 66.0 67.0 65.0 66.0 67.0 65.0 21:16:57 INFO - PROCESS | 2032 | -------- Summary: end -------- 21:16:57 INFO - PROCESS | 2032 | 21:16:58 INFO - TEST-INFO | 2032: exit 0 21:16:58 INFO - TEST-OK | kraken | took 59456ms 21:16:58 INFO - SUITE-END | took 1170s 21:16:59 INFO - Completed test suite (00:19:30) 21:16:59 INFO - javascript benchmark 21:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.917552061198, 3370.7808992415507, 3375.409303371909, 3399.456087026075, 3440.243146507769, 5595.3285605727315, 5618.915716264249, 5621.269234999455, 5638.0415329394, 5673.234113394686, 5595.38450770415, 5638.295213098363, 5643.351014633318, 5654.46282603153, 5685.1756495308155, 5140.383154021504, 5144.279800827887, 5171.120909445384, 5240.554552863011, 5286.207068939651, 5151.4333423323405, 5161.071007218699, 5187.844364669066, 5235.371755389358, 5252.264682944391, 5219.373675158986, 5231.267622532849, 5231.790728370861, 5239.816606418776, 5270.446603106676, 5156.149235376159, 5165.560927321182, 5218.39988401333, 5235.0, 5241.187615919539, 5001.974990125026, 5098.158803797369, 5135.563477104413, 5167.870803229949, 5167.948320516784, 5569.331680198362, 5590.692511911843, 5593.161025846156, 5595.21666966625, 5611.186377975171, 5910.793122240744, 5974.850628734316, 6089.543284253655, 6094.177286066369, 6100.45095941363, 6100.938990610081, 6101.328853826076, 6107.358727333611, 6109.991851344523, 6117.724702388403, 5702.914456283159, 5708.286464191976, 5710.914336284917, 5711.971440142773, 5748.338941021752, 6116.755329786759, 6141.07883817422, 6164.321924588292, 6206.813795586139, 6221.968890155611, 5984.790532331434, 5993.011153159679, 6018.187544681499, 6038.154658347835, 6040.728167232485, 6084.239470066242, 6087.421694938974, 6087.573869829158, 6088.726007329681, 6092.695365231721, 5992.790252341147, 6022.3676513966275, 6023.759049638053, 6029.909551356734, 6093.634381937098, 6022.126791615191, 6044.395560443921, 6055.485283750842, 6062.757489700451, 6079.513638908877, 4599.563041511051, 4604.930926036112, 4607.216773148572, 4610.631149508032, 4635.907281854412, 4046.352583586612, 4092.7953602319767, 4099.938500922489, 4103.5691252418665, 4139.089400331922, 5824.0390335595, 5832.445917637818, 5838.79564215259, 5840.474357307863, 5842.444967728059, 6067.180930574316, 6117.602355846856, 6121.877562448726, 6126.969365153146, 6130.693465326716, 5636.436356364413, 5782.277215348082, 5798.594098413155, 5852.092925596539, 5882.882342353215, 5184.48155184486, 5190.480951904855, 5194.6104042196985, 5200.6619569727845, 5203.973980130151, 6301.464375528039, 6304.558680892385, 6308.905366419507, 6311.463525600284, 6313.873722525524, 5970.492508136857, 5988.999999999913, 6030.246219222598, 6066.211392518944, 6075.362086980804, 6242.375762423721, 6251.593646412968, 6276.811695649138, 6285.560010799383, 6357.396047375492, 5891.558133140117, 6023.969880150747, 6028.668423236764, 6031.396860313934, 6032.668203248688, 6041.18444010053, 6062.242219722535, 6083.756649734138, 6118.357572454828, 6136.601120927304, 5945.732442040032, 5951.315598706031, 5956.195913551615, 5956.37458066914, 5967.76128954837, 5809.215755873072, 5831.679257640871, 5880.558958078076, 5960.4635582797755, 5969.671668058299, 5789.45000224978, 5812.331581868139, 5820.563457740602, 5822.039363504974, 5846.6784326862435, 5900.468957793819, 5932.911006334994, 5937.050071988461, 5938.61399009063, 5943.405659434022, 5770.682612456355, 5787.508061814793, 5817.7963771267805, 5857.50211232033, 5875.764969401176], "value": 5599.790557450573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.42763936834, 673.8854394752892, 693.2235895796708, 740.16361511492, 762.1768490030768, 31576.684233157663, 32462.350752984956, 40371.59628403719, 40475.39286910699, 40564.39153412694, 42276.57723422765, 42602.573974260245, 42721.572784272146, 42853.357199641956, 42962.0, 7950.4037197210155, 8633.740987770378, 8822.602982865787, 8827.867581986244, 8831.690890818823, 8106.392020598479, 10666.679999600025, 10941.83587246192, 10947.56209751609, 10951.726206844813, 10469.057784799366, 10549.525271362769, 10554.366737995706, 10555.155587553016, 10559.26085174038, 10538.947305263462, 10607.946960265226, 10623.734406639818, 10627.202959778047, 10634.255602107856, 10245.180385569136, 10344.94827525865, 10370.533326000348, 10380.377177369382, 10383.688489345257, 43140.56859431428, 43465.130697385874, 43655.78172109151, 43897.561024389666, 43959.0, 4033.193361327746, 4117.958820411817, 4136.6483848872585, 4190.0, 4397.956020439787, 33508.83245583757, 33671.831640841636, 34000.48999265013, 34350.656493434995, 35114.0, 4135.234981528397, 4136.503619565641, 4230.132822771325, 4237.915241695149, 4246.278132717445, 228511.0, 228958.0, 230190.0, 230260.0, 231120.84439577864, 39607.405888911686, 39796.403053954215, 39914.80042599768, 64361.35638643554, 64806.0, 39554.60445395567, 39585.2082958345, 39587.40618890719, 39732.40401393981, 39760.0, 16413.1793410329, 16543.420980265873, 16545.6690866182, 16567.0, 16569.83430165707, 13601.727965440636, 14985.775213371808, 15108.0, 15369.538913832603, 15503.457378991907, 9456.196223321094, 9466.95266523663, 9524.047595240421, 9585.424874507413, 9585.472798996123, 3603.72972027099, 3655.1044993976116, 3750.2499500099543, 3758.1168425420005, 3769.7172712046704, 1067.8024565455416, 1116.843641890136, 1132.3036332655358, 1164.6214980131492, 1217.2331431198288, 33258.0, 33875.0, 33899.0, 34309.31381372359, 35097.47353789695, 1223.7919553675897, 1248.950041998328, 1251.0, 1253.2731016010691, 1323.087069921751, 17501.7374739379, 17912.910435448, 18054.638907222045, 18438.539036523925, 18488.907555462407, 483917.0, 488729.0, 490629.0, 490828.0, 491794.0, 59268.40731592715, 60164.39835601588, 60515.092273615934, 60525.39474605286, 60684.696576516835, 1375.7592421326228, 1460.3282490054694, 1549.055076403393, 1580.123031717408, 1654.123314643241, 31187.688123118478, 32908.67091329056, 33159.33681326408, 33446.0, 33698.32603347969, 61640.691796540734, 63326.0, 63387.0, 63428.36571634225, 63478.68260658667, 462921.0, 473985.0, 474026.0, 474263.0, 474524.0, 40790.79604601958, 49506.75246623744, 50722.2391664118, 51646.48353516417, 52034.739826300625, 48910.75544622254, 49487.752561236965, 49841.0, 49913.0, 50754.492455076455, 40012.0, 40519.59480405158, 40569.59430405658, 41137.38293925653, 45533.0, 44518.0, 45182.54817451915, 45640.771796140805, 45792.54207458016, 46279.0, 44469.11061778811, 44787.0, 45104.548954510035, 45218.32172517481, 45494.77252613716, 39886.0, 40587.797061014506, 40712.59287407206, 41286.0, 41594.37608435936, 32828.0, 35404.46893296654, 35969.64030359663, 36153.096172594844, 36259.27481450409], "value": 20391.644474310244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.79606083271005, 440.56164116703843, 440.77961019490255, 449.2161178743093, 453.8593036158791, 18753.531161720948, 18829.0, 19438.90280548597, 20249.797502024976, 20322.18711251552, 18698.0, 19110.52223694408, 19534.902325488387, 19569.41291761246, 19595.314164004263, 5560.555155587544, 5640.5487560995125, 5793.594448388614, 5797.478226959573, 5801.303843538782, 3903.8243279052367, 5809.2738407699035, 5809.73856176471, 5844.357120716718, 6095.573309868311, 6084.269887613493, 6126.724297406628, 6131.693415329238, 6132.26412830461, 6135.631862088267, 5859.589828711992, 6036.758529658809, 6050.667213303266, 6056.000759874638, 6059.848503787396, 3831.3103641344546, 5673.780137270506, 5831.970840145815, 5898.970505147489, 5915.3788852170765, 14475.493357732428, 14556.344964476624, 14655.047421917649, 14713.632159196106, 22198.11207551696, 2535.150724507292, 2554.1698947842024, 2621.423286876884, 2627.671541057368, 2634.3677517395686, 10088.54601542925, 10775.191860610486, 10789.406582637952, 11184.944075279653, 11263.380514071723, 2010.3667344786345, 2047.5495391014101, 2080.219917530926, 2100.726905502275, 2174.6194415977143, 73364.0, 75870.0, 76186.61906690487, 76229.0, 76738.23261767367, 11717.12121590884, 11868.347240901661, 11934.0, 11948.581799636971, 12002.399880005965, 16892.324307027826, 16996.235169417407, 17046.48860534186, 17049.48851534456, 17049.659006819795, 8619.138086191331, 8658.653653853902, 8803.119688031275, 9012.81974360509, 9181.0818918109, 8797.0, 8804.383693141419, 8843.46939183651, 8907.643694252158, 8915.465072095694, 5103.157978933508, 5110.7955681773055, 5174.793008279702, 5216.1393370094265, 5277.683338999673, 1935.419374187738, 2054.4042227754085, 2082.666773316262, 2123.6708310211943, 2206.8786216757912, 1027.5376080763538, 1074.854894589236, 1086.5273605981424, 1091.7270682329417, 1132.592266783957, 18853.52866178329, 18964.620707586048, 19026.143823527975, 19231.230750769813, 19622.509437263896, 1045.8431235314763, 1086.5870969031716, 1089.199438412766, 1110.245033377311, 1167.1363191238422, 10765.407902565434, 10969.780604387868, 11043.392613406178, 11048.558057677603, 11052.889471105185, 473195.0, 474790.0, 477191.0, 483758.0, 486560.0, 84833.57583212045, 90182.99999999869, 90957.54521227484, 92058.53970730104, 93073.53463232641, 1062.3997441445713, 1092.4646923007829, 1144.6222746493638, 1160.2980196980873, 1164.0745607242263, 17068.743968840725, 17192.742108868126, 17223.0, 17257.827421725622, 17417.738733918748, 37186.814065929495, 37267.62732372642, 37750.43374349442, 38618.84143475588, 39114.2177156461, 55347.16979245234, 55642.72178639081, 55773.721131394086, 56768.0, 57103.42896571147, 8592.957035214784, 8633.602936043393, 8721.781955450911, 8768.649254029768, 9022.233110185707, 9350.485723285012, 12615.747685046432, 13394.866051339362, 13400.664983375493, 13572.0, 11666.358350290477, 12087.818682719942, 12141.453634586289, 12234.143609947574, 12331.506739730668, 11581.82627260575, 11729.237599556001, 11895.702607434883, 11898.940505297418, 11974.0, 12060.638180854588, 12223.449944752685, 12378.257304561756, 12926.095173337777, 12964.870351296366, 9166.0, 9226.9538652309, 9439.056094390506, 9450.574724137292, 9480.436560984812, 9332.533373331442, 11779.528818847493, 11957.282563046245, 12309.44607492683, 12592.622221333375], "value": 9431.485577233281, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.1704685711998, 1596.9840301596985, 1606.9437569685062, 1818.38175020493, 1905.7713074431078, 8225.670973161074, 8325.125861784516, 8343.12397198293, 8345.958270208655, 8358.414910956235, 8274.95862520688, 8520.19058189471, 8545.871811922827, 8559.44363616366, 8569.828603427928, 2376.3821406434363, 2401.471676231235, 2403.230966090852, 2405.9518809623796, 2406.939826504343, 2446.3272600035043, 2448.9387765305833, 2486.403263216824, 2499.52509023285, 2500.9749902501017, 2331.4987277735286, 2337.8714170720605, 2342.449524361782, 2403.351095204294, 2404.026369320428, 2380.1193558383334, 2419.1049311754764, 2435.537247922889, 2437.5368679950843, 2438.9878050609723, 2365.8935347909387, 2433.9634905476432, 2441.4994926040117, 2442.364985103886, 2442.6213936839818, 7489.475736698433, 7879.409044321699, 8819.647214111428, 8854.513001784899, 8867.334949878785, 5334.359876814807, 5429.077056900336, 5464.098423760075, 5480.232767412565, 5487.725613719338, 3497.9125521862156, 3576.052346128252, 3610.0794297454245, 3614.2771445710964, 3625.655562721537, 1220.6582156996055, 1227.9079069069767, 1238.5541205166132, 1253.1979533098825, 1267.9936600317033, 11997.560292764836, 12018.519259229708, 12079.516819327304, 12100.515979360815, 12128.211666241667, 4692.929606055912, 4706.647001474835, 4798.5441383068555, 4812.06164797868, 4819.469858315582, 10348.637797677045, 10369.377837329785, 10369.948150259352, 10373.118284945864, 10417.218708596885, 5545.584081193927, 5547.972260138674, 5549.472800083986, 5554.0, 5555.111182210908, 4921.015796840575, 4940.1601727706375, 4987.60099192071, 4988.551030407209, 4995.900081998412, 4077.8776636700945, 4220.240356735756, 4221.767802770815, 4250.171216612731, 4261.786910654455, 1331.1613683379603, 1368.6920442900466, 1375.6010756880594, 1380.365032085252, 1380.861913808611, 976.0971101731012, 989.4360214677708, 995.9900400996042, 999.6051559633904, 1008.1833714690977, 5881.941180588139, 5893.850699113717, 5913.793017244376, 5917.704114794243, 6057.121717350959, 477.26024661774113, 479.1064664400867, 480.0710624940751, 482.79722516543137, 492.1682356816968, 3900.2199560088097, 3979.3633018716864, 3999.320115580358, 4014.558398576154, 4082.795860206978, 10417.479126043667, 10797.406142662072, 10825.188110891557, 10858.72853178661, 10907.945460272807, 10583.100436462986, 10595.470226488645, 10686.679399617868, 10711.0, 10714.303570267908, 7932.365410767125, 8169.142240064826, 8309.169083091763, 8350.66597336112, 8377.916220837835, 5851.853703657443, 5899.528037757055, 5905.379935106752, 6000.849978750566, 6015.909761353496, 9342.205912497242, 9377.953110234404, 9391.107844754737, 9431.669891554036, 9600.75998100053, 9579.856302155613, 9592.08875156859, 9978.700638980843, 10006.349587276804, 10076.748081298027, 7806.92193078062, 8040.356771458152, 8082.393820463606, 8087.393445491494, 8131.0, 8510.404271700922, 8555.31557475413, 8579.65681372763, 8658.48049117055, 8664.696735614223, 7805.648745806338, 7939.523628582304, 7969.681212751425, 8061.798455038671, 8122.1065682776025, 7273.636318184175, 7341.192468828532, 7740.0, 7742.341900938483, 7888.605569721606, 7424.1462231844025, 7437.702491900263, 7503.88744168827, 7505.136909255287, 7535.773926782205, 4754.50077741846, 5163.845084647466, 5180.7409629519125, 5247.58019358458, 5315.282436870973, 5160.09698302803, 5184.300119483822, 5215.791368345223, 5235.3717553893775, 5261.657992230493], "value": 4631.447805867583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.091853987222, 363.20095789263627, 364.0970393424308, 366.3936185612812, 368.10366756946837, 6310.8106756797315, 6321.652309123008, 6356.07836863655, 6368.3313252108555, 6371.108044873716, 5991.430814072667, 6120.234970628671, 6246.344133865947, 6248.250209974809, 6319.936800631992, 4875.195592727196, 4899.510048995107, 4906.067847109038, 4907.852764417074, 4922.409310882699, 4912.828051018198, 4923.261510773395, 4925.014997000596, 4930.531599498042, 4931.975340123312, 4644.465886423054, 4685.367475390813, 4687.086018226447, 4772.0, 4792.784324705397, 4777.808887644507, 4781.0, 4796.304535842283, 4841.128596852565, 4852.636052296057, 4291.785410729451, 4295.248331541968, 4298.591633794785, 4299.290617048183, 4307.181635489247, 6096.512279017668, 6102.298235702907, 6102.572819902609, 6103.755849766004, 6111.663858487781, 5618.129189975561, 5619.241402410663, 5627.155926611, 5634.323881134249, 5636.774529018834, 6492.285848556655, 6622.569532980389, 6625.536212465129, 6634.137562116942, 6635.900461493082, 4643.117807616576, 4662.0, 4672.415948006499, 4674.158651442739, 4680.461746899082, 6924.376806087476, 6926.58440493572, 6931.133608298963, 6936.826579335507, 6944.4444444444825, 4778.665493415428, 4779.808807647724, 4786.210275304536, 4788.162071637449, 4788.281757736368, 4846.030793841246, 4846.539578740014, 4851.175300198975, 4851.587615052689, 4853.927191092136, 5451.536619387317, 5568.582356323211, 5604.019296623074, 5606.60753747242, 5611.494965453129, 6659.567128136656, 6678.365555272241, 6683.431908287753, 6692.230393504712, 6693.230278517935, 1616.3534586165629, 1718.8195239499923, 1735.9305627774747, 1741.2251548061245, 1741.2599645151013, 1094.7372630568607, 1107.2526044919648, 1112.7607564373698, 1117.899389054989, 1190.3572071081692, 6454.064160696673, 6455.935440645533, 6461.8061458156335, 6470.09418681385, 6472.223333199952, 6849.280825513349, 6851.862962740717, 6855.897161542581, 6859.108315918898, 6862.348076932683, 6458.321876203025, 6459.09572659828, 6464.838379040561, 6466.062420948936, 6473.320301368382, 3622.5471816022996, 3673.779573225615, 3706.1475860552223, 3711.2206436648066, 3712.3317802795755, 7084.539504932266, 7096.787096387116, 7100.289971002859, 7104.964475177591, 7110.146782386147, 6932.341427564374, 6936.722531098801, 6946.5484743492525, 6947.548409353376, 6951.582905025714, 7048.718051277891, 7074.68163932614, 7089.574625522485, 7090.610016449042, 7090.680919358641, 6673.8998915015345, 6826.180858297036, 6827.1807383112355, 6827.658617069226, 6833.0, 6698.330166983263, 6716.5634233774645, 6718.630475323904, 6720.092787473824, 6723.462123030244, 7035.12060992376, 7055.823604409726, 7056.08270924797, 7058.682359293947, 7061.2232654409, 4860.1008813369635, 4864.586510146536, 4867.513248675245, 4869.391326084239, 4869.902601947871, 6795.762148324785, 6804.285550017177, 6805.2854450283985, 6805.979103134569, 6808.148981377328, 6542.182227221598, 6716.798496045127, 6725.865482690221, 6726.6972986216715, 6729.798106056826, 6670.866582668223, 6704.966475167593, 6710.0, 6719.126513553402, 6721.395074443323, 6577.375149360803, 6578.605283682994, 6582.3746744059235, 6584.934150658432, 6589.4728421725185, 6596.8350791230605, 6736.73053077891, 6739.0, 6743.494237932076, 6753.2909044549615, 6579.309172536815, 6615.206175259, 6660.700268488026, 6664.566803157779, 6666.866662666623], "value": 5052.886369577194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.4208866926156, 846.5894041389924, 847.5973912391614, 887.653815012145, 919.5562271353588, 14683.486077987272, 15440.768388474182, 15487.61280967975, 15505.767413488793, 15532.22338883057, 14019.719605607881, 14059.437622495088, 14088.0, 14146.221957792317, 14189.574312770608, 766.2682138557692, 772.7256823827545, 772.9884051739228, 895.6327905558705, 912.9817403651956, 776.1733753552477, 898.0301274623424, 916.3539704508306, 917.0554329041098, 917.3761841947506, 951.4101257220499, 959.4531117263163, 960.6445615122415, 962.2686758063887, 964.2286171063122, 787.5038725602891, 792.6591565626778, 951.5242378810594, 953.2421724728822, 953.9236861051099, 585.2333443189393, 691.9688614012382, 699.9370056694871, 700.4361489001352, 700.6671830880291, 15086.698266034728, 15120.924395377953, 15139.848601514064, 15167.24163791806, 15174.089554626647, 13856.792148117785, 14328.426862925471, 14387.78418323726, 15053.623659408493, 15214.08715477064, 12003.699907502294, 12034.578789742318, 12105.878941210563, 12242.143049986504, 12628.68428289291, 3976.4234186042863, 3982.26328129297, 4016.859409920639, 4040.717149799515, 4097.44684467599, 57654.0, 57717.422825771624, 57852.71073644647, 58006.41993580094, 58467.122993155135, 11699.0, 12007.159498835172, 12178.451969661386, 12223.816642750366, 12417.068719846047, 21617.567648647255, 21627.35117946464, 21685.241016564345, 21748.673769893463, 21776.237831675815, 8760.342974276955, 8811.603477843513, 8993.910060899307, 8998.460092394478, 9140.771480712903, 4997.2254300582745, 5019.387872224649, 5076.187809950464, 5078.7206703631655, 5231.869203269873, 3592.9281414371567, 3604.2070744436182, 3631.055925459347, 3639.1266096137265, 3653.232821107544, 597.0626116996274, 611.3977731934042, 616.0635833533005, 621.2886245249165, 625.5371025441232, 715.727109158324, 822.5434883639638, 829.618375547243, 840.1514470384956, 852.0797538658235, 10073.59705611782, 10408.47957602117, 10440.68677939663, 10608.522616482276, 10696.732581685364, 786.6302837666287, 804.6097642643314, 825.1130035212171, 845.2688424512752, 856.1823458597025, 4644.8374306899095, 4835.371401717754, 4860.083227430124, 4901.0, 5009.649324547319, 63177.0, 66665.33334666688, 67310.3268967304, 67942.3205767936, 67978.0, 57392.0, 58036.0, 58626.82746345049, 60245.397546024855, 60519.39480605138, 51791.741041294554, 51933.22100168501, 52062.0, 53077.0, 53632.46367536275, 9637.18083962871, 9668.613255469703, 9719.56261968199, 9724.367916085432, 9889.703308900744, 38260.426093609174, 38860.6113938857, 38917.02707432337, 39676.0, 39956.80021599874, 47708.284375733696, 50050.249246262065, 50115.74942125266, 50712.23931641102, 50811.49188508068, 12204.32876191818, 12364.258144511357, 12560.937195313965, 12640.873591264337, 12645.74708505843, 14277.214753188258, 14309.427622894967, 14313.499027533986, 14458.421663133357, 14512.274386280855, 13320.800187996994, 13371.465141394236, 13437.395317210945, 13489.258090804708, 13914.0, 13743.862561374659, 14429.350679219251, 14482.855171448573, 14687.118772873662, 14700.0, 13534.59396218115, 13832.723345533233, 13892.374843131882, 14741.705165896836, 14743.705125897637, 11237.168017752445, 11434.48544815502, 11615.941920290683, 11621.0, 11760.35318057515, 11256.662300131009, 11582.0, 11726.413679315829, 11925.880741192477, 11972.281663100242], "value": 7294.938229999635, "unit": "score"}], "name": "dromaeo_css", "value": 7540.846653156181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 105.0, 109.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 153.0, 174.0, 126.0, 159.0, 151.0, 127.0, 172.0, 125.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 163.0, 162.0, 161.0, 161.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 182.0, 77.0, 76.0, 78.0, 77.0, 155.0, 74.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 154.0, 92.0, 92.0, 92.0, 147.0, 92.0, 93.0, 146.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 53.0, 52.0, 54.0, 76.0, 50.0, 51.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 59.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 72.0, 79.0, 72.0, 73.0, 81.0, 74.0, 74.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 111.0, 112.0, 112.0, 109.0, 120.0, 112.0, 127.0, 128.0], "value": 116.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 186.0, 157.0, 159.0, 158.0, 155.0, 157.0, 157.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 66.0, 67.0, 65.0, 66.0, 67.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1508.8, "alertThreshold": 2.0}]} 21:16:59 INFO - Return code: 0 21:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:16:59 ERROR - # TBPL SUCCESS # 21:16:59 INFO - Running post-action listener: _resource_record_post_action 21:16:59 INFO - Running post-run listener: _resource_record_post_run 21:17:00 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 467816448; Read time: 20; Write time: 631572 21:17:00 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 251105280; Read time: 0; Write time: 396812 21:17:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 215953408; Read time: 20; Write time: 234748 21:17:00 INFO - Running post-run listener: _upload_blobber_files 21:17:00 INFO - Blob upload gear active. 21:17:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:17:00 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 21:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:17:00 INFO - (blobuploader) - INFO - Open directory for files ... 21:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:01 INFO - (blobuploader) - INFO - Done attempting. 21:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:02 INFO - (blobuploader) - INFO - Done attempting. 21:17:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:02 INFO - Return code: 0 21:17:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/085ea1deb178d2e0e487aff336c2a987eec27d2e8623732c57ae1b0826d2cab58da2eb27cf070f7584cb283f4ead5f40f18299d331e948977c5ec31ba33f5e08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96cfb403bed3760e62615e0499264a1c06727c51e305b364c67c8999acf3712360c132bd9802c2339edbda78778955ac6e92d3ff2ae087860ac04334561c0ce9"} 21:17:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:02 INFO - Contents: 21:17:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/085ea1deb178d2e0e487aff336c2a987eec27d2e8623732c57ae1b0826d2cab58da2eb27cf070f7584cb283f4ead5f40f18299d331e948977c5ec31ba33f5e08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96cfb403bed3760e62615e0499264a1c06727c51e305b364c67c8999acf3712360c132bd9802c2339edbda78778955ac6e92d3ff2ae087860ac04334561c0ce9"} 21:17:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:02 INFO - Copying logs to upload dir... 21:17:02 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.625891 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-09 21:17:02.012091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 21:17:02.015791) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/085ea1deb178d2e0e487aff336c2a987eec27d2e8623732c57ae1b0826d2cab58da2eb27cf070f7584cb283f4ead5f40f18299d331e948977c5ec31ba33f5e08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96cfb403bed3760e62615e0499264a1c06727c51e305b364c67c8999acf3712360c132bd9802c2339edbda78778955ac6e92d3ff2ae087860ac04334561c0ce9"} build_url:https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/V5kaF8T4RSOZBCQHZi-Y4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/085ea1deb178d2e0e487aff336c2a987eec27d2e8623732c57ae1b0826d2cab58da2eb27cf070f7584cb283f4ead5f40f18299d331e948977c5ec31ba33f5e08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96cfb403bed3760e62615e0499264a1c06727c51e305b364c67c8999acf3712360c132bd9802c2339edbda78778955ac6e92d3ff2ae087860ac04334561c0ce9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 21:17:02.042032) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 21:17:02.042444) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465530981.549122-1605478389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 21:17:02.126522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 21:17:02.126892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 21:17:02.127277) ========= ========= Total master_lag: 0.25 =========