builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1468504274.98 results: success (0) buildid: 20160714035142 builduid: a500e45266444b5e9bd4ccaa96d4c2b7 revision: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:14.978149) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:14.978676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:14.978982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:14.990798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:14.991106) ========= 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=826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:51:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-07-14 06:51:15 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.079863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.080191) ========= 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=826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022476 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.130369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.130734) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc7cc284b0c73491db3f45c165cf7ddb78fdde01 --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 fc7cc284b0c73491db3f45c165cf7ddb78fdde01 --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=826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:51:15,548 truncating revision to first 12 chars 2016-07-14 06:51:15,548 Setting DEBUG logging. 2016-07-14 06:51:15,548 attempt 1/10 2016-07-14 06:51:15,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc7cc284b0c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:51:15,865 unpacking tar archive at: mozilla-beta-fc7cc284b0c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.840796) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.841350) ========= script_repo_revision: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.842003) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.842494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:51:15.853730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-14 06:51:15.854095) ========= /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=826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:16 INFO - MultiFileLogger online at 20160714 06:51:16 in /builds/slave/test 06:51:16 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 06:51:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:51:16 INFO - {'append_to_log': False, 06:51:16 INFO - 'base_work_dir': '/builds/slave/test', 06:51:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:51:16 INFO - 'branch': 'Mozilla-Beta', 06:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:16 INFO - 'config_files': ('talos/linux_config.py',), 06:51:16 INFO - 'default_actions': ('clobber', 06:51:16 INFO - 'read-buildbot-config', 06:51:16 INFO - 'download-and-extract', 06:51:16 INFO - 'populate-webroot', 06:51:16 INFO - 'create-virtualenv', 06:51:16 INFO - 'install', 06:51:16 INFO - 'run-tests'), 06:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:16 INFO - 'download_minidump_stackwalk': True, 06:51:16 INFO - 'download_symbols': 'ondemand', 06:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:16 INFO - 'installer_path': 'installer.exe', 06:51:16 INFO - 'log_level': 'info', 06:51:16 INFO - 'log_name': 'talos', 06:51:16 INFO - 'log_to_console': True, 06:51:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:16 INFO - 'opt_config_files': (), 06:51:16 INFO - 'pip_index': False, 06:51:16 INFO - 'sps_profile': False, 06:51:16 INFO - 'sps_profile_interval': 0, 06:51:16 INFO - 'suite': 'dromaeojs', 06:51:16 INFO - 'system_bits': '32', 06:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:16 INFO - 'title': 'talos-linux64-ix-052', 06:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:16 INFO - 'use_talos_json': True, 06:51:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:16 INFO - 'work_dir': 'build'} 06:51:16 INFO - ##### 06:51:16 INFO - ##### Running clobber step. 06:51:16 INFO - ##### 06:51:16 INFO - Running pre-action listener: _resource_record_pre_action 06:51:16 INFO - Running main action method: clobber 06:51:16 INFO - rmtree: /builds/slave/test/build 06:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:51:17 INFO - Running post-action listener: _resource_record_post_action 06:51:17 INFO - ##### 06:51:17 INFO - ##### Running read-buildbot-config step. 06:51:17 INFO - ##### 06:51:17 INFO - Running pre-action listener: _resource_record_pre_action 06:51:17 INFO - Running main action method: read_buildbot_config 06:51:17 INFO - Using buildbot properties: 06:51:17 INFO - { 06:51:17 INFO - "project": "", 06:51:17 INFO - "product": "firefox", 06:51:17 INFO - "script_repo_revision": "production", 06:51:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:51:17 INFO - "repository": "", 06:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:51:17 INFO - "buildid": "20160714035142", 06:51:17 INFO - "pgo_build": "True", 06:51:17 INFO - "basedir": "/builds/slave/test", 06:51:17 INFO - "buildnumber": 169, 06:51:17 INFO - "slavename": "talos-linux64-ix-052", 06:51:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:17 INFO - "platform": "ubuntu64_hw", 06:51:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:51:17 INFO - "branch": "mozilla-beta", 06:51:17 INFO - "repo_path": "releases/mozilla-beta", 06:51:17 INFO - "revision": "fc7cc284b0c73491db3f45c165cf7ddb78fdde01", 06:51:17 INFO - "stage_platform": "linux64-pgo", 06:51:17 INFO - "builduid": "a500e45266444b5e9bd4ccaa96d4c2b7", 06:51:17 INFO - "slavebuilddir": "test" 06:51:17 INFO - } 06:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:51:17 INFO - Running post-action listener: _resource_record_post_action 06:51:17 INFO - ##### 06:51:17 INFO - ##### Running download-and-extract step. 06:51:17 INFO - ##### 06:51:17 INFO - Running pre-action listener: _resource_record_pre_action 06:51:17 INFO - Running main action method: download_and_extract 06:51:17 INFO - mkdir: /builds/slave/test/build/tests 06:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:17 INFO - https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:18 INFO - Downloaded 1327 bytes. 06:51:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:51:18 INFO - Using the following test package requirements: 06:51:18 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:51:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:18 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:51:18 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'jsshell-linux-x86_64.zip'], 06:51:18 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:18 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:51:18 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:51:18 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:51:18 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:51:18 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:18 INFO - https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:19 INFO - Downloaded 24199460 bytes. 06:51:19 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'] 06:51:19 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 06:51:20 INFO - Return code: 0 06:51:20 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 06:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:20 INFO - https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:21 INFO - Downloaded 24199460 bytes. 06:51:21 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'] 06:51:21 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 06:51:23 INFO - Return code: 0 06:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:23 INFO - https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:24 INFO - Downloaded 10840145 bytes. 06:51:24 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'] 06:51:24 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 06:51:24 INFO - Return code: 0 06:51: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')]} 06:51:24 INFO - https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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 06:51:25 INFO - Downloaded 56038351 bytes. 06:51:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:51:25 INFO - mkdir: /builds/slave/test/properties 06:51:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:25 INFO - Contents: 06:51:25 INFO - build_url:https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:51:26 INFO - Running post-action listener: _resource_record_post_action 06:51:26 INFO - Running post-action listener: set_extra_try_arguments 06:51:26 INFO - ##### 06:51:26 INFO - ##### Running populate-webroot step. 06:51:26 INFO - ##### 06:51:26 INFO - Running pre-action listener: _resource_record_pre_action 06:51:26 INFO - Running main action method: populate_webroot 06:51:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:26 INFO - '--tppagecycles', 06:51:26 INFO - '7'], 06:51:26 INFO - 'tests': ['tsvgm']}}, 06:51:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['damp', 'tps']}, 06:51:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'tests': ['damp', 'tps']}, 06:51:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['dromaeo_dom']}, 06:51:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['a11yr', 06:51:26 INFO - 'ts_paint', 06:51:26 INFO - 'tpaint', 06:51:26 INFO - 'sessionrestore', 06:51:26 INFO - 'sessionrestore_no_auto_restore', 06:51:26 INFO - 'tabpaint']}, 06:51:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:26 INFO - 'ts_paint', 06:51:26 INFO - 'tpaint', 06:51:26 INFO - 'sessionrestore', 06:51:26 INFO - 'sessionrestore_no_auto_restore', 06:51:26 INFO - 'tabpaint']}, 06:51:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:26 INFO - 'ts_paint', 06:51:26 INFO - 'tpaint', 06:51:26 INFO - 'sessionrestore', 06:51:26 INFO - 'sessionrestore_no_auto_restore', 06:51:26 INFO - 'tabpaint']}, 06:51:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:26 INFO - 'ts_paint', 06:51:26 INFO - 'tpaint', 06:51:26 INFO - 'sessionrestore', 06:51:26 INFO - 'sessionrestore_no_auto_restore', 06:51:26 INFO - 'tabpaint']}, 06:51:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['a11yr', 06:51:26 INFO - 'ts_paint', 06:51:26 INFO - 'tpaint', 06:51:26 INFO - 'sessionrestore', 06:51:26 INFO - 'sessionrestore_no_auto_restore', 06:51:26 INFO - 'tabpaint']}, 06:51:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['a11yr', 06:51:26 INFO - 'ts_paint', 06:51:26 INFO - 'tpaint', 06:51:26 INFO - 'sessionrestore', 06:51:26 INFO - 'sessionrestore_no_auto_restore', 06:51:26 INFO - 'tabpaint']}, 06:51:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['tsvgx', 06:51:26 INFO - 'tsvgr_opacity', 06:51:26 INFO - 'tart', 06:51:26 INFO - 'tscrollx', 06:51:26 INFO - 'cart']}, 06:51:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:26 INFO - 'tsvgr_opacity', 06:51:26 INFO - 'tart', 06:51:26 INFO - 'tscrollx', 06:51:26 INFO - 'cart']}, 06:51:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'talos_options': ['--disable-e10s'], 06:51:26 INFO - 'tests': ['tp5o']}, 06:51:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'tests': ['tp5o']}, 06:51:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'talos_options': ['--disable-e10s', 06:51:26 INFO - '--xperf_path', 06:51:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:26 INFO - 'tests': ['tp5n']}, 06:51:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:26 INFO - 'talos_options': ['--xperf_path', 06:51:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:26 INFO - 'tests': ['tp5n']}}, 06:51:26 INFO - 'talos.zip': {'path': '', 06:51:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:26 INFO - Running post-action listener: _resource_record_post_action 06:51:26 INFO - ##### 06:51:26 INFO - ##### Running create-virtualenv step. 06:51:26 INFO - ##### 06:51:26 INFO - Running pre-action listener: _resource_record_pre_action 06:51:26 INFO - Running main action method: create_virtualenv 06:51:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:51:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:26 INFO - Using real prefix '/usr' 06:51:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:29 INFO - Installing pip.................done. 06:51:29 INFO - Return code: 0 06:51:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:29 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:51:29 INFO - Using env: {'DISPLAY': ':0', 06:51:29 INFO - 'HOME': '/home/cltbld', 06:51:29 INFO - 'LANG': 'en_US.UTF-8', 06:51:29 INFO - 'LANGUAGE': 'en_US:en', 06:51:29 INFO - 'LOGNAME': 'cltbld', 06:51:29 INFO - 'MAIL': '/var/mail/cltbld', 06:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:29 INFO - 'MOZ_NO_REMOTE': '1', 06:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:29 INFO - 'NO_EM_RESTART': '1', 06:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:29 INFO - 'PWD': '/builds/slave/test', 06:51:29 INFO - 'SHELL': '/bin/bash', 06:51:29 INFO - 'SHLVL': '1', 06:51:29 INFO - 'TERM': 'linux', 06:51:29 INFO - 'TMOUT': '86400', 06:51:29 INFO - 'USER': 'cltbld', 06:51:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:29 INFO - '_': '/tools/buildbot/bin/python'} 06:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:51:29 INFO - Cleaning up... 06:51:29 INFO - Return code: 0 06:51:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:29 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:51:29 INFO - Using env: {'DISPLAY': ':0', 06:51:29 INFO - 'HOME': '/home/cltbld', 06:51:29 INFO - 'LANG': 'en_US.UTF-8', 06:51:29 INFO - 'LANGUAGE': 'en_US:en', 06:51:29 INFO - 'LOGNAME': 'cltbld', 06:51:29 INFO - 'MAIL': '/var/mail/cltbld', 06:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:29 INFO - 'MOZ_NO_REMOTE': '1', 06:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:29 INFO - 'NO_EM_RESTART': '1', 06:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:29 INFO - 'PWD': '/builds/slave/test', 06:51:29 INFO - 'SHELL': '/bin/bash', 06:51:29 INFO - 'SHLVL': '1', 06:51:29 INFO - 'TERM': 'linux', 06:51:29 INFO - 'TMOUT': '86400', 06:51:29 INFO - 'USER': 'cltbld', 06:51:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:29 INFO - '_': '/tools/buildbot/bin/python'} 06:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:29 INFO - Downloading/unpacking psutil>=0.7.1 06:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:31 INFO - Installing collected packages: psutil 06:51:31 INFO - Running setup.py install for psutil 06:51:31 INFO - building 'psutil._psutil_linux' extension 06:51:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:51:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:51:31 INFO - building 'psutil._psutil_posix' extension 06:51:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:51:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:32 INFO - Successfully installed psutil 06:51:32 INFO - Cleaning up... 06:51:32 INFO - Return code: 0 06:51:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:32 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:51:32 INFO - Using env: {'DISPLAY': ':0', 06:51:32 INFO - 'HOME': '/home/cltbld', 06:51:32 INFO - 'LANG': 'en_US.UTF-8', 06:51:32 INFO - 'LANGUAGE': 'en_US:en', 06:51:32 INFO - 'LOGNAME': 'cltbld', 06:51:32 INFO - 'MAIL': '/var/mail/cltbld', 06:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:32 INFO - 'MOZ_NO_REMOTE': '1', 06:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:32 INFO - 'NO_EM_RESTART': '1', 06:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:32 INFO - 'PWD': '/builds/slave/test', 06:51:32 INFO - 'SHELL': '/bin/bash', 06:51:32 INFO - 'SHLVL': '1', 06:51:32 INFO - 'TERM': 'linux', 06:51:32 INFO - 'TMOUT': '86400', 06:51:32 INFO - 'USER': 'cltbld', 06:51:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:32 INFO - '_': '/tools/buildbot/bin/python'} 06:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:34 INFO - Installing collected packages: mozsystemmonitor 06:51:34 INFO - Running setup.py install for mozsystemmonitor 06:51:34 INFO - Successfully installed mozsystemmonitor 06:51:34 INFO - Cleaning up... 06:51:34 INFO - Return code: 0 06:51:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:34 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:51:34 INFO - Using env: {'DISPLAY': ':0', 06:51:34 INFO - 'HOME': '/home/cltbld', 06:51:34 INFO - 'LANG': 'en_US.UTF-8', 06:51:34 INFO - 'LANGUAGE': 'en_US:en', 06:51:34 INFO - 'LOGNAME': 'cltbld', 06:51:34 INFO - 'MAIL': '/var/mail/cltbld', 06:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:34 INFO - 'MOZ_NO_REMOTE': '1', 06:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:34 INFO - 'NO_EM_RESTART': '1', 06:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:34 INFO - 'PWD': '/builds/slave/test', 06:51:34 INFO - 'SHELL': '/bin/bash', 06:51:34 INFO - 'SHLVL': '1', 06:51:34 INFO - 'TERM': 'linux', 06:51:34 INFO - 'TMOUT': '86400', 06:51:34 INFO - 'USER': 'cltbld', 06:51:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:34 INFO - '_': '/tools/buildbot/bin/python'} 06:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:37 INFO - Downloading docopt-0.6.1.tar.gz 06:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:37 INFO - Running setup.py install for blobuploader 06:51:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:37 INFO - Running setup.py install for requests 06:51:37 INFO - Running setup.py install for docopt 06:51:37 INFO - Successfully installed blobuploader requests docopt 06:51:37 INFO - Cleaning up... 06:51:37 INFO - Return code: 0 06:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:37 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:37 INFO - Using env: {'DISPLAY': ':0', 06:51:37 INFO - 'HOME': '/home/cltbld', 06:51:37 INFO - 'LANG': 'en_US.UTF-8', 06:51:37 INFO - 'LANGUAGE': 'en_US:en', 06:51:37 INFO - 'LOGNAME': 'cltbld', 06:51:37 INFO - 'MAIL': '/var/mail/cltbld', 06:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:37 INFO - 'MOZ_NO_REMOTE': '1', 06:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:37 INFO - 'NO_EM_RESTART': '1', 06:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:37 INFO - 'PWD': '/builds/slave/test', 06:51:37 INFO - 'SHELL': '/bin/bash', 06:51:37 INFO - 'SHLVL': '1', 06:51:37 INFO - 'TERM': 'linux', 06:51:37 INFO - 'TMOUT': '86400', 06:51:37 INFO - 'USER': 'cltbld', 06:51:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:37 INFO - '_': '/tools/buildbot/bin/python'} 06:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:38 INFO - Running setup.py (path:/tmp/pip-3RIvbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:38 INFO - Running setup.py (path:/tmp/pip-Q_MQLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:38 INFO - Running setup.py (path:/tmp/pip-gwD4qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:38 INFO - Running setup.py (path:/tmp/pip-V77maI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:38 INFO - Running setup.py (path:/tmp/pip-fAuSAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:38 INFO - Running setup.py (path:/tmp/pip-Jur1YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:38 INFO - Running setup.py (path:/tmp/pip-ub2XcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:38 INFO - Running setup.py (path:/tmp/pip-a5ITPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:38 INFO - Running setup.py (path:/tmp/pip-vlwpEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:38 INFO - Running setup.py (path:/tmp/pip-ZOBfB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:38 INFO - Running setup.py (path:/tmp/pip-Yvt9KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:38 INFO - Running setup.py (path:/tmp/pip-rPoN23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:38 INFO - Running setup.py (path:/tmp/pip-TJzG1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:39 INFO - Running setup.py (path:/tmp/pip-st5NKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:39 INFO - Running setup.py (path:/tmp/pip-d0UPpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:39 INFO - Running setup.py (path:/tmp/pip-2lo4jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:39 INFO - Running setup.py (path:/tmp/pip-asW5Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:39 INFO - Running setup.py install for manifestparser 06:51:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:39 INFO - Running setup.py install for mozcrash 06:51:39 INFO - Running setup.py install for mozdebug 06:51:39 INFO - Running setup.py install for mozdevice 06:51:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:51:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:39 INFO - Running setup.py install for mozfile 06:51:39 INFO - Running setup.py install for mozhttpd 06:51:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:39 INFO - Running setup.py install for mozinfo 06:51:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Running setup.py install for mozInstall 06:51:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Running setup.py install for mozleak 06:51:40 INFO - Running setup.py install for mozlog 06:51:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Running setup.py install for moznetwork 06:51:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Running setup.py install for mozprocess 06:51:40 INFO - Running setup.py install for mozprofile 06:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Running setup.py install for mozrunner 06:51:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:40 INFO - Running setup.py install for mozscreenshot 06:51:40 INFO - Running setup.py install for moztest 06:51:40 INFO - Running setup.py install for mozversion 06:51:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:41 INFO - Cleaning up... 06:51:41 INFO - Return code: 0 06:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:41 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:41 INFO - Using env: {'DISPLAY': ':0', 06:51:41 INFO - 'HOME': '/home/cltbld', 06:51:41 INFO - 'LANG': 'en_US.UTF-8', 06:51:41 INFO - 'LANGUAGE': 'en_US:en', 06:51:41 INFO - 'LOGNAME': 'cltbld', 06:51:41 INFO - 'MAIL': '/var/mail/cltbld', 06:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:41 INFO - 'MOZ_NO_REMOTE': '1', 06:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:41 INFO - 'NO_EM_RESTART': '1', 06:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:41 INFO - 'PWD': '/builds/slave/test', 06:51:41 INFO - 'SHELL': '/bin/bash', 06:51:41 INFO - 'SHLVL': '1', 06:51:41 INFO - 'TERM': 'linux', 06:51:41 INFO - 'TMOUT': '86400', 06:51:41 INFO - 'USER': 'cltbld', 06:51:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:41 INFO - '_': '/tools/buildbot/bin/python'} 06:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:41 INFO - Running setup.py (path:/tmp/pip-55YO37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:41 INFO - Running setup.py (path:/tmp/pip-kwaXd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:41 INFO - Running setup.py (path:/tmp/pip-kyRx05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:41 INFO - Running setup.py (path:/tmp/pip-0c7ABI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:41 INFO - Running setup.py (path:/tmp/pip-LHmj9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:41 INFO - Running setup.py (path:/tmp/pip-ZvygyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:41 INFO - Running setup.py (path:/tmp/pip-tZvcgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:41 INFO - Running setup.py (path:/tmp/pip-ZT9dSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:41 INFO - Running setup.py (path:/tmp/pip-9w8nD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:41 INFO - Running setup.py (path:/tmp/pip-NQ9DYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:42 INFO - Running setup.py (path:/tmp/pip-0fzOr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:42 INFO - Running setup.py (path:/tmp/pip-4eR3Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:42 INFO - Running setup.py (path:/tmp/pip-AVnuRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:42 INFO - Running setup.py (path:/tmp/pip-DIOgVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:42 INFO - Running setup.py (path:/tmp/pip-kQNLWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:42 INFO - Running setup.py (path:/tmp/pip-gCW9RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:42 INFO - Running setup.py (path:/tmp/pip-oxhFQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:44 INFO - Downloading blessings-1.6.tar.gz 06:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:44 INFO - Installing collected packages: blessings 06:51:44 INFO - Running setup.py install for blessings 06:51:44 INFO - Successfully installed blessings 06:51:44 INFO - Cleaning up... 06:51:44 INFO - Return code: 0 06:51:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:44 INFO - Reading from file tmpfile_stdout 06:51:44 INFO - Current package versions: 06:51:44 INFO - argparse == 1.2.1 06:51:44 INFO - blessings == 1.6 06:51:44 INFO - blobuploader == 1.2.4 06:51:44 INFO - docopt == 0.6.1 06:51:44 INFO - manifestparser == 1.1 06:51:44 INFO - mozInstall == 1.12 06:51:44 INFO - mozcrash == 0.17 06:51:44 INFO - mozdebug == 0.1 06:51:44 INFO - mozdevice == 0.48 06:51:44 INFO - mozfile == 1.2 06:51:44 INFO - mozhttpd == 0.7 06:51:44 INFO - mozinfo == 0.9 06:51:44 INFO - mozleak == 0.1 06:51:44 INFO - mozlog == 3.1 06:51:44 INFO - moznetwork == 0.27 06:51:44 INFO - mozprocess == 0.22 06:51:44 INFO - mozprofile == 0.28 06:51:44 INFO - mozrunner == 6.11 06:51:44 INFO - mozscreenshot == 0.1 06:51:44 INFO - mozsystemmonitor == 0.0 06:51:44 INFO - moztest == 0.7 06:51:44 INFO - mozversion == 1.4 06:51:44 INFO - psutil == 3.1.1 06:51:44 INFO - requests == 1.2.3 06:51:44 INFO - wsgiref == 0.1.2 06:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:44 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:44 INFO - Using env: {'DISPLAY': ':0', 06:51:44 INFO - 'HOME': '/home/cltbld', 06:51:44 INFO - 'LANG': 'en_US.UTF-8', 06:51:44 INFO - 'LANGUAGE': 'en_US:en', 06:51:44 INFO - 'LOGNAME': 'cltbld', 06:51:44 INFO - 'MAIL': '/var/mail/cltbld', 06:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:44 INFO - 'MOZ_NO_REMOTE': '1', 06:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:44 INFO - 'NO_EM_RESTART': '1', 06:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:44 INFO - 'PWD': '/builds/slave/test', 06:51:44 INFO - 'SHELL': '/bin/bash', 06:51:44 INFO - 'SHLVL': '1', 06:51:44 INFO - 'TERM': 'linux', 06:51:44 INFO - 'TMOUT': '86400', 06:51:44 INFO - 'USER': 'cltbld', 06:51:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:44 INFO - '_': '/tools/buildbot/bin/python'} 06:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:51:45 INFO - Cleaning up... 06:51:45 INFO - Return code: 0 06:51:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:45 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 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:51:45 INFO - Using env: {'DISPLAY': ':0', 06:51:45 INFO - 'HOME': '/home/cltbld', 06:51:45 INFO - 'LANG': 'en_US.UTF-8', 06:51:45 INFO - 'LANGUAGE': 'en_US:en', 06:51:45 INFO - 'LOGNAME': 'cltbld', 06:51:45 INFO - 'MAIL': '/var/mail/cltbld', 06:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:45 INFO - 'MOZ_NO_REMOTE': '1', 06:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:45 INFO - 'NO_EM_RESTART': '1', 06:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:45 INFO - 'PWD': '/builds/slave/test', 06:51:45 INFO - 'SHELL': '/bin/bash', 06:51:45 INFO - 'SHLVL': '1', 06:51:45 INFO - 'TERM': 'linux', 06:51:45 INFO - 'TMOUT': '86400', 06:51:45 INFO - 'USER': 'cltbld', 06:51:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:45 INFO - '_': '/tools/buildbot/bin/python'} 06:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:45 INFO - Downloading/unpacking jsonschema 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:47 INFO - Downloading/unpacking functools32 (from jsonschema) 06:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:47 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:47 INFO - warning: no files found matching '*.txt' 06:51:47 INFO - no previously-included directories found matching 'build' 06:51:47 INFO - no previously-included directories found matching 'dist' 06:51:47 INFO - no previously-included directories found matching '.git*' 06:51:47 INFO - Installing collected packages: jsonschema, functools32 06:51:47 INFO - Running setup.py install for functools32 06:51:47 INFO - warning: no files found matching '*.txt' 06:51:47 INFO - no previously-included directories found matching 'build' 06:51:47 INFO - no previously-included directories found matching 'dist' 06:51:47 INFO - no previously-included directories found matching '.git*' 06:51:47 INFO - Successfully installed jsonschema functools32 06:51:47 INFO - Cleaning up... 06:51:47 INFO - Return code: 0 06:51:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa96a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:51:47 INFO - Using env: {'DISPLAY': ':0', 06:51:47 INFO - 'HOME': '/home/cltbld', 06:51:47 INFO - 'LANG': 'en_US.UTF-8', 06:51:47 INFO - 'LANGUAGE': 'en_US:en', 06:51:47 INFO - 'LOGNAME': 'cltbld', 06:51:47 INFO - 'MAIL': '/var/mail/cltbld', 06:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:47 INFO - 'MOZ_NO_REMOTE': '1', 06:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:47 INFO - 'NO_EM_RESTART': '1', 06:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:47 INFO - 'PWD': '/builds/slave/test', 06:51:47 INFO - 'SHELL': '/bin/bash', 06:51:47 INFO - 'SHLVL': '1', 06:51:47 INFO - 'TERM': 'linux', 06:51:47 INFO - 'TMOUT': '86400', 06:51:47 INFO - 'USER': 'cltbld', 06:51:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:47 INFO - '_': '/tools/buildbot/bin/python'} 06:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:48 INFO - Downloading/unpacking flake8 06:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:51:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:51:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:50 INFO - no previously-included directories found matching 'docs/_build' 06:51:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:51:50 INFO - Running setup.py install for pep8 06:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:50 INFO - no previously-included directories found matching 'docs/_build' 06:51:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:51:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:51:50 INFO - Cleaning up... 06:51:51 INFO - Return code: 0 06:51:51 INFO - Running post-action listener: _resource_record_post_action 06:51:51 INFO - Running post-action listener: _start_resource_monitoring 06:51:51 INFO - Starting resource monitoring. 06:51:51 INFO - ##### 06:51:51 INFO - ##### Running install step. 06:51:51 INFO - ##### 06:51:51 INFO - Running pre-action listener: _resource_record_pre_action 06:51:51 INFO - Running main action method: install 06:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:51 INFO - Reading from file tmpfile_stdout 06:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:51 INFO - Reading from file tmpfile_stdout 06:51:51 INFO - Output received: 06:51:51 INFO - Usage: mozinstall [options] installer 06:51:51 INFO - Options: 06:51:51 INFO - -h, --help show this help message and exit 06:51:51 INFO - -d DEST, --destination=DEST 06:51:51 INFO - Directory to install application into. [default: 06:51:51 INFO - "/builds/slave/test"] 06:51:51 INFO - --app=APP Application being installed. [default: firefox] 06:51:51 INFO - mkdir: /builds/slave/test/build/application 06:51:51 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'] 06:51:51 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 06:52:04 INFO - Reading from file tmpfile_stdout 06:52:04 INFO - Output received: 06:52:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:52:04 INFO - Running post-action listener: _resource_record_post_action 06:52:04 INFO - ##### 06:52:04 INFO - ##### Running run-tests step. 06:52:04 INFO - ##### 06:52:04 INFO - Running pre-action listener: _resource_record_pre_action 06:52:04 INFO - Running main action method: run_tests 06:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:52:04 INFO - Python 2.7.3 06:52:04 INFO - Return code: 0 06:52:04 INFO - grabbing minidump binary from tooltool 06:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:04 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 0x294c410>, '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 0x294d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:52:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:52:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:52:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:04 INFO - Return code: 0 06:52:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:52:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:52:05 INFO - Return code: 0 06:52:05 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/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:52:05 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/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:52:05 INFO - Using env: {'DISPLAY': ':0', 06:52:05 INFO - 'HOME': '/home/cltbld', 06:52:05 INFO - 'LANG': 'en_US.UTF-8', 06:52:05 INFO - 'LANGUAGE': 'en_US:en', 06:52:05 INFO - 'LOGNAME': 'cltbld', 06:52:05 INFO - 'MAIL': '/var/mail/cltbld', 06:52:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:52:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:05 INFO - 'MOZ_NO_REMOTE': '1', 06:52:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:05 INFO - 'NO_EM_RESTART': '1', 06:52:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:05 INFO - 'PWD': '/builds/slave/test', 06:52:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:52:05 INFO - 'SHELL': '/bin/bash', 06:52:05 INFO - 'SHLVL': '1', 06:52:05 INFO - 'TERM': 'linux', 06:52:05 INFO - 'TMOUT': '86400', 06:52:05 INFO - 'USER': 'cltbld', 06:52:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729', 06:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:05 INFO - '_': '/tools/buildbot/bin/python'} 06:52:05 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/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:52:05 INFO - mozversion application_buildid: 20160714035142 06:52:05 INFO - mozversion application_changeset: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 06:52:05 INFO - mozversion application_display_name: Firefox 06:52:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:05 INFO - mozversion application_name: Firefox 06:52:05 INFO - mozversion application_remotingname: firefox 06:52:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:52:05 INFO - mozversion application_vendor: Mozilla 06:52:05 INFO - mozversion application_version: 48.0 06:52:05 INFO - mozversion platform_buildid: 20160714035142 06:52:05 INFO - mozversion platform_changeset: fc7cc284b0c73491db3f45c165cf7ddb78fdde01 06:52:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:52:05 INFO - mozversion platform_version: 48.0 06:52:05 INFO - using testdate: 1468504325 06:52:05 INFO - actual date: 1468504325 06:52:05 INFO - starting webserver on 'localhost:44748' 06:52:05 INFO - SUITE-START | Running 2 tests 06:52:05 INFO - TEST-START | dromaeo_css 06:52:05 INFO - operating with platform_type : linux_ 06:52:05 INFO - Initialising browser for dromaeo_css test... 06:52:05 INFO - TEST-INFO | started process 28838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ADgjy/profile http://localhost:44748/getInfo.html) 06:52:09 INFO - PROCESS | 28838 | __metrics Screen width/height:1600/1200 06:52:09 INFO - PROCESS | 28838 | colorDepth:24 06:52:09 INFO - PROCESS | 28838 | Browser inner width/height: 1024/697 06:52:09 INFO - PROCESS | 28838 | __metrics 06:52:10 ERROR - PROCESS | 28838 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:52:10 INFO - TEST-INFO | 28838: exit 0 06:52:10 INFO - Browser initialized. 06:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:10 INFO - TEST-INFO | started process 28929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ADgjy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:22 INFO - PROCESS | 28929 | RSS: Main: 139661312 06:52:22 INFO - PROCESS | 28929 | 06:53:13 INFO - PROCESS | 28929 | 1468504393506 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:55:20 INFO - PROCESS | 28929 | Cycle 1(1): loaded http://localhost:44748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44748/tests/dromaeo/cssquery-ext.html) 06:55:21 INFO - PROCESS | 28929 | RSS: Main: 245907456 06:55:21 INFO - PROCESS | 28929 | 06:58:24 INFO - PROCESS | 28929 | Cycle 1(1): loaded http://localhost:44748/tests/dromaeo/cssquery-ext.html (next: http://localhost:44748/tests/dromaeo/cssquery-jquery.html) 06:58:24 INFO - PROCESS | 28929 | RSS: Main: 220614656 06:58:24 INFO - PROCESS | 28929 | 07:01:26 INFO - PROCESS | 28929 | Cycle 1(1): loaded http://localhost:44748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44748/tests/dromaeo/cssquery-mootools.html) 07:01:27 INFO - PROCESS | 28929 | RSS: Main: 214806528 07:01:27 INFO - PROCESS | 28929 | 07:04:28 INFO - PROCESS | 28929 | Cycle 1(1): loaded http://localhost:44748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44748/tests/dromaeo/cssquery-prototype.html) 07:04:29 INFO - PROCESS | 28929 | RSS: Main: 215695360 07:04:29 INFO - PROCESS | 28929 | 07:07:31 INFO - PROCESS | 28929 | Cycle 1(1): loaded http://localhost:44748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44748/tests/dromaeo/cssquery-yui.html) 07:07:32 INFO - PROCESS | 28929 | RSS: Main: 210972672 07:07:32 INFO - PROCESS | 28929 | 07:10:34 INFO - PROCESS | 28929 | Cycle 1(1): loaded http://localhost:44748/tests/dromaeo/cssquery-yui.html (next: http://localhost:44748/tests/dromaeo/cssquery-dojo.html) 07:10:35 INFO - PROCESS | 28929 | RSS: Main: 251666432 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | __start_tp_report 07:10:35 INFO - PROCESS | 28929 | _x_x_mozilla_page_load 07:10:35 INFO - PROCESS | 28929 | _x_x_mozilla_page_load_details 07:10:35 INFO - PROCESS | 28929 | |i|pagename|runs| 07:10:35 INFO - PROCESS | 28929 | |0;dojo.html;3214.7428205743545;3310.238645111625;3323.185819474229;3353.7820041697305;3370.2922386298874;5354.946450535494;5359.946400535993;5369.355677318717;5381.19282107684;5382.569394448445;5367.2485851980755;5369.087255166622;5376.8118115865855;5387.568994480442;5388.622796404254;4817.108834865544;4844.152273352167;4929.654924155293;4975.776090075937;4997.750112494361;4712.929306060395;4750.3349531065505;4767.952320476803;4791.832285869995;4795.712257264558;4808.879778005543;4861.392325959255;4942.135126352892;4972.676776009548;4978.352814134158;4919.754012299389;4957;4964.925526117111;4974.328465657162;4997.4003119625695;4775.450823155347;4785.114753770529;4856.781444834955;4871.4397844248015;4922.0402021605805;5235.188545775372;5293.179557168645;5309.548688361494;5324.866878328034;5330.493603107699;5721.742521586497;5820.272465941757;5824.592278540504;5832.533397328203;5835.153902684129;5813.6802475863815;5833.300003999547;5867.589268751189;5890.234269544974;5906.468417842415;5437.075697131497;5442.809501667422;5480.150576660624;5481.9036192761205;5486.231927530109;5496.422875598085;5882.3529411764675;5910.024845900378;5912.260967379078;5917.970410147922;5659.207710920475;5696.8006119785605;5714.971425142848;5736.627119237236;5747.913781293284;5803.767849286066;5804.970975145182;5810.709464526757;5820.097884827858;5821.505172060338;5479.75341109651;5649.745761440663;5774.624649397776;5780.942190578125;5795.362510123883;5746.712664366765;5781.942180578225;5785.797497087666;5791.652500849962;5821.476067153892;4453.1761624099645;4486.753228572395;4488.775561221926;4496.7077139985795;4528.660350473728;3951.6048395160255;3961.742486738353;4013.7591744495426;4027.617376349242;4073.348264277701;5485.698286594195;5506.339239291311;5513.3108361454815;5515.586331025109;5534.280543529316;5712.800051998243;5716.571257155647;5719.885602287931;5719.971400143056;5728.541716662657;5432.239486471897;5505.559555235652;5580.469855363734;5670.829875103754;5677.09166533361;4977.402711674622;4978.502149784992;4984.975075124601;4989.750512474362;4991.4758950310425;6082.847928801815;6136.355682653347;6139.10982907476;6140.662263575547;6142.232220972379;5591.8881622368135;5662.66024038559;5687.687177205128;5703.914441283467;5877.823665290048;5856.0630299151935;5889.116632505158;5899.528037756883;5899.970500147643;5925.585209035326;5519.31008623922;5522.22688823557;5525.392206857323;5527.391986881359;5558.02734521449;5671.461211184931;5816.360200377871;5859.677717725395;5881.088431293157;5892;5432.293801805898;5451.890962180813;5452.7546260417585;5469.124940009579;5479.4520547944885;5383.7846486140115;5447.319085114361;5466.1254199329505;5483.095289277225;5496.917546236729;5566.860828479321;5620.803271885465;5623.522000629992;5647.85880352978;5655.85860353478;5480.725963701879;5535.529479994085;5537.086380747131;5547.084731019498;5554.777808887599;5241.6068794839775;5302.946970530245;5419.241306217212;5428.185772134211;5463.836084917459 07:10:35 INFO - PROCESS | 28929 | |1;ext.html;663.9410140825382;671.2850813883214;674.0563211503897;683.4122654517116;737.8118579762156;32165.51751723723;32438.513422298656;40297.597024029754;40599.59400405995;40659.390109148386;42384;42848.57151428485;42858.57141428585;42904.141917161636;43057;7821.726239581616;8687.218150366481;8972.327075469366;8978.281737460988;10362.171026317914;10397;10525.052745252926;10539.051485366315;10539.578416863316;10540.051395374414;10509.6321628743;10579.471026448686;10586.682399527988;10591.523381447814;10596.31123976939;10429.061384475395;10478.056974872221;10484.58061677532;10489.318194317346;10489.475526223734;10500.737481562946;10922.836157457645;10949.288296260796;10952.671419857417;10961.232713710044;43085.56914430847;43306;43526;43575;43695.34456983116;3717.962820371789;3784.9621503784883;3908;4015.036391266104;4102.077032667656;33856;33865.83067084649;33914.49128263078;34087.488687669706;34262.82868585666;4440.978574927784;4476.709013914117;4480.171168333869;4509.774511274423;4515.977420112911;352691;355159;355495;355983;356113;61343;61851.38148618546;61864.69067654723;61876.38123618706;61902.69048654728;65899;68844.31155688479;69697;69917.3008269921;69951.30048699549;17611.38360157388;17671.204795783964;17742.112894355232;17804.55488612769;17813.821861781475;14539.563813085624;14891.47879824201;14897.329620167118;14912.925435372754;14942;19515.045573729556;20566.280180193622;20658.483537911372;20693.89653051725;20708.689369659467;7544.924550754532;7598.924010759933;7615;7638.312551870358;7638.8090297743;1040.6201736366172;1161.7734541764275;1191.92252503587;1219.5426714981882;1225.105672858818;33005.66994330026;33029.66970330314;33692.326153476795;33899.830500847835;34018.659813402046;1184.2006645514243;1185.8458400407892;1195.8325834383193;1226.515526367098;1285.3059347952187;17419.216135273942;17460.388886388915;17628.823711762976;17704.557386065193;17873.553161171076;489665;493869;495872;496073;496282;62123.37876621266;62532.37467625357;62594.37405625886;62703.68648156821;62726.37273627205;1347.710242297891;1425.6507155746701;1501.3018946189857;1510.4411367793766;1525.1078119300334;29824.552631710107;32041.519377208893;32398.676013240507;32707.672923270464;33206.501902471;50871.491285086675;51121.48878511167;51216;51281.743591283295;51338.48661513337;299134;302761;303560;303599;303828;25994;29729.554056689598;29923.10230693083;29927.251818704706;30280.091597252118;42833.78583107064;44919.32621010622;46291;48612.5138748608;49576.752116239186;40237.1952560953;40732.322601592816;41464;41773;42076.36885446659;39762.60237397589;40465.1906961865;40729.1854162921;41479.58520414878;41564.58435415607;41064.384034238916;41295.58704412918;41569.79215104026;42009.1598168041;42275.7886210567;34978.30043399169;36467.45298820467;36602;36781.63218367782;37335.43996839995;27584.862075689492;27852.72147278501;27967.300817479725;27969.580456292766;28272.575911360935 07:10:35 INFO - PROCESS | 28929 | |2;jquery.html;436.1125110400336;441.9513853476118;449.301336421864;449.3125517957526;450.4953455458767;18550.257989680413;18767.906160469196;19113.904430477847;19357.128929198185;19803.306884259055;17173.398931037416;17424.128793560336;18366.35717749879;18574.25702971883;18576.442706718786;5604.075327570946;5828.650280983144;5857.941420585782;5865.853353666171;5982.282126144847;3930.3711406175016;5504.587155963299;5790.507806836403;5819.53443724501;5855.736491857877;5829.8251052468495;5832.9708351458185;5839.766409343642;5845.240118784552;5846.64920104793;5801.7389217485315;5827.621204621707;6398.616083035033;6564.048213009087;6579.144711187563;3866.845326186977;5508.669479831223;5724.627899186539;5918.40815918409;5939.346671866091;13174.934125329408;13281.535146269931;13314.800277995837;13412.597622071353;18227.817721822878;2213.225371120111;2331.2423462374627;2355.281639100074;2690.6233127362184;3117.1427857339186;9877.40735555869;10167.44079075658;10272.589096436133;10476.842847357295;12863.742725145537;1995.1420889017716;2014.74815648044;2073.2432662078386;2143.7856214378594;2156.611809874222;73191.63404182998;76782.23217767863;77533.61233193854;79093;79974.60012699958;11598.898104680042;11600.361980091007;11646.126540509496;11735.88264117365;11789.351585662871;16333.591660208589;16486.917565412336;16541.917290413712;16554.255058522394;16599;8493.150684931581;8588.48469091844;8594.5702714864;8724.91275087241;8815.074417186232;8294.917050829414;8328.125546817619;8591.48451092924;8698;8718.60766265507;5050.545450909362;5144.948550514447;5152.227165925141;5169.327987361619;5182.948170518246;1858.5260758506495;1955.3742802303127;2028.0468179955396;2053.0453339197343;2087.822535084535;988.7923536057508;1027.5170669785189;1027.6968294353185;1032.9793404131876;1050.1546255264586;17537.386191483492;17619.207135678924;18029.639407212046;18138.183781729855;18206.817931820777;1083.631565267797;1128.6219116595869;1129.9378534180698;1137.1755477278907;1143.7598104398003;10462.24119954319;10622;10634.680959571226;10681.732956676145;10826.133909287239;301695;309494;309514;310337;540974;98552;101044;102362;102545.4618180713;102620;1156.7050402147568;1158.8725240223569;1162.035510526261;1197.7305106351175;1220.5422966387605;17055.573610659834;17113.315467381166;17273;17297.91351043237;17333.306667733654;37755;38658;39846;39964.8001760001;39977.60022399739;55628.72185639046;56310;57970;60052.39947600468;61613.383866160766;11965.521379144737;12610.936945315581;13025.348732563145;13027.153235040072;13190.406431710788;13964.511242106477;14125;14413.495527656481;14496.782548261996;14750.55748327509;12025.579104731292;12302.630921072383;12445.813312800134;12499.437525311201;12957.287349195885;12247.571335003233;12276.570320038756;12444.81332779991;12544.560940367044;12669.619911402673;6468.902966455413;12379.93810030944;12468.688282793002;12953.611391658265;12967.157134786208;13094.869051309364;13136.211827290394;13162.670933226746;13276.269805160422;13309.600711978655;12560.371981401076;12642.87357126417;12663.240205587694;12757.8086328707;12888.806667900177 07:10:35 INFO - PROCESS | 28929 | |3;mootools.html;1477.5788900163443;1513.5837644647725;1538.6538028943485;1712.1268153241851;1857.702767557192;8070.55611941343;8348.582570871455;8357.540335281565;8365.958170209156;8367.91632083679;8017.438779285452;8176.632051557679;8179.182081791818;8183.877241841377;8194.877076843837;2262.2986874069093;2263.547290541886;2272.2842304673973;2282.087165133951;2282.7945484906354;2229.7101376820992;2242.831787615927;2280.05377768226;2284.200529814568;2285.2001799370255;2319.489712263308;2333.6382860656627;2333.9649905251435;2357.481354102095;2377.2986968844148;2304.8617082974906;2361.3860396297;2367.07684003238;2370.2652177824843;2379.2862141357696;2357.7288611809518;2374.833761636686;2383.797377222938;2383.892724827387;2389.569877422063;8371.414001019932;8378;8408.915910840935;8458.577071146417;8693.869591956125;5193.532582067594;5223.582113430916;5269.314989051399;5272.31459910213;5277.8416647500635;3353.731701463877;3389.4237979543536;3390.4066788311948;3417.3165366926714;3448.0862571418593;1164.7554013657143;1168.772089442559;1203.3501908969147;1237.4060450983488;1251.124213050859;11873.584424545186;11928.821067683904;11972.760544789142;11980;11982.52069917211;4385.627221686193;4414.249577571821;4463.799129039201;4498.775061246924;4586.495485496593;9654.469004204695;9692.70921872345;9692.806143877224;9693.563789629483;9697.321187516805;5211.557017653542;5233.267342572043;5237.580993520509;5253.947460525423;5254.6847189168775;4110.157417729359;4709.576138147515;4795.232762757942;4808.783604737795;4857.0528746894015;3850.6726928210855;3913.2760439318818;3946.408038794204;3980.8208630611693;3983.6813054955533;1147.7302833834042;1150.6433005768238;1155.0701685143372;1156.7397335599424;1168.8831116888414;958.7603099225194;1047.4082143588848;1065.4938904020682;1068.9786204276027;1078.6116997880756;5888.411158884077;5916.497097746654;6027.246594175728;6058.606190597685;6283.37166283368;1011.7066050845173;1047.2512153810062;1095.3044816541553;1110.2172968057662;1136.778328225988;4293.8711838644895;4420.403245561873;4424.424824772824;4445.533219011957;4468.084042771224;10143.949280253551;10439.739006524745;10440.42577658236;10459.895401045893;10495.317804342692;10260.897391026143;10284.794304113875;10308.278420510493;10318.43248621333;10331.638392656221;7827.334676552443;8045.034595848536;8071.556064416396;8207.548584827773;8209.712660056988;5385.542228910586;5421.620486565903;5484.808031718871;5533.3083364579425;5561.054620714407;8080.232377924088;8158.3065439438315;8268.131846156068;8292.543910085004;8328.458650187718;8138.877916831134;8424.410291279552;8439;8451.704190353308;8466.703665371682;6637.236717777324;7340;7562.848743024999;7739.380849532136;8074.87887681697;8461.576921153795;8503.447275927045;8517.190866867637;8544.102869198645;8547.52988585609;7613.809654758676;7736.2650548197835;7741.225877412214;7843.764687059397;7888.921110788819;7334.523255988557;7355.227701091522;7415.629218539159;7457.47797654159;7486.251374862471;7157.463190260855;7164.104486939133;7201.891971620535;7204.135503739585;7209.35115839577;4726.692764970266;4825.6139508838505;4829.468758436499;4852.8301509447;4868.440129385166;5225.92161117576;5308.575313974796;5360.865978350573;5380.112281473513;5393.056215162253 07:10:35 INFO - PROCESS | 28929 | |4;prototype.html;344.3835534393436;347.4787818272591;358.27806968957555;362.8639260277396;368.0577721034153;6015.819525414234;6021.2774467063955;6030.125631783394;6032.8793424131545;6038.637681739098;5946.5242780577555;5946.643201407907;5962.522998160148;5968.910466342997;6073.180120683706;4399.406080179175;4510.278355463127;4539.273716205408;4548.135854187693;4569.337446070318;4618.49196588375;4649.116667833117;4660.370849935266;4669.066186762661;4674.719516829001;4612.423447069116;4612.4465064192345;4615.907681846361;4617.07658468306;4625.468071171807;4402.757848318357;4489.461264648263;4514.8419805306985;4585.037142200142;4618.838340658078;4040.6161414665853;4041.2927737645796;4045;4081.7755023473696;4099.692523060782;5799.043157878945;5812.505936995361;5813.767449302023;5817.243758311392;5817.854553636193;5386.542143917772;5400.78396864125;5403.108487099624;5404.513593776579;5419;6348.238211414659;6353.682315884187;6358.268799088118;6359;6369;4360.542143074963;4515.819367225307;4521.683482156251;4574.290984897346;4586.059857729158;6622.403983641495;6659.40065394112;6677.833054173684;6682.231543372477;6698.095757072781;4489.393931819228;4490.034642551867;4491.056878055645;4493.415855938707;4494.70784399013;4537.773111344485;4547.977260113678;4552.11233809404;4552.408186935743;4559.202139625552;5294.788208471618;5297.682139071668;5306.283651707047;5306.946930530646;5307.01820163271;6309.810705678837;6444.8388790280615;6451.838669039618;6451.903221451682;6453.483721302285;1602.9118398488195;1615.7414813629762;1626.8861179717542;1628.0313213637867;1631.1028934086205;1015.4262841494532;1068.391017120234;1078.52544880254;1092.448313601626;1093.1528065748948;6256.217972753406;6329.873402531924;6353.491720662336;6368.713407896656;6409.487241020707;6688.197416310074;6706.362895524917;6709.597424154566;6721.126253587003;6731.49513786468;6364.809055728336;6422;6423.297826076094;6429.357064293533;6440.259370172396;3564.2515071834687;3573.6247693991754;3604.5133906922756;3607;3607.67530922213;6834.111565496553;7107.360337569644;7118.28817118284;7132.643367831588;7142.4286057115305;6797.490188235902;6824.146981627297;6832.658367081626;6837.076994605664;6837.965810170917;7101.786946391513;7105.78682639532;7105.928940710527;7108.111486064242;7123.964380178169;6717.227518835396;6720.0591917132615;6726.125603671491;6726.495512836655;6728.495362847708;6390.936090639034;6604.306547812411;6659.733610655519;6683.331666833278;6685.498587606046;7056;7077.327653872874;7086.645667716697;7091.1490621125795;7099.07711997437;4584.816607335669;4612.884677883079;4619.514950930238;4622.51463596331;4626.421697287839;6690.966545167243;6709.094272273181;6716.32836716344;6716.597004179569;6734.4612431004425;6401.071844582602;6472;6508.902366464412;6516.087747715229;6516.250631177286;6442.935570644421;6506.479481641362;6508.186476690414;6517.771877984248;6520.315366886409;6367.554271200971;6399.136116624196;6400.903986440114;6405.231372235362;6412.807615771534;6528.771492997722;6552.63960482159;6554.180727409074;6556.213254409501;6561.639109849004;6122.418370254997;6180.381961803783;6214.098955651315;6387.137736405526;6405.814924239031 07:10:35 INFO - PROCESS | 28929 | |5;yui.html;759.41904443101;773.4817672159656;816.326530612245;867.9126700285815;919.3176487028738;13464.192148471086;13926.651833704162;13957.023008389417;13989.650258743537;14004.22976736279;13484.325783710825;13550.390232439539;13557.11878727882;13563.050586458952;13572.728545429085;726.2628432141368;884.6726711116896;893.852514335134;900.0414558495214;903.6249956268141;894.1460904835899;898.2768871058795;901.342020325163;901.5221932375819;905.5110240470171;756.9432292578078;942.981140377192;948.4451595816421;948.6063283737241;949.4493193947494;918.9678361257357;945.1021529546923;945.1776954049986;945.2485274207022;945.966891158813;684.1140722764032;687.3229868579446;687.4191308344441;687.5290426058166;688.0470548290654;11881.702957426047;11916.642500724993;11950.103742219368;11952.940235298855;12007.3395963222;14143.717125657533;14551.272436378245;14759.77860332096;15389.230538473144;15434.45979390716;11860.169788114836;11965.940170299093;11988.820167697404;12059;12115.212511186834;3965.2466031453932;3991.481107456041;4006.8797936061965;4029.1135950090934;4089.8159582818844;55411.72294138504;56751.14873276904;56813;56901;56987.430125699044;11268.38023908693;11382.203245772882;11648.70878228034;11775.52897884075;11896.762064758655;21497.462563435725;21712.782872171076;21714.56570868574;21873.343799686034;21878;8711;8847.69033083839;8849.51327676971;9043.366964312567;9422.575984080733;5184.8185313514605;5209;5212.192110222922;5218.8956220876125;5241.685498870003;3678.70570354371;3714.4428335749853;3714.4428335749853;3724.832382542792;3727.0496023514374;632.3076231526471;639.405353021685;649.7758273395671;720.5928650312661;722.4256715910864;658.2890478283442;695.8469136789898;740.7925780781283;767.1752865669428;782.1145877273563;10067.093961543496;10198.082172604501;10343.224258180666;10359;10378.27352085362;765.7938746474325;783.1502819440857;788.678962737424;795.2683531151355;818.8444195602935;4314.352847072964;4447.756744671311;4483.686141970096;4559.3844830948065;4703.153432382135;57542;59109.113363299584;59140.40859591349;65879.34120658827;65985.67007164934;53289.467105329226;53654;54165.72917135468;55665;55731.442685573435;50465;50479.49520504822;51011.7449412758;51311;51987.74006129945;9581.712548623553;9689.806203876024;9737.123658870736;9854.507274636382;10102.494875256061;38128.428073579475;38406.23187536289;38932.41601376038;39837;39956.20087598173;49956.750216248685;50215.24677129919;50526.747366262935;50764.238536421246;51117;12333.321667308384;12511.937440313104;12596.803303686134;12849;12907.386576677914;13382.197068175941;14296.142231466145;14688;15102.622434438787;15171;12930.159539629894;12966.351682415652;13066.281354525592;13175.275359854917;13187.60437186886;13333.466661333827;13835.930820345833;14009.579712608638;14016.159030458206;14514.564563063124;13148.671283217996;13283.468661253442;13380.598582042554;13704.24626645544;13863;10841.51213195424;11058.668239952814;11110.61112861046;11183.552657893593;11373.545058197911;11495.482703278205;11500.48247828833;11600;11662.650120496399;11822.231554948901 07:10:35 INFO - PROCESS | 28929 | __end_tp_report 07:10:35 INFO - PROCESS | 28929 | __start_cc_report 07:10:35 INFO - PROCESS | 28929 | _x_x_mozilla_cycle_collect,804 07:10:35 INFO - PROCESS | 28929 | __end_cc_report 07:10:35 INFO - PROCESS | 28929 | __startTimestamp1468505435092__endTimestamp 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | ------- Summary: start ------- 07:10:35 INFO - PROCESS | 28929 | Number of tests: 6 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | [#0] dojo.html Cycles:165 Average:5349.16 Median:5486.23 stddev:580.54 (10.6%) stddev-sans-first:557.65 07:10:35 INFO - PROCESS | 28929 | Values: 3214.7 3310.2 3323.2 3353.8 3370.3 5354.9 5359.9 5369.4 5381.2 5382.6 5367.2 5369.1 5376.8 5387.6 5388.6 4817.1 4844.2 4929.7 4975.8 4997.8 4712.9 4750.3 4768.0 4791.8 4795.7 4808.9 4861.4 4942.1 4972.7 4978.4 4919.8 4957.0 4964.9 4974.3 4997.4 4775.5 4785.1 4856.8 4871.4 4922.0 5235.2 5293.2 5309.5 5324.9 5330.5 5721.7 5820.3 5824.6 5832.5 5835.2 5813.7 5833.3 5867.6 5890.2 5906.5 5437.1 5442.8 5480.2 5481.9 5486.2 5496.4 5882.4 5910.0 5912.3 5918.0 5659.2 5696.8 5715.0 5736.6 5747.9 5803.8 5805.0 5810.7 5820.1 5821.5 5479.8 5649.7 5774.6 5780.9 5795.4 5746.7 5781.9 5785.8 5791.7 5821.5 4453.2 4486.8 4488.8 4496.7 4528.7 3951.6 3961.7 4013.8 4027.6 4073.3 5485.7 5506.3 5513.3 5515.6 5534.3 5712.8 5716.6 5719.9 5720.0 5728.5 5432.2 5505.6 5580.5 5670.8 5677.1 4977.4 4978.5 4985.0 4989.8 4991.5 6082.8 6136.4 6139.1 6140.7 6142.2 5591.9 5662.7 5687.7 5703.9 5877.8 5856.1 5889.1 5899.5 5900.0 5925.6 5519.3 5522.2 5525.4 5527.4 5558.0 5671.5 5816.4 5859.7 5881.1 5892.0 5432.3 5451.9 5452.8 5469.1 5479.5 5383.8 5447.3 5466.1 5483.1 5496.9 5566.9 5620.8 5623.5 5647.9 5655.9 5480.7 5535.5 5537.1 5547.1 5554.8 5241.6 5302.9 5419.2 5428.2 5463.8 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | [#1] ext.html Cycles:180 Average:56266.30 Median:355327.00 stddev:103527.18 (29.1%) stddev-sans-first:103733.43 07:10:35 INFO - PROCESS | 28929 | Values: 663.9 671.3 674.1 683.4 737.8 32165.5 32438.5 40297.6 40599.6 40659.4 42384.0 42848.6 42858.6 42904.1 43057.0 7821.7 8687.2 8972.3 8978.3 10362.2 10397.0 10525.1 10539.1 10539.6 10540.1 10509.6 10579.5 10586.7 10591.5 10596.3 10429.1 10478.1 10484.6 10489.3 10489.5 10500.7 10922.8 10949.3 10952.7 10961.2 43085.6 43306.0 43526.0 43575.0 43695.3 3718.0 3785.0 3908.0 4015.0 4102.1 33856.0 33865.8 33914.5 34087.5 34262.8 4441.0 4476.7 4480.2 4509.8 4516.0 352691.0 355159.0 355495.0 355983.0 356113.0 61343.0 61851.4 61864.7 61876.4 61902.7 65899.0 68844.3 69697.0 69917.3 69951.3 17611.4 17671.2 17742.1 17804.6 17813.8 14539.6 14891.5 14897.3 14912.9 14942.0 19515.0 20566.3 20658.5 20693.9 20708.7 7544.9 7598.9 7615.0 7638.3 7638.8 1040.6 1161.8 1191.9 1219.5 1225.1 33005.7 33029.7 33692.3 33899.8 34018.7 1184.2 1185.8 1195.8 1226.5 1285.3 17419.2 17460.4 17628.8 17704.6 17873.6 489665.0 493869.0 495872.0 496073.0 496282.0 62123.4 62532.4 62594.4 62703.7 62726.4 1347.7 1425.7 1501.3 1510.4 1525.1 29824.6 32041.5 32398.7 32707.7 33206.5 50871.5 51121.5 51216.0 51281.7 51338.5 299134.0 302761.0 303560.0 303599.0 303828.0 25994.0 29729.6 29923.1 29927.3 30280.1 42833.8 44919.3 46291.0 48612.5 49576.8 40237.2 40732.3 41464.0 41773.0 42076.4 39762.6 40465.2 40729.2 41479.6 41564.6 41064.4 41295.6 41569.8 42009.2 42275.8 34978.3 36467.5 36602.0 36781.6 37335.4 27584.9 27852.7 27967.3 27969.6 28272.6 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | [#2] jquery.html Cycles:180 Average:25486.42 Median:18575.35 stddev:61592.65 (331.6%) stddev-sans-first:61736.71 07:10:35 INFO - PROCESS | 28929 | Values: 436.1 442.0 449.3 449.3 450.5 18550.3 18767.9 19113.9 19357.1 19803.3 17173.4 17424.1 18366.4 18574.3 18576.4 5604.1 5828.7 5857.9 5865.9 5982.3 3930.4 5504.6 5790.5 5819.5 5855.7 5829.8 5833.0 5839.8 5845.2 5846.6 5801.7 5827.6 6398.6 6564.0 6579.1 3866.8 5508.7 5724.6 5918.4 5939.3 13174.9 13281.5 13314.8 13412.6 18227.8 2213.2 2331.2 2355.3 2690.6 3117.1 9877.4 10167.4 10272.6 10476.8 12863.7 1995.1 2014.7 2073.2 2143.8 2156.6 73191.6 76782.2 77533.6 79093.0 79974.6 11598.9 11600.4 11646.1 11735.9 11789.4 16333.6 16486.9 16541.9 16554.3 16599.0 8493.2 8588.5 8594.6 8724.9 8815.1 8294.9 8328.1 8591.5 8698.0 8718.6 5050.5 5144.9 5152.2 5169.3 5182.9 1858.5 1955.4 2028.0 2053.0 2087.8 988.8 1027.5 1027.7 1033.0 1050.2 17537.4 17619.2 18029.6 18138.2 18206.8 1083.6 1128.6 1129.9 1137.2 1143.8 10462.2 10622.0 10634.7 10681.7 10826.1 301695.0 309494.0 309514.0 310337.0 540974.0 98552.0 101044.0 102362.0 102545.5 102620.0 1156.7 1158.9 1162.0 1197.7 1220.5 17055.6 17113.3 17273.0 17297.9 17333.3 37755.0 38658.0 39846.0 39964.8 39977.6 55628.7 56310.0 57970.0 60052.4 61613.4 11965.5 12610.9 13025.3 13027.2 13190.4 13964.5 14125.0 14413.5 14496.8 14750.6 12025.6 12302.6 12445.8 12499.4 12957.3 12247.6 12276.6 12444.8 12544.6 12669.6 6468.9 12379.9 12468.7 12953.6 12967.2 13094.9 13136.2 13162.7 13276.3 13309.6 12560.4 12642.9 12663.2 12757.8 12888.8 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | [#3] mootools.html Cycles:180 Average:5583.85 Median:4841.15 stddev:3035.74 (62.7%) stddev-sans-first:3028.57 07:10:35 INFO - PROCESS | 28929 | Values: 1477.6 1513.6 1538.7 1712.1 1857.7 8070.6 8348.6 8357.5 8366.0 8367.9 8017.4 8176.6 8179.2 8183.9 8194.9 2262.3 2263.5 2272.3 2282.1 2282.8 2229.7 2242.8 2280.1 2284.2 2285.2 2319.5 2333.6 2334.0 2357.5 2377.3 2304.9 2361.4 2367.1 2370.3 2379.3 2357.7 2374.8 2383.8 2383.9 2389.6 8371.4 8378.0 8408.9 8458.6 8693.9 5193.5 5223.6 5269.3 5272.3 5277.8 3353.7 3389.4 3390.4 3417.3 3448.1 1164.8 1168.8 1203.4 1237.4 1251.1 11873.6 11928.8 11972.8 11980.0 11982.5 4385.6 4414.2 4463.8 4498.8 4586.5 9654.5 9692.7 9692.8 9693.6 9697.3 5211.6 5233.3 5237.6 5253.9 5254.7 4110.2 4709.6 4795.2 4808.8 4857.1 3850.7 3913.3 3946.4 3980.8 3983.7 1147.7 1150.6 1155.1 1156.7 1168.9 958.8 1047.4 1065.5 1069.0 1078.6 5888.4 5916.5 6027.2 6058.6 6283.4 1011.7 1047.3 1095.3 1110.2 1136.8 4293.9 4420.4 4424.4 4445.5 4468.1 10143.9 10439.7 10440.4 10459.9 10495.3 10260.9 10284.8 10308.3 10318.4 10331.6 7827.3 8045.0 8071.6 8207.5 8209.7 5385.5 5421.6 5484.8 5533.3 5561.1 8080.2 8158.3 8268.1 8292.5 8328.5 8138.9 8424.4 8439.0 8451.7 8466.7 6637.2 7340.0 7562.8 7739.4 8074.9 8461.6 8503.4 8517.2 8544.1 8547.5 7613.8 7736.3 7741.2 7843.8 7888.9 7334.5 7355.2 7415.6 7457.5 7486.3 7157.5 7164.1 7201.9 7204.1 7209.4 4726.7 4825.6 4829.5 4852.8 4868.4 5225.9 5308.6 5360.9 5380.1 5393.1 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | [#4] prototype.html Cycles:180 Average:5414.84 Median:6151.40 stddev:1657.35 (26.9%) stddev-sans-first:1617.71 07:10:35 INFO - PROCESS | 28929 | Values: 344.4 347.5 358.3 362.9 368.1 6015.8 6021.3 6030.1 6032.9 6038.6 5946.5 5946.6 5962.5 5968.9 6073.2 4399.4 4510.3 4539.3 4548.1 4569.3 4618.5 4649.1 4660.4 4669.1 4674.7 4612.4 4612.4 4615.9 4617.1 4625.5 4402.8 4489.5 4514.8 4585.0 4618.8 4040.6 4041.3 4045.0 4081.8 4099.7 5799.0 5812.5 5813.8 5817.2 5817.9 5386.5 5400.8 5403.1 5404.5 5419.0 6348.2 6353.7 6358.3 6359.0 6369.0 4360.5 4515.8 4521.7 4574.3 4586.1 6622.4 6659.4 6677.8 6682.2 6698.1 4489.4 4490.0 4491.1 4493.4 4494.7 4537.8 4548.0 4552.1 4552.4 4559.2 5294.8 5297.7 5306.3 5306.9 5307.0 6309.8 6444.8 6451.8 6451.9 6453.5 1602.9 1615.7 1626.9 1628.0 1631.1 1015.4 1068.4 1078.5 1092.4 1093.2 6256.2 6329.9 6353.5 6368.7 6409.5 6688.2 6706.4 6709.6 6721.1 6731.5 6364.8 6422.0 6423.3 6429.4 6440.3 3564.3 3573.6 3604.5 3607.0 3607.7 6834.1 7107.4 7118.3 7132.6 7142.4 6797.5 6824.1 6832.7 6837.1 6838.0 7101.8 7105.8 7105.9 7108.1 7124.0 6717.2 6720.1 6726.1 6726.5 6728.5 6390.9 6604.3 6659.7 6683.3 6685.5 7056.0 7077.3 7086.6 7091.1 7099.1 4584.8 4612.9 4619.5 4622.5 4626.4 6691.0 6709.1 6716.3 6716.6 6734.5 6401.1 6472.0 6508.9 6516.1 6516.3 6442.9 6506.5 6508.2 6517.8 6520.3 6367.6 6399.1 6400.9 6405.2 6412.8 6528.8 6552.6 6554.2 6556.2 6561.6 6122.4 6180.4 6214.1 6387.1 6405.8 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - PROCESS | 28929 | [#5] yui.html Cycles:180 Average:15470.60 Median:4202.08 stddev:17586.13 (418.5%) stddev-sans-first:17600.77 07:10:35 INFO - PROCESS | 28929 | Values: 759.4 773.5 816.3 867.9 919.3 13464.2 13926.7 13957.0 13989.7 14004.2 13484.3 13550.4 13557.1 13563.1 13572.7 726.3 884.7 893.9 900.0 903.6 894.1 898.3 901.3 901.5 905.5 756.9 943.0 948.4 948.6 949.4 919.0 945.1 945.2 945.2 946.0 684.1 687.3 687.4 687.5 688.0 11881.7 11916.6 11950.1 11952.9 12007.3 14143.7 14551.3 14759.8 15389.2 15434.5 11860.2 11965.9 11988.8 12059.0 12115.2 3965.2 3991.5 4006.9 4029.1 4089.8 55411.7 56751.1 56813.0 56901.0 56987.4 11268.4 11382.2 11648.7 11775.5 11896.8 21497.5 21712.8 21714.6 21873.3 21878.0 8711.0 8847.7 8849.5 9043.4 9422.6 5184.8 5209.0 5212.2 5218.9 5241.7 3678.7 3714.4 3714.4 3724.8 3727.0 632.3 639.4 649.8 720.6 722.4 658.3 695.8 740.8 767.2 782.1 10067.1 10198.1 10343.2 10359.0 10378.3 765.8 783.2 788.7 795.3 818.8 4314.4 4447.8 4483.7 4559.4 4703.2 57542.0 59109.1 59140.4 65879.3 65985.7 53289.5 53654.0 54165.7 55665.0 55731.4 50465.0 50479.5 51011.7 51311.0 51987.7 9581.7 9689.8 9737.1 9854.5 10102.5 38128.4 38406.2 38932.4 39837.0 39956.2 49956.8 50215.2 50526.7 50764.2 51117.0 12333.3 12511.9 12596.8 12849.0 12907.4 13382.2 14296.1 14688.0 15102.6 15171.0 12930.2 12966.4 13066.3 13175.3 13187.6 13333.5 13835.9 14009.6 14016.2 14514.6 13148.7 13283.5 13380.6 13704.2 13863.0 10841.5 11058.7 11110.6 11183.6 11373.5 11495.5 11500.5 11600.0 11662.7 11822.2 07:10:35 INFO - PROCESS | 28929 | -------- Summary: end -------- 07:10:35 INFO - PROCESS | 28929 | 07:10:35 INFO - TEST-INFO | 28929: exit 0 07:10:35 INFO - TEST-OK | dromaeo_css | took 1109996ms 07:10:35 INFO - TEST-START | kraken 07:10:35 INFO - operating with platform_type : linux_ 07:10:35 INFO - Initialising browser for kraken test... 07:10:35 INFO - TEST-INFO | started process 29120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjoy5Kd/profile http://localhost:44748/getInfo.html) 07:10:38 INFO - PROCESS | 29120 | __metrics Screen width/height:1600/1200 07:10:38 INFO - PROCESS | 29120 | colorDepth:24 07:10:38 INFO - PROCESS | 29120 | Browser inner width/height: 1024/697 07:10:38 INFO - PROCESS | 29120 | __metrics 07:10:39 ERROR - PROCESS | 29120 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:10:40 INFO - TEST-INFO | 29120: exit 0 07:10:40 INFO - Browser initialized. 07:10:40 INFO - Running cycle 1/1 for kraken test... 07:10:40 INFO - TEST-INFO | started process 29211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjoy5Kd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:52 INFO - PROCESS | 29211 | RSS: Main: 139431936 07:10:52 INFO - PROCESS | 29211 | 07:10:54 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44748/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:55 INFO - PROCESS | 29211 | RSS: Main: 197640192 07:10:55 INFO - PROCESS | 29211 | 07:10:58 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44748/tests/kraken/driver.html?testName=audio-dft) 07:10:58 INFO - PROCESS | 29211 | RSS: Main: 183975936 07:10:58 INFO - PROCESS | 29211 | 07:11:01 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44748/tests/kraken/driver.html?testName=audio-fft) 07:11:02 INFO - PROCESS | 29211 | RSS: Main: 273035264 07:11:02 INFO - PROCESS | 29211 | 07:11:04 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44748/tests/kraken/driver.html?testName=audio-oscillator) 07:11:04 INFO - PROCESS | 29211 | RSS: Main: 179924992 07:11:04 INFO - PROCESS | 29211 | 07:11:07 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:07 INFO - PROCESS | 29211 | RSS: Main: 177598464 07:11:07 INFO - PROCESS | 29211 | 07:11:10 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44748/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:11 INFO - PROCESS | 29211 | RSS: Main: 211947520 07:11:11 INFO - PROCESS | 29211 | 07:11:14 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44748/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:15 INFO - PROCESS | 29211 | RSS: Main: 212631552 07:11:15 INFO - PROCESS | 29211 | 07:11:17 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44748/tests/kraken/driver.html?testName=json-parse-financial) 07:11:18 INFO - PROCESS | 29211 | RSS: Main: 212226048 07:11:18 INFO - PROCESS | 29211 | 07:11:20 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:20 INFO - PROCESS | 29211 | RSS: Main: 196202496 07:11:20 INFO - PROCESS | 29211 | 07:11:22 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:22 INFO - PROCESS | 29211 | RSS: Main: 199438336 07:11:22 INFO - PROCESS | 29211 | 07:11:24 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:25 INFO - PROCESS | 29211 | RSS: Main: 209489920 07:11:25 INFO - PROCESS | 29211 | 07:11:27 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:28 INFO - PROCESS | 29211 | RSS: Main: 216973312 07:11:28 INFO - PROCESS | 29211 | 07:11:31 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:31 INFO - PROCESS | 29211 | RSS: Main: 213483520 07:11:31 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | Cycle 1(1): loaded http://localhost:44748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44748/tests/kraken/driver.html?testName=ai-astar) 07:11:33 INFO - PROCESS | 29211 | RSS: Main: 274485248 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | __start_tp_report 07:11:33 INFO - PROCESS | 29211 | _x_x_mozilla_page_load 07:11:33 INFO - PROCESS | 29211 | _x_x_mozilla_page_load_details 07:11:33 INFO - PROCESS | 29211 | |i|pagename|runs| 07:11:33 INFO - PROCESS | 29211 | |0;ai-astar;111;111;110;112;113;113;106;109;112;111 07:11:33 INFO - PROCESS | 29211 | |1;audio-beat-detection;153;126;161;191;128;151;158;134;183;132 07:11:33 INFO - PROCESS | 29211 | |2;audio-dft;159;161;158;160;160;165;159;159;160;160 07:11:33 INFO - PROCESS | 29211 | |3;audio-fft;77;75;74;181;76;76;74;76;178;74 07:11:33 INFO - PROCESS | 29211 | |4;audio-oscillator;93;91;148;91;92;93;151;93;92;150 07:11:33 INFO - PROCESS | 29211 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 07:11:33 INFO - PROCESS | 29211 | |6;imaging-darkroom;145;146;145;145;146;144;145;146;145;144 07:11:33 INFO - PROCESS | 29211 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;94;94 07:11:33 INFO - PROCESS | 29211 | |8;json-parse-financial;56;54;56;54;54;56;55;75;53;52 07:11:33 INFO - PROCESS | 29211 | |9;json-stringify-tinderbox;59;58;59;59;59;58;58;58;59;58 07:11:33 INFO - PROCESS | 29211 | |10;stanford-crypto-aes;74;72;72;72;73;74;74;72;74;74 07:11:33 INFO - PROCESS | 29211 | |11;stanford-crypto-ccm;114;114;114;118;114;111;122;114;137;125 07:11:33 INFO - PROCESS | 29211 | |12;stanford-crypto-pbkdf2;159;168;159;156;169;164;161;157;155;160 07:11:33 INFO - PROCESS | 29211 | |13;stanford-crypto-sha256-iterative;69;66;66;67;64;65;73;65;67;63 07:11:33 INFO - PROCESS | 29211 | __end_tp_report 07:11:33 INFO - PROCESS | 29211 | __start_cc_report 07:11:33 INFO - PROCESS | 29211 | _x_x_mozilla_cycle_collect,1561 07:11:33 INFO - PROCESS | 29211 | __end_cc_report 07:11:33 INFO - PROCESS | 29211 | __startTimestamp1468505493709__endTimestamp 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | ------- Summary: start ------- 07:11:33 INFO - PROCESS | 29211 | Number of tests: 14 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.10 (1.9%) stddev-sans-first:2.22 07:11:33 INFO - PROCESS | 29211 | Values: 111.0 111.0 110.0 112.0 113.0 113.0 106.0 109.0 112.0 111.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.50 stddev:22.55 (14.5%) stddev-sans-first:23.91 07:11:33 INFO - PROCESS | 29211 | Values: 153.0 126.0 161.0 191.0 128.0 151.0 158.0 134.0 183.0 132.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.91 (1.2%) stddev-sans-first:1.99 07:11:33 INFO - PROCESS | 29211 | Values: 159.0 161.0 158.0 160.0 160.0 165.0 159.0 159.0 160.0 160.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#3] audio-fft Cycles:10 Average:96.10 Median:75.50 stddev:43.97 (58.2%) stddev-sans-first:46.09 07:11:33 INFO - PROCESS | 29211 | Values: 77.0 75.0 74.0 181.0 76.0 76.0 74.0 76.0 178.0 74.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:27.81 (30.2%) stddev-sans-first:28.85 07:11:33 INFO - PROCESS | 29211 | Values: 93.0 91.0 148.0 91.0 92.0 93.0 151.0 93.0 92.0 150.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:11:33 INFO - PROCESS | 29211 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 07:11:33 INFO - PROCESS | 29211 | Values: 145.0 146.0 145.0 145.0 146.0 144.0 145.0 146.0 145.0 144.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:11:33 INFO - PROCESS | 29211 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.50 stddev:6.64 (12.0%) stddev-sans-first:7.04 07:11:33 INFO - PROCESS | 29211 | Values: 56.0 54.0 56.0 54.0 54.0 56.0 55.0 75.0 53.0 52.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 07:11:33 INFO - PROCESS | 29211 | Values: 59.0 58.0 59.0 59.0 59.0 58.0 58.0 58.0 59.0 58.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 07:11:33 INFO - PROCESS | 29211 | Values: 74.0 72.0 72.0 72.0 73.0 74.0 74.0 72.0 74.0 74.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:116.00 stddev:7.85 (6.8%) stddev-sans-first:8.17 07:11:33 INFO - PROCESS | 29211 | Values: 114.0 114.0 114.0 118.0 114.0 111.0 122.0 114.0 137.0 125.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:4.80 (3.0%) stddev-sans-first:5.05 07:11:33 INFO - PROCESS | 29211 | Values: 159.0 168.0 159.0 156.0 169.0 164.0 161.0 157.0 155.0 160.0 07:11:33 INFO - PROCESS | 29211 | 07:11:33 INFO - PROCESS | 29211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.84 (4.3%) stddev-sans-first:2.86 07:11:33 INFO - PROCESS | 29211 | Values: 69.0 66.0 66.0 67.0 64.0 65.0 73.0 65.0 67.0 63.0 07:11:33 INFO - PROCESS | 29211 | -------- Summary: end -------- 07:11:33 INFO - PROCESS | 29211 | 07:11:34 INFO - TEST-INFO | 29211: exit 0 07:11:34 INFO - TEST-OK | kraken | took 58786ms 07:11:34 INFO - SUITE-END | took 1168s 07:11:34 INFO - Completed test suite (00:19:29) 07:11:34 INFO - javascript benchmark 07:11:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.7428205743545, 3310.238645111625, 3323.185819474229, 3353.7820041697305, 3370.2922386298874, 5354.946450535494, 5359.946400535993, 5369.355677318717, 5381.19282107684, 5382.569394448445, 5367.2485851980755, 5369.087255166622, 5376.8118115865855, 5387.568994480442, 5388.622796404254, 4817.108834865544, 4844.152273352167, 4929.654924155293, 4975.776090075937, 4997.750112494361, 4712.929306060395, 4750.3349531065505, 4767.952320476803, 4791.832285869995, 4795.712257264558, 4808.879778005543, 4861.392325959255, 4942.135126352892, 4972.676776009548, 4978.352814134158, 4919.754012299389, 4957.0, 4964.925526117111, 4974.328465657162, 4997.4003119625695, 4775.450823155347, 4785.114753770529, 4856.781444834955, 4871.4397844248015, 4922.0402021605805, 5235.188545775372, 5293.179557168645, 5309.548688361494, 5324.866878328034, 5330.493603107699, 5721.742521586497, 5820.272465941757, 5824.592278540504, 5832.533397328203, 5835.153902684129, 5813.6802475863815, 5833.300003999547, 5867.589268751189, 5890.234269544974, 5906.468417842415, 5437.075697131497, 5442.809501667422, 5480.150576660624, 5481.9036192761205, 5486.231927530109, 5496.422875598085, 5882.3529411764675, 5910.024845900378, 5912.260967379078, 5917.970410147922, 5659.207710920475, 5696.8006119785605, 5714.971425142848, 5736.627119237236, 5747.913781293284, 5803.767849286066, 5804.970975145182, 5810.709464526757, 5820.097884827858, 5821.505172060338, 5479.75341109651, 5649.745761440663, 5774.624649397776, 5780.942190578125, 5795.362510123883, 5746.712664366765, 5781.942180578225, 5785.797497087666, 5791.652500849962, 5821.476067153892, 4453.1761624099645, 4486.753228572395, 4488.775561221926, 4496.7077139985795, 4528.660350473728, 3951.6048395160255, 3961.742486738353, 4013.7591744495426, 4027.617376349242, 4073.348264277701, 5485.698286594195, 5506.339239291311, 5513.3108361454815, 5515.586331025109, 5534.280543529316, 5712.800051998243, 5716.571257155647, 5719.885602287931, 5719.971400143056, 5728.541716662657, 5432.239486471897, 5505.559555235652, 5580.469855363734, 5670.829875103754, 5677.09166533361, 4977.402711674622, 4978.502149784992, 4984.975075124601, 4989.750512474362, 4991.4758950310425, 6082.847928801815, 6136.355682653347, 6139.10982907476, 6140.662263575547, 6142.232220972379, 5591.8881622368135, 5662.66024038559, 5687.687177205128, 5703.914441283467, 5877.823665290048, 5856.0630299151935, 5889.116632505158, 5899.528037756883, 5899.970500147643, 5925.585209035326, 5519.31008623922, 5522.22688823557, 5525.392206857323, 5527.391986881359, 5558.02734521449, 5671.461211184931, 5816.360200377871, 5859.677717725395, 5881.088431293157, 5892.0, 5432.293801805898, 5451.890962180813, 5452.7546260417585, 5469.124940009579, 5479.4520547944885, 5383.7846486140115, 5447.319085114361, 5466.1254199329505, 5483.095289277225, 5496.917546236729, 5566.860828479321, 5620.803271885465, 5623.522000629992, 5647.85880352978, 5655.85860353478, 5480.725963701879, 5535.529479994085, 5537.086380747131, 5547.084731019498, 5554.777808887599, 5241.6068794839775, 5302.946970530245, 5419.241306217212, 5428.185772134211, 5463.836084917459], "value": 5313.0225468963445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.9410140825382, 671.2850813883214, 674.0563211503897, 683.4122654517116, 737.8118579762156, 32165.51751723723, 32438.513422298656, 40297.597024029754, 40599.59400405995, 40659.390109148386, 42384.0, 42848.57151428485, 42858.57141428585, 42904.141917161636, 43057.0, 7821.726239581616, 8687.218150366481, 8972.327075469366, 8978.281737460988, 10362.171026317914, 10397.0, 10525.052745252926, 10539.051485366315, 10539.578416863316, 10540.051395374414, 10509.6321628743, 10579.471026448686, 10586.682399527988, 10591.523381447814, 10596.31123976939, 10429.061384475395, 10478.056974872221, 10484.58061677532, 10489.318194317346, 10489.475526223734, 10500.737481562946, 10922.836157457645, 10949.288296260796, 10952.671419857417, 10961.232713710044, 43085.56914430847, 43306.0, 43526.0, 43575.0, 43695.34456983116, 3717.962820371789, 3784.9621503784883, 3908.0, 4015.036391266104, 4102.077032667656, 33856.0, 33865.83067084649, 33914.49128263078, 34087.488687669706, 34262.82868585666, 4440.978574927784, 4476.709013914117, 4480.171168333869, 4509.774511274423, 4515.977420112911, 352691.0, 355159.0, 355495.0, 355983.0, 356113.0, 61343.0, 61851.38148618546, 61864.69067654723, 61876.38123618706, 61902.69048654728, 65899.0, 68844.31155688479, 69697.0, 69917.3008269921, 69951.30048699549, 17611.38360157388, 17671.204795783964, 17742.112894355232, 17804.55488612769, 17813.821861781475, 14539.563813085624, 14891.47879824201, 14897.329620167118, 14912.925435372754, 14942.0, 19515.045573729556, 20566.280180193622, 20658.483537911372, 20693.89653051725, 20708.689369659467, 7544.924550754532, 7598.924010759933, 7615.0, 7638.312551870358, 7638.8090297743, 1040.6201736366172, 1161.7734541764275, 1191.92252503587, 1219.5426714981882, 1225.105672858818, 33005.66994330026, 33029.66970330314, 33692.326153476795, 33899.830500847835, 34018.659813402046, 1184.2006645514243, 1185.8458400407892, 1195.8325834383193, 1226.515526367098, 1285.3059347952187, 17419.216135273942, 17460.388886388915, 17628.823711762976, 17704.557386065193, 17873.553161171076, 489665.0, 493869.0, 495872.0, 496073.0, 496282.0, 62123.37876621266, 62532.37467625357, 62594.37405625886, 62703.68648156821, 62726.37273627205, 1347.710242297891, 1425.6507155746701, 1501.3018946189857, 1510.4411367793766, 1525.1078119300334, 29824.552631710107, 32041.519377208893, 32398.676013240507, 32707.672923270464, 33206.501902471, 50871.491285086675, 51121.48878511167, 51216.0, 51281.743591283295, 51338.48661513337, 299134.0, 302761.0, 303560.0, 303599.0, 303828.0, 25994.0, 29729.554056689598, 29923.10230693083, 29927.251818704706, 30280.091597252118, 42833.78583107064, 44919.32621010622, 46291.0, 48612.5138748608, 49576.752116239186, 40237.1952560953, 40732.322601592816, 41464.0, 41773.0, 42076.36885446659, 39762.60237397589, 40465.1906961865, 40729.1854162921, 41479.58520414878, 41564.58435415607, 41064.384034238916, 41295.58704412918, 41569.79215104026, 42009.1598168041, 42275.7886210567, 34978.30043399169, 36467.45298820467, 36602.0, 36781.63218367782, 37335.43996839995, 27584.862075689492, 27852.72147278501, 27967.300817479725, 27969.580456292766, 28272.575911360935], "value": 20942.621054020303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.1125110400336, 441.9513853476118, 449.301336421864, 449.3125517957526, 450.4953455458767, 18550.257989680413, 18767.906160469196, 19113.904430477847, 19357.128929198185, 19803.306884259055, 17173.398931037416, 17424.128793560336, 18366.35717749879, 18574.25702971883, 18576.442706718786, 5604.075327570946, 5828.650280983144, 5857.941420585782, 5865.853353666171, 5982.282126144847, 3930.3711406175016, 5504.587155963299, 5790.507806836403, 5819.53443724501, 5855.736491857877, 5829.8251052468495, 5832.9708351458185, 5839.766409343642, 5845.240118784552, 5846.64920104793, 5801.7389217485315, 5827.621204621707, 6398.616083035033, 6564.048213009087, 6579.144711187563, 3866.845326186977, 5508.669479831223, 5724.627899186539, 5918.40815918409, 5939.346671866091, 13174.934125329408, 13281.535146269931, 13314.800277995837, 13412.597622071353, 18227.817721822878, 2213.225371120111, 2331.2423462374627, 2355.281639100074, 2690.6233127362184, 3117.1427857339186, 9877.40735555869, 10167.44079075658, 10272.589096436133, 10476.842847357295, 12863.742725145537, 1995.1420889017716, 2014.74815648044, 2073.2432662078386, 2143.7856214378594, 2156.611809874222, 73191.63404182998, 76782.23217767863, 77533.61233193854, 79093.0, 79974.60012699958, 11598.898104680042, 11600.361980091007, 11646.126540509496, 11735.88264117365, 11789.351585662871, 16333.591660208589, 16486.917565412336, 16541.917290413712, 16554.255058522394, 16599.0, 8493.150684931581, 8588.48469091844, 8594.5702714864, 8724.91275087241, 8815.074417186232, 8294.917050829414, 8328.125546817619, 8591.48451092924, 8698.0, 8718.60766265507, 5050.545450909362, 5144.948550514447, 5152.227165925141, 5169.327987361619, 5182.948170518246, 1858.5260758506495, 1955.3742802303127, 2028.0468179955396, 2053.0453339197343, 2087.822535084535, 988.7923536057508, 1027.5170669785189, 1027.6968294353185, 1032.9793404131876, 1050.1546255264586, 17537.386191483492, 17619.207135678924, 18029.639407212046, 18138.183781729855, 18206.817931820777, 1083.631565267797, 1128.6219116595869, 1129.9378534180698, 1137.1755477278907, 1143.7598104398003, 10462.24119954319, 10622.0, 10634.680959571226, 10681.732956676145, 10826.133909287239, 301695.0, 309494.0, 309514.0, 310337.0, 540974.0, 98552.0, 101044.0, 102362.0, 102545.4618180713, 102620.0, 1156.7050402147568, 1158.8725240223569, 1162.035510526261, 1197.7305106351175, 1220.5422966387605, 17055.573610659834, 17113.315467381166, 17273.0, 17297.91351043237, 17333.306667733654, 37755.0, 38658.0, 39846.0, 39964.8001760001, 39977.60022399739, 55628.72185639046, 56310.0, 57970.0, 60052.39947600468, 61613.383866160766, 11965.521379144737, 12610.936945315581, 13025.348732563145, 13027.153235040072, 13190.406431710788, 13964.511242106477, 14125.0, 14413.495527656481, 14496.782548261996, 14750.55748327509, 12025.579104731292, 12302.630921072383, 12445.813312800134, 12499.437525311201, 12957.287349195885, 12247.571335003233, 12276.570320038756, 12444.81332779991, 12544.560940367044, 12669.619911402673, 6468.902966455413, 12379.93810030944, 12468.688282793002, 12953.611391658265, 12967.157134786208, 13094.869051309364, 13136.211827290394, 13162.670933226746, 13276.269805160422, 13309.600711978655, 12560.371981401076, 12642.87357126417, 12663.240205587694, 12757.8086328707, 12888.806667900177], "value": 9523.937768994736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.5788900163443, 1513.5837644647725, 1538.6538028943485, 1712.1268153241851, 1857.702767557192, 8070.55611941343, 8348.582570871455, 8357.540335281565, 8365.958170209156, 8367.91632083679, 8017.438779285452, 8176.632051557679, 8179.182081791818, 8183.877241841377, 8194.877076843837, 2262.2986874069093, 2263.547290541886, 2272.2842304673973, 2282.087165133951, 2282.7945484906354, 2229.7101376820992, 2242.831787615927, 2280.05377768226, 2284.200529814568, 2285.2001799370255, 2319.489712263308, 2333.6382860656627, 2333.9649905251435, 2357.481354102095, 2377.2986968844148, 2304.8617082974906, 2361.3860396297, 2367.07684003238, 2370.2652177824843, 2379.2862141357696, 2357.7288611809518, 2374.833761636686, 2383.797377222938, 2383.892724827387, 2389.569877422063, 8371.414001019932, 8378.0, 8408.915910840935, 8458.577071146417, 8693.869591956125, 5193.532582067594, 5223.582113430916, 5269.314989051399, 5272.31459910213, 5277.8416647500635, 3353.731701463877, 3389.4237979543536, 3390.4066788311948, 3417.3165366926714, 3448.0862571418593, 1164.7554013657143, 1168.772089442559, 1203.3501908969147, 1237.4060450983488, 1251.124213050859, 11873.584424545186, 11928.821067683904, 11972.760544789142, 11980.0, 11982.52069917211, 4385.627221686193, 4414.249577571821, 4463.799129039201, 4498.775061246924, 4586.495485496593, 9654.469004204695, 9692.70921872345, 9692.806143877224, 9693.563789629483, 9697.321187516805, 5211.557017653542, 5233.267342572043, 5237.580993520509, 5253.947460525423, 5254.6847189168775, 4110.157417729359, 4709.576138147515, 4795.232762757942, 4808.783604737795, 4857.0528746894015, 3850.6726928210855, 3913.2760439318818, 3946.408038794204, 3980.8208630611693, 3983.6813054955533, 1147.7302833834042, 1150.6433005768238, 1155.0701685143372, 1156.7397335599424, 1168.8831116888414, 958.7603099225194, 1047.4082143588848, 1065.4938904020682, 1068.9786204276027, 1078.6116997880756, 5888.411158884077, 5916.497097746654, 6027.246594175728, 6058.606190597685, 6283.37166283368, 1011.7066050845173, 1047.2512153810062, 1095.3044816541553, 1110.2172968057662, 1136.778328225988, 4293.8711838644895, 4420.403245561873, 4424.424824772824, 4445.533219011957, 4468.084042771224, 10143.949280253551, 10439.739006524745, 10440.42577658236, 10459.895401045893, 10495.317804342692, 10260.897391026143, 10284.794304113875, 10308.278420510493, 10318.43248621333, 10331.638392656221, 7827.334676552443, 8045.034595848536, 8071.556064416396, 8207.548584827773, 8209.712660056988, 5385.542228910586, 5421.620486565903, 5484.808031718871, 5533.3083364579425, 5561.054620714407, 8080.232377924088, 8158.3065439438315, 8268.131846156068, 8292.543910085004, 8328.458650187718, 8138.877916831134, 8424.410291279552, 8439.0, 8451.704190353308, 8466.703665371682, 6637.236717777324, 7340.0, 7562.848743024999, 7739.380849532136, 8074.87887681697, 8461.576921153795, 8503.447275927045, 8517.190866867637, 8544.102869198645, 8547.52988585609, 7613.809654758676, 7736.2650548197835, 7741.225877412214, 7843.764687059397, 7888.921110788819, 7334.523255988557, 7355.227701091522, 7415.629218539159, 7457.47797654159, 7486.251374862471, 7157.463190260855, 7164.104486939133, 7201.891971620535, 7204.135503739585, 7209.35115839577, 4726.692764970266, 4825.6139508838505, 4829.468758436499, 4852.8301509447, 4868.440129385166, 5225.92161117576, 5308.575313974796, 5360.865978350573, 5380.112281473513, 5393.056215162253], "value": 4556.582550639736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.3835534393436, 347.4787818272591, 358.27806968957555, 362.8639260277396, 368.0577721034153, 6015.819525414234, 6021.2774467063955, 6030.125631783394, 6032.8793424131545, 6038.637681739098, 5946.5242780577555, 5946.643201407907, 5962.522998160148, 5968.910466342997, 6073.180120683706, 4399.406080179175, 4510.278355463127, 4539.273716205408, 4548.135854187693, 4569.337446070318, 4618.49196588375, 4649.116667833117, 4660.370849935266, 4669.066186762661, 4674.719516829001, 4612.423447069116, 4612.4465064192345, 4615.907681846361, 4617.07658468306, 4625.468071171807, 4402.757848318357, 4489.461264648263, 4514.8419805306985, 4585.037142200142, 4618.838340658078, 4040.6161414665853, 4041.2927737645796, 4045.0, 4081.7755023473696, 4099.692523060782, 5799.043157878945, 5812.505936995361, 5813.767449302023, 5817.243758311392, 5817.854553636193, 5386.542143917772, 5400.78396864125, 5403.108487099624, 5404.513593776579, 5419.0, 6348.238211414659, 6353.682315884187, 6358.268799088118, 6359.0, 6369.0, 4360.542143074963, 4515.819367225307, 4521.683482156251, 4574.290984897346, 4586.059857729158, 6622.403983641495, 6659.40065394112, 6677.833054173684, 6682.231543372477, 6698.095757072781, 4489.393931819228, 4490.034642551867, 4491.056878055645, 4493.415855938707, 4494.70784399013, 4537.773111344485, 4547.977260113678, 4552.11233809404, 4552.408186935743, 4559.202139625552, 5294.788208471618, 5297.682139071668, 5306.283651707047, 5306.946930530646, 5307.01820163271, 6309.810705678837, 6444.8388790280615, 6451.838669039618, 6451.903221451682, 6453.483721302285, 1602.9118398488195, 1615.7414813629762, 1626.8861179717542, 1628.0313213637867, 1631.1028934086205, 1015.4262841494532, 1068.391017120234, 1078.52544880254, 1092.448313601626, 1093.1528065748948, 6256.217972753406, 6329.873402531924, 6353.491720662336, 6368.713407896656, 6409.487241020707, 6688.197416310074, 6706.362895524917, 6709.597424154566, 6721.126253587003, 6731.49513786468, 6364.809055728336, 6422.0, 6423.297826076094, 6429.357064293533, 6440.259370172396, 3564.2515071834687, 3573.6247693991754, 3604.5133906922756, 3607.0, 3607.67530922213, 6834.111565496553, 7107.360337569644, 7118.28817118284, 7132.643367831588, 7142.4286057115305, 6797.490188235902, 6824.146981627297, 6832.658367081626, 6837.076994605664, 6837.965810170917, 7101.786946391513, 7105.78682639532, 7105.928940710527, 7108.111486064242, 7123.964380178169, 6717.227518835396, 6720.0591917132615, 6726.125603671491, 6726.495512836655, 6728.495362847708, 6390.936090639034, 6604.306547812411, 6659.733610655519, 6683.331666833278, 6685.498587606046, 7056.0, 7077.327653872874, 7086.645667716697, 7091.1490621125795, 7099.07711997437, 4584.816607335669, 4612.884677883079, 4619.514950930238, 4622.51463596331, 4626.421697287839, 6690.966545167243, 6709.094272273181, 6716.32836716344, 6716.597004179569, 6734.4612431004425, 6401.071844582602, 6472.0, 6508.902366464412, 6516.087747715229, 6516.250631177286, 6442.935570644421, 6506.479481641362, 6508.186476690414, 6517.771877984248, 6520.315366886409, 6367.554271200971, 6399.136116624196, 6400.903986440114, 6405.231372235362, 6412.807615771534, 6528.771492997722, 6552.63960482159, 6554.180727409074, 6556.213254409501, 6561.639109849004, 6122.418370254997, 6180.381961803783, 6214.098955651315, 6387.137736405526, 6405.814924239031], "value": 4878.940943304254, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.41904443101, 773.4817672159656, 816.326530612245, 867.9126700285815, 919.3176487028738, 13464.192148471086, 13926.651833704162, 13957.023008389417, 13989.650258743537, 14004.22976736279, 13484.325783710825, 13550.390232439539, 13557.11878727882, 13563.050586458952, 13572.728545429085, 726.2628432141368, 884.6726711116896, 893.852514335134, 900.0414558495214, 903.6249956268141, 894.1460904835899, 898.2768871058795, 901.342020325163, 901.5221932375819, 905.5110240470171, 756.9432292578078, 942.981140377192, 948.4451595816421, 948.6063283737241, 949.4493193947494, 918.9678361257357, 945.1021529546923, 945.1776954049986, 945.2485274207022, 945.966891158813, 684.1140722764032, 687.3229868579446, 687.4191308344441, 687.5290426058166, 688.0470548290654, 11881.702957426047, 11916.642500724993, 11950.103742219368, 11952.940235298855, 12007.3395963222, 14143.717125657533, 14551.272436378245, 14759.77860332096, 15389.230538473144, 15434.45979390716, 11860.169788114836, 11965.940170299093, 11988.820167697404, 12059.0, 12115.212511186834, 3965.2466031453932, 3991.481107456041, 4006.8797936061965, 4029.1135950090934, 4089.8159582818844, 55411.72294138504, 56751.14873276904, 56813.0, 56901.0, 56987.430125699044, 11268.38023908693, 11382.203245772882, 11648.70878228034, 11775.52897884075, 11896.762064758655, 21497.462563435725, 21712.782872171076, 21714.56570868574, 21873.343799686034, 21878.0, 8711.0, 8847.69033083839, 8849.51327676971, 9043.366964312567, 9422.575984080733, 5184.8185313514605, 5209.0, 5212.192110222922, 5218.8956220876125, 5241.685498870003, 3678.70570354371, 3714.4428335749853, 3714.4428335749853, 3724.832382542792, 3727.0496023514374, 632.3076231526471, 639.405353021685, 649.7758273395671, 720.5928650312661, 722.4256715910864, 658.2890478283442, 695.8469136789898, 740.7925780781283, 767.1752865669428, 782.1145877273563, 10067.093961543496, 10198.082172604501, 10343.224258180666, 10359.0, 10378.27352085362, 765.7938746474325, 783.1502819440857, 788.678962737424, 795.2683531151355, 818.8444195602935, 4314.352847072964, 4447.756744671311, 4483.686141970096, 4559.3844830948065, 4703.153432382135, 57542.0, 59109.113363299584, 59140.40859591349, 65879.34120658827, 65985.67007164934, 53289.467105329226, 53654.0, 54165.72917135468, 55665.0, 55731.442685573435, 50465.0, 50479.49520504822, 51011.7449412758, 51311.0, 51987.74006129945, 9581.712548623553, 9689.806203876024, 9737.123658870736, 9854.507274636382, 10102.494875256061, 38128.428073579475, 38406.23187536289, 38932.41601376038, 39837.0, 39956.20087598173, 49956.750216248685, 50215.24677129919, 50526.747366262935, 50764.238536421246, 51117.0, 12333.321667308384, 12511.937440313104, 12596.803303686134, 12849.0, 12907.386576677914, 13382.197068175941, 14296.142231466145, 14688.0, 15102.622434438787, 15171.0, 12930.159539629894, 12966.351682415652, 13066.281354525592, 13175.275359854917, 13187.60437186886, 13333.466661333827, 13835.930820345833, 14009.579712608638, 14016.159030458206, 14514.564563063124, 13148.671283217996, 13283.468661253442, 13380.598582042554, 13704.24626645544, 13863.0, 10841.51213195424, 11058.668239952814, 11110.61112861046, 11183.552657893593, 11373.545058197911, 11495.482703278205, 11500.48247828833, 11600.0, 11662.650120496399, 11822.231554948901], "value": 7132.6209545717675, "unit": "score"}], "name": "dromaeo_css", "value": 7428.610991449934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 112.0, 113.0, 113.0, 106.0, 109.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 161.0, 191.0, 128.0, 151.0, 158.0, 134.0, 183.0, 132.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 158.0, 160.0, 160.0, 165.0, 159.0, 159.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 181.0, 76.0, 76.0, 74.0, 76.0, 178.0, 74.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 148.0, 91.0, 92.0, 93.0, 151.0, 93.0, 92.0, 150.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 144.0, 145.0, 146.0, 145.0, 144.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 54.0, 54.0, 56.0, 55.0, 75.0, 53.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 72.0, 73.0, 74.0, 74.0, 72.0, 74.0, 74.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 118.0, 114.0, 111.0, 122.0, 114.0, 137.0, 125.0], "value": 118.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 168.0, 159.0, 156.0, 169.0, 164.0, 161.0, 157.0, 155.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 67.0, 64.0, 65.0, 73.0, 65.0, 67.0, 63.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1518.3999999999999, "alertThreshold": 2.0}]} 07:11:34 INFO - Return code: 0 07:11:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:34 ERROR - # TBPL SUCCESS # 07:11:34 INFO - Running post-action listener: _resource_record_post_action 07:11:34 INFO - Running post-run listener: _resource_record_post_run 07:11:36 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 465801216; Read time: 12; Write time: 444480 07:11:36 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 254992384; Read time: 0; Write time: 319988 07:11:36 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 210210816; Read time: 12; Write time: 124488 07:11:36 INFO - Running post-run listener: _upload_blobber_files 07:11:36 INFO - Blob upload gear active. 07:11:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:36 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 07:11:36 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'] 07:11:36 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 07:11:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:37 INFO - (blobuploader) - INFO - Done attempting. 07:11:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:38 INFO - (blobuploader) - INFO - Done attempting. 07:11:38 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:38 INFO - Return code: 0 07:11:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3a49cfb72e47e5116c70dafef6e13816255eb43e3692b04e0620d3d823d55d0542d8460e449bb398dc4f81ee6ba5a92c6df82db19116447b34e85a26d1a243d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f31fe04f2aa370cdf1a7177b06e04e9939e9aee9d05aca8292b46e404f1faf8deec5379e5f72e6f74fbd814d359ccf25f9f746bf965c58464da86aa16224590"} 07:11:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:38 INFO - Contents: 07:11:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3a49cfb72e47e5116c70dafef6e13816255eb43e3692b04e0620d3d823d55d0542d8460e449bb398dc4f81ee6ba5a92c6df82db19116447b34e85a26d1a243d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f31fe04f2aa370cdf1a7177b06e04e9939e9aee9d05aca8292b46e404f1faf8deec5379e5f72e6f74fbd814d359ccf25f9f746bf965c58464da86aa16224590"} 07:11:38 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:38 INFO - Copying logs to upload dir... 07:11:38 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.968502 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-14 07:11:37.833289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:11:37.836714) ========= 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=826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729 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/a3a49cfb72e47e5116c70dafef6e13816255eb43e3692b04e0620d3d823d55d0542d8460e449bb398dc4f81ee6ba5a92c6df82db19116447b34e85a26d1a243d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f31fe04f2aa370cdf1a7177b06e04e9939e9aee9d05aca8292b46e404f1faf8deec5379e5f72e6f74fbd814d359ccf25f9f746bf965c58464da86aa16224590"} build_url:https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/KK_gTcrCTbyIv-1Zlg-Tjg/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/a3a49cfb72e47e5116c70dafef6e13816255eb43e3692b04e0620d3d823d55d0542d8460e449bb398dc4f81ee6ba5a92c6df82db19116447b34e85a26d1a243d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f31fe04f2aa370cdf1a7177b06e04e9939e9aee9d05aca8292b46e404f1faf8deec5379e5f72e6f74fbd814d359ccf25f9f746bf965c58464da86aa16224590"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:11:37.865204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:11:37.865978) ========= 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=826874ccc97bd7bf541b4875000001d5-1468504274.487363-2017768729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:11:37.949138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:11:37.949867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:11:37.950628) ========= ========= Total master_lag: 0.16 =========