builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1468503393.29 results: success (0) buildid: 20160714034942 builduid: cd19e48177a442968db062d9999e4f39 revision: 81f987b98a91032913ef201143e2e91db9b77bf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.288131) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.288680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.288969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.335746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.336105) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:36:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-14 06:36:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217780 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.695908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.696363) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.098984 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.808963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:33.809360) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 81f987b98a91032913ef201143e2e91db9b77bf7 --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 81f987b98a91032913ef201143e2e91db9b77bf7 --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=9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:36:33,871 truncating revision to first 12 chars 2016-07-14 06:36:33,871 Setting DEBUG logging. 2016-07-14 06:36:33,871 attempt 1/10 2016-07-14 06:36:33,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/81f987b98a91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:36:34,171 unpacking tar archive at: mozilla-beta-81f987b98a91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:34.466336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:34.466790) ========= script_repo_revision: 81f987b98a91032913ef201143e2e91db9b77bf7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:34.467242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:34.467537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:36:34.478792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-14 06:36:34.479379) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:34 INFO - MultiFileLogger online at 20160714 06:36:34 in /builds/slave/test 06:36:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:36:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:34 INFO - {'append_to_log': False, 06:36:34 INFO - 'base_work_dir': '/builds/slave/test', 06:36:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:36:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:34 INFO - 'branch': 'Mozilla-Beta', 06:36:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:34 INFO - 'config_files': ('talos/linux_config.py',), 06:36:34 INFO - 'default_actions': ('clobber', 06:36:34 INFO - 'read-buildbot-config', 06:36:34 INFO - 'download-and-extract', 06:36:34 INFO - 'populate-webroot', 06:36:34 INFO - 'create-virtualenv', 06:36:34 INFO - 'install', 06:36:34 INFO - 'run-tests'), 06:36:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:34 INFO - 'download_minidump_stackwalk': True, 06:36:34 INFO - 'download_symbols': 'ondemand', 06:36:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:34 INFO - 'installer_path': 'installer.exe', 06:36:34 INFO - 'log_level': 'info', 06:36:34 INFO - 'log_name': 'talos', 06:36:34 INFO - 'log_to_console': True, 06:36:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:34 INFO - 'opt_config_files': (), 06:36:34 INFO - 'pip_index': False, 06:36:34 INFO - 'sps_profile': False, 06:36:34 INFO - 'sps_profile_interval': 0, 06:36:34 INFO - 'suite': 'dromaeojs-e10s', 06:36:34 INFO - 'system_bits': '32', 06:36:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:34 INFO - 'title': 'talos-linux64-ix-022', 06:36:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:34 INFO - 'use_talos_json': True, 06:36:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:34 INFO - 'work_dir': 'build'} 06:36:34 INFO - ##### 06:36:34 INFO - ##### Running clobber step. 06:36:34 INFO - ##### 06:36:34 INFO - Running pre-action listener: _resource_record_pre_action 06:36:34 INFO - Running main action method: clobber 06:36:34 INFO - rmtree: /builds/slave/test/build 06:36:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:36 INFO - Running post-action listener: _resource_record_post_action 06:36:36 INFO - ##### 06:36:36 INFO - ##### Running read-buildbot-config step. 06:36:36 INFO - ##### 06:36:36 INFO - Running pre-action listener: _resource_record_pre_action 06:36:36 INFO - Running main action method: read_buildbot_config 06:36:36 INFO - Using buildbot properties: 06:36:36 INFO - { 06:36:36 INFO - "project": "", 06:36:36 INFO - "product": "firefox", 06:36:36 INFO - "script_repo_revision": "production", 06:36:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:36:36 INFO - "repository": "", 06:36:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:36:36 INFO - "buildid": "20160714034942", 06:36:36 INFO - "pgo_build": "True", 06:36:36 INFO - "basedir": "/builds/slave/test", 06:36:36 INFO - "buildnumber": 174, 06:36:36 INFO - "slavename": "talos-linux64-ix-022", 06:36:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:36:36 INFO - "platform": "ubuntu64_hw", 06:36:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:36:36 INFO - "branch": "mozilla-beta", 06:36:36 INFO - "repo_path": "releases/mozilla-beta", 06:36:36 INFO - "revision": "81f987b98a91032913ef201143e2e91db9b77bf7", 06:36:36 INFO - "stage_platform": "linux64-pgo", 06:36:36 INFO - "builduid": "cd19e48177a442968db062d9999e4f39", 06:36:36 INFO - "slavebuilddir": "test" 06:36:36 INFO - } 06:36:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:36:36 INFO - Running post-action listener: _resource_record_post_action 06:36:36 INFO - ##### 06:36:36 INFO - ##### Running download-and-extract step. 06:36:36 INFO - ##### 06:36:36 INFO - Running pre-action listener: _resource_record_pre_action 06:36:36 INFO - Running main action method: download_and_extract 06:36:36 INFO - mkdir: /builds/slave/test/build/tests 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:36 INFO - https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:37 INFO - Downloaded 1327 bytes. 06:36:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:36:37 INFO - Using the following test package requirements: 06:36:37 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:36:37 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:37 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:36:37 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'jsshell-linux-x86_64.zip'], 06:36:37 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:37 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:36:37 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:36:37 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:36:37 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:37 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:36:37 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:37 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36: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:36:37 INFO - https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:38 INFO - Downloaded 24200581 bytes. 06:36:38 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:36:38 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:36:40 INFO - Return code: 0 06:36:40 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:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:40 INFO - https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:36:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:36:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:36:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:42 INFO - Downloaded 24200581 bytes. 06:36:42 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:36:42 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:36:43 INFO - Return code: 0 06:36:43 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:36:43 INFO - https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:44 INFO - Downloaded 10840145 bytes. 06:36:44 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:36:44 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:36:45 INFO - Return code: 0 06:36: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:36:45 INFO - https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-t-RWKxQFab9l_up8zQUw/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:36:46 INFO - Downloaded 56032229 bytes. 06:36:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:36:46 INFO - mkdir: /builds/slave/test/properties 06:36:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:46 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:46 INFO - Contents: 06:36:46 INFO - build_url:https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:36:47 INFO - Running post-action listener: _resource_record_post_action 06:36:47 INFO - Running post-action listener: set_extra_try_arguments 06:36:47 INFO - ##### 06:36:47 INFO - ##### Running populate-webroot step. 06:36:47 INFO - ##### 06:36:47 INFO - Running pre-action listener: _resource_record_pre_action 06:36:47 INFO - Running main action method: populate_webroot 06:36:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:47 INFO - '--tppagecycles', 06:36:47 INFO - '7'], 06:36:47 INFO - 'tests': ['tsvgm']}}, 06:36:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['damp', 'tps']}, 06:36:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'tests': ['damp', 'tps']}, 06:36:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['dromaeo_dom']}, 06:36:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['a11yr', 06:36:47 INFO - 'ts_paint', 06:36:47 INFO - 'tpaint', 06:36:47 INFO - 'sessionrestore', 06:36:47 INFO - 'sessionrestore_no_auto_restore', 06:36:47 INFO - 'tabpaint']}, 06:36:47 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:47 INFO - 'ts_paint', 06:36:47 INFO - 'tpaint', 06:36:47 INFO - 'sessionrestore', 06:36:47 INFO - 'sessionrestore_no_auto_restore', 06:36:47 INFO - 'tabpaint']}, 06:36:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:47 INFO - 'ts_paint', 06:36:47 INFO - 'tpaint', 06:36:47 INFO - 'sessionrestore', 06:36:47 INFO - 'sessionrestore_no_auto_restore', 06:36:47 INFO - 'tabpaint']}, 06:36:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:47 INFO - 'ts_paint', 06:36:47 INFO - 'tpaint', 06:36:47 INFO - 'sessionrestore', 06:36:47 INFO - 'sessionrestore_no_auto_restore', 06:36:47 INFO - 'tabpaint']}, 06:36:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['a11yr', 06:36:47 INFO - 'ts_paint', 06:36:47 INFO - 'tpaint', 06:36:47 INFO - 'sessionrestore', 06:36:47 INFO - 'sessionrestore_no_auto_restore', 06:36:47 INFO - 'tabpaint']}, 06:36:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['a11yr', 06:36:47 INFO - 'ts_paint', 06:36:47 INFO - 'tpaint', 06:36:47 INFO - 'sessionrestore', 06:36:47 INFO - 'sessionrestore_no_auto_restore', 06:36:47 INFO - 'tabpaint']}, 06:36:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['tsvgx', 06:36:47 INFO - 'tsvgr_opacity', 06:36:47 INFO - 'tart', 06:36:47 INFO - 'tscrollx', 06:36:47 INFO - 'cart']}, 06:36:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:47 INFO - 'tsvgr_opacity', 06:36:47 INFO - 'tart', 06:36:47 INFO - 'tscrollx', 06:36:47 INFO - 'cart']}, 06:36:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'talos_options': ['--disable-e10s'], 06:36:47 INFO - 'tests': ['tp5o']}, 06:36:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'tests': ['tp5o']}, 06:36:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'talos_options': ['--disable-e10s', 06:36:47 INFO - '--xperf_path', 06:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:47 INFO - 'tests': ['tp5n']}, 06:36:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:47 INFO - 'talos_options': ['--xperf_path', 06:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:47 INFO - 'tests': ['tp5n']}}, 06:36:47 INFO - 'talos.zip': {'path': '', 06:36:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:47 INFO - Running post-action listener: _resource_record_post_action 06:36:47 INFO - ##### 06:36:47 INFO - ##### Running create-virtualenv step. 06:36:47 INFO - ##### 06:36:47 INFO - Running pre-action listener: _resource_record_pre_action 06:36:47 INFO - Running main action method: create_virtualenv 06:36:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:47 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:36:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:47 INFO - Using real prefix '/usr' 06:36:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:50 INFO - Installing pip.................done. 06:36:50 INFO - Return code: 0 06:36:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:50 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:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:50 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:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:50 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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:36:50 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:36:50 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:36:50 INFO - Using env: {'DISPLAY': ':0', 06:36:50 INFO - 'HOME': '/home/cltbld', 06:36:50 INFO - 'LANG': 'en_US.UTF-8', 06:36:50 INFO - 'LANGUAGE': 'en_US:en', 06:36:50 INFO - 'LOGNAME': 'cltbld', 06:36:50 INFO - 'MAIL': '/var/mail/cltbld', 06:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:50 INFO - 'MOZ_NO_REMOTE': '1', 06:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:50 INFO - 'NO_EM_RESTART': '1', 06:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:50 INFO - 'PWD': '/builds/slave/test', 06:36:50 INFO - 'SHELL': '/bin/bash', 06:36:50 INFO - 'SHLVL': '1', 06:36:50 INFO - 'TERM': 'linux', 06:36:50 INFO - 'TMOUT': '86400', 06:36:50 INFO - 'USER': 'cltbld', 06:36:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:50 INFO - '_': '/tools/buildbot/bin/python'} 06:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:51 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:36:51 INFO - Cleaning up... 06:36:51 INFO - Return code: 0 06:36:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:36:51 INFO - Using env: {'DISPLAY': ':0', 06:36:51 INFO - 'HOME': '/home/cltbld', 06:36:51 INFO - 'LANG': 'en_US.UTF-8', 06:36:51 INFO - 'LANGUAGE': 'en_US:en', 06:36:51 INFO - 'LOGNAME': 'cltbld', 06:36:51 INFO - 'MAIL': '/var/mail/cltbld', 06:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:51 INFO - 'MOZ_NO_REMOTE': '1', 06:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:51 INFO - 'NO_EM_RESTART': '1', 06:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:51 INFO - 'PWD': '/builds/slave/test', 06:36:51 INFO - 'SHELL': '/bin/bash', 06:36:51 INFO - 'SHLVL': '1', 06:36:51 INFO - 'TERM': 'linux', 06:36:51 INFO - 'TMOUT': '86400', 06:36:51 INFO - 'USER': 'cltbld', 06:36:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:51 INFO - '_': '/tools/buildbot/bin/python'} 06:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:51 INFO - Downloading/unpacking psutil>=0.7.1 06:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:53 INFO - Installing collected packages: psutil 06:36:53 INFO - Running setup.py install for psutil 06:36:53 INFO - building 'psutil._psutil_linux' extension 06:36:53 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:36:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:36:55 INFO - building 'psutil._psutil_posix' extension 06:36:55 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:36:55 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:36:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:55 INFO - Successfully installed psutil 06:36:55 INFO - Cleaning up... 06:36:55 INFO - Return code: 0 06:36:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:36:55 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:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:55 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:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:55 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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:36:55 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:36:55 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:36:55 INFO - Using env: {'DISPLAY': ':0', 06:36:55 INFO - 'HOME': '/home/cltbld', 06:36:55 INFO - 'LANG': 'en_US.UTF-8', 06:36:55 INFO - 'LANGUAGE': 'en_US:en', 06:36:55 INFO - 'LOGNAME': 'cltbld', 06:36:55 INFO - 'MAIL': '/var/mail/cltbld', 06:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:55 INFO - 'MOZ_NO_REMOTE': '1', 06:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:55 INFO - 'NO_EM_RESTART': '1', 06:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:55 INFO - 'PWD': '/builds/slave/test', 06:36:55 INFO - 'SHELL': '/bin/bash', 06:36:55 INFO - 'SHLVL': '1', 06:36:55 INFO - 'TERM': 'linux', 06:36:55 INFO - 'TMOUT': '86400', 06:36:55 INFO - 'USER': 'cltbld', 06:36:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:55 INFO - '_': '/tools/buildbot/bin/python'} 06:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:57 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:36:57 INFO - Installing collected packages: mozsystemmonitor 06:36:57 INFO - Running setup.py install for mozsystemmonitor 06:36:57 INFO - Successfully installed mozsystemmonitor 06:36:57 INFO - Cleaning up... 06:36:57 INFO - Return code: 0 06:36:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:36:57 INFO - Using env: {'DISPLAY': ':0', 06:36:57 INFO - 'HOME': '/home/cltbld', 06:36:57 INFO - 'LANG': 'en_US.UTF-8', 06:36:57 INFO - 'LANGUAGE': 'en_US:en', 06:36:57 INFO - 'LOGNAME': 'cltbld', 06:36:57 INFO - 'MAIL': '/var/mail/cltbld', 06:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:57 INFO - 'MOZ_NO_REMOTE': '1', 06:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:57 INFO - 'NO_EM_RESTART': '1', 06:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:57 INFO - 'PWD': '/builds/slave/test', 06:36:57 INFO - 'SHELL': '/bin/bash', 06:36:57 INFO - 'SHLVL': '1', 06:36:57 INFO - 'TERM': 'linux', 06:36:57 INFO - 'TMOUT': '86400', 06:36:57 INFO - 'USER': 'cltbld', 06:36:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:57 INFO - '_': '/tools/buildbot/bin/python'} 06:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:00 INFO - Downloading docopt-0.6.1.tar.gz 06:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:00 INFO - Running setup.py install for blobuploader 06:37:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:00 INFO - Running setup.py install for requests 06:37:01 INFO - Running setup.py install for docopt 06:37:01 INFO - Successfully installed blobuploader requests docopt 06:37:01 INFO - Cleaning up... 06:37:01 INFO - Return code: 0 06:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:01 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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:37:01 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:37:01 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:37:01 INFO - Using env: {'DISPLAY': ':0', 06:37:01 INFO - 'HOME': '/home/cltbld', 06:37:01 INFO - 'LANG': 'en_US.UTF-8', 06:37:01 INFO - 'LANGUAGE': 'en_US:en', 06:37:01 INFO - 'LOGNAME': 'cltbld', 06:37:01 INFO - 'MAIL': '/var/mail/cltbld', 06:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:01 INFO - 'MOZ_NO_REMOTE': '1', 06:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:01 INFO - 'NO_EM_RESTART': '1', 06:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:01 INFO - 'PWD': '/builds/slave/test', 06:37:01 INFO - 'SHELL': '/bin/bash', 06:37:01 INFO - 'SHLVL': '1', 06:37:01 INFO - 'TERM': 'linux', 06:37:01 INFO - 'TMOUT': '86400', 06:37:01 INFO - 'USER': 'cltbld', 06:37:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:01 INFO - '_': '/tools/buildbot/bin/python'} 06:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:01 INFO - Running setup.py (path:/tmp/pip-Xi8Oos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:01 INFO - Running setup.py (path:/tmp/pip-rhVhta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:01 INFO - Running setup.py (path:/tmp/pip-WMTU6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:01 INFO - Running setup.py (path:/tmp/pip-IYb0Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:01 INFO - Running setup.py (path:/tmp/pip-ybpBVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:01 INFO - Running setup.py (path:/tmp/pip-csfl5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:01 INFO - Running setup.py (path:/tmp/pip-vuzLxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:02 INFO - Running setup.py (path:/tmp/pip-dAcGCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:02 INFO - Running setup.py (path:/tmp/pip-JxpptM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:02 INFO - Running setup.py (path:/tmp/pip-EsZAjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:02 INFO - Running setup.py (path:/tmp/pip-h1z_hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:02 INFO - Running setup.py (path:/tmp/pip-xiWTxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:02 INFO - Running setup.py (path:/tmp/pip-dSaqMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:02 INFO - Running setup.py (path:/tmp/pip-3fWZay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:02 INFO - Running setup.py (path:/tmp/pip-IJ0ADT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:02 INFO - Running setup.py (path:/tmp/pip-iKXhOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:02 INFO - Running setup.py (path:/tmp/pip-0pSYzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:02 INFO - Running setup.py install for manifestparser 06:37:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Running setup.py install for mozcrash 06:37:02 INFO - Running setup.py install for mozdebug 06:37:03 INFO - Running setup.py install for mozdevice 06:37:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Running setup.py install for mozfile 06:37:03 INFO - Running setup.py install for mozhttpd 06:37:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Running setup.py install for mozinfo 06:37:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Running setup.py install for mozInstall 06:37:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Running setup.py install for mozleak 06:37:03 INFO - Running setup.py install for mozlog 06:37:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Running setup.py install for moznetwork 06:37:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:03 INFO - Running setup.py install for mozprocess 06:37:03 INFO - Running setup.py install for mozprofile 06:37:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:04 INFO - Running setup.py install for mozrunner 06:37:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:04 INFO - Running setup.py install for mozscreenshot 06:37:04 INFO - Running setup.py install for moztest 06:37:04 INFO - Running setup.py install for mozversion 06:37:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:04 INFO - Cleaning up... 06:37:04 INFO - Return code: 0 06:37:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37: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:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:04 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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:37:04 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:37:04 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:37:04 INFO - Using env: {'DISPLAY': ':0', 06:37:04 INFO - 'HOME': '/home/cltbld', 06:37:04 INFO - 'LANG': 'en_US.UTF-8', 06:37:04 INFO - 'LANGUAGE': 'en_US:en', 06:37:04 INFO - 'LOGNAME': 'cltbld', 06:37:04 INFO - 'MAIL': '/var/mail/cltbld', 06:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:04 INFO - 'MOZ_NO_REMOTE': '1', 06:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:04 INFO - 'NO_EM_RESTART': '1', 06:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:04 INFO - 'PWD': '/builds/slave/test', 06:37:04 INFO - 'SHELL': '/bin/bash', 06:37:04 INFO - 'SHLVL': '1', 06:37:04 INFO - 'TERM': 'linux', 06:37:04 INFO - 'TMOUT': '86400', 06:37:04 INFO - 'USER': 'cltbld', 06:37:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:04 INFO - '_': '/tools/buildbot/bin/python'} 06:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:04 INFO - Running setup.py (path:/tmp/pip-dVtjFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:04 INFO - Running setup.py (path:/tmp/pip-vLCjN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:04 INFO - Running setup.py (path:/tmp/pip-eKftEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:04 INFO - Running setup.py (path:/tmp/pip-OodSLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:05 INFO - Running setup.py (path:/tmp/pip-kerCnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:05 INFO - Running setup.py (path:/tmp/pip-8hh98d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:05 INFO - Running setup.py (path:/tmp/pip-gGv0lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:05 INFO - Running setup.py (path:/tmp/pip-wZr_ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:05 INFO - Running setup.py (path:/tmp/pip-3JAbG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:05 INFO - Running setup.py (path:/tmp/pip-x7pwQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:05 INFO - Running setup.py (path:/tmp/pip-QldIqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:05 INFO - Running setup.py (path:/tmp/pip-7qgesZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:05 INFO - Running setup.py (path:/tmp/pip-QGbJ4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:05 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:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:05 INFO - Running setup.py (path:/tmp/pip-zTmfK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:05 INFO - Running setup.py (path:/tmp/pip-zejFoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:05 INFO - Running setup.py (path:/tmp/pip-8cp2qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:05 INFO - Running setup.py (path:/tmp/pip-P3I2SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:07 INFO - Downloading blessings-1.6.tar.gz 06:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:08 INFO - Installing collected packages: blessings 06:37:08 INFO - Running setup.py install for blessings 06:37:08 INFO - Successfully installed blessings 06:37:08 INFO - Cleaning up... 06:37:08 INFO - Return code: 0 06:37:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:08 INFO - Reading from file tmpfile_stdout 06:37:08 INFO - Current package versions: 06:37:08 INFO - argparse == 1.2.1 06:37:08 INFO - blessings == 1.6 06:37:08 INFO - blobuploader == 1.2.4 06:37:08 INFO - docopt == 0.6.1 06:37:08 INFO - manifestparser == 1.1 06:37:08 INFO - mozInstall == 1.12 06:37:08 INFO - mozcrash == 0.17 06:37:08 INFO - mozdebug == 0.1 06:37:08 INFO - mozdevice == 0.48 06:37:08 INFO - mozfile == 1.2 06:37:08 INFO - mozhttpd == 0.7 06:37:08 INFO - mozinfo == 0.9 06:37:08 INFO - mozleak == 0.1 06:37:08 INFO - mozlog == 3.1 06:37:08 INFO - moznetwork == 0.27 06:37:08 INFO - mozprocess == 0.22 06:37:08 INFO - mozprofile == 0.28 06:37:08 INFO - mozrunner == 6.11 06:37:08 INFO - mozscreenshot == 0.1 06:37:08 INFO - mozsystemmonitor == 0.0 06:37:08 INFO - moztest == 0.7 06:37:08 INFO - mozversion == 1.4 06:37:08 INFO - psutil == 3.1.1 06:37:08 INFO - requests == 1.2.3 06:37:08 INFO - wsgiref == 0.1.2 06:37:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:37:08 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:37:08 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:37:08 INFO - Using env: {'DISPLAY': ':0', 06:37:08 INFO - 'HOME': '/home/cltbld', 06:37:08 INFO - 'LANG': 'en_US.UTF-8', 06:37:08 INFO - 'LANGUAGE': 'en_US:en', 06:37:08 INFO - 'LOGNAME': 'cltbld', 06:37:08 INFO - 'MAIL': '/var/mail/cltbld', 06:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:08 INFO - 'MOZ_NO_REMOTE': '1', 06:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:08 INFO - 'NO_EM_RESTART': '1', 06:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:08 INFO - 'PWD': '/builds/slave/test', 06:37:08 INFO - 'SHELL': '/bin/bash', 06:37:08 INFO - 'SHLVL': '1', 06:37:08 INFO - 'TERM': 'linux', 06:37:08 INFO - 'TMOUT': '86400', 06:37:08 INFO - 'USER': 'cltbld', 06:37:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:08 INFO - '_': '/tools/buildbot/bin/python'} 06:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 INFO - Cleaning up... 06:37:08 INFO - Return code: 0 06:37:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:37:08 INFO - Using env: {'DISPLAY': ':0', 06:37:08 INFO - 'HOME': '/home/cltbld', 06:37:08 INFO - 'LANG': 'en_US.UTF-8', 06:37:08 INFO - 'LANGUAGE': 'en_US:en', 06:37:08 INFO - 'LOGNAME': 'cltbld', 06:37:08 INFO - 'MAIL': '/var/mail/cltbld', 06:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:08 INFO - 'MOZ_NO_REMOTE': '1', 06:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:08 INFO - 'NO_EM_RESTART': '1', 06:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:08 INFO - 'PWD': '/builds/slave/test', 06:37:08 INFO - 'SHELL': '/bin/bash', 06:37:08 INFO - 'SHLVL': '1', 06:37:08 INFO - 'TERM': 'linux', 06:37:08 INFO - 'TMOUT': '86400', 06:37:08 INFO - 'USER': 'cltbld', 06:37:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:08 INFO - '_': '/tools/buildbot/bin/python'} 06:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:08 INFO - Downloading/unpacking jsonschema 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:10 INFO - Downloading/unpacking functools32 (from jsonschema) 06:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:11 INFO - warning: no files found matching '*.txt' 06:37:11 INFO - no previously-included directories found matching 'build' 06:37:11 INFO - no previously-included directories found matching 'dist' 06:37:11 INFO - no previously-included directories found matching '.git*' 06:37:11 INFO - Installing collected packages: jsonschema, functools32 06:37:11 INFO - Running setup.py install for functools32 06:37:11 INFO - warning: no files found matching '*.txt' 06:37:11 INFO - no previously-included directories found matching 'build' 06:37:11 INFO - no previously-included directories found matching 'dist' 06:37:11 INFO - no previously-included directories found matching '.git*' 06:37:11 INFO - Successfully installed jsonschema functools32 06:37:11 INFO - Cleaning up... 06:37:11 INFO - Return code: 0 06:37:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:37:11 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:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:11 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:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:11 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 0x7fbdedb9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', '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:37:11 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:37:11 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:37:11 INFO - Using env: {'DISPLAY': ':0', 06:37:11 INFO - 'HOME': '/home/cltbld', 06:37:11 INFO - 'LANG': 'en_US.UTF-8', 06:37:11 INFO - 'LANGUAGE': 'en_US:en', 06:37:11 INFO - 'LOGNAME': 'cltbld', 06:37:11 INFO - 'MAIL': '/var/mail/cltbld', 06:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:11 INFO - 'MOZ_NO_REMOTE': '1', 06:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:11 INFO - 'NO_EM_RESTART': '1', 06:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:11 INFO - 'PWD': '/builds/slave/test', 06:37:11 INFO - 'SHELL': '/bin/bash', 06:37:11 INFO - 'SHLVL': '1', 06:37:11 INFO - 'TERM': 'linux', 06:37:11 INFO - 'TMOUT': '86400', 06:37:11 INFO - 'USER': 'cltbld', 06:37:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:11 INFO - '_': '/tools/buildbot/bin/python'} 06:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:11 INFO - Downloading/unpacking flake8 06:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:37:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:37:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:15 INFO - no previously-included directories found matching 'docs/_build' 06:37:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:37:15 INFO - Running setup.py install for pep8 06:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:15 INFO - no previously-included directories found matching 'docs/_build' 06:37:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:37:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:37:15 INFO - Cleaning up... 06:37:15 INFO - Return code: 0 06:37:15 INFO - Running post-action listener: _resource_record_post_action 06:37:15 INFO - Running post-action listener: _start_resource_monitoring 06:37:15 INFO - Starting resource monitoring. 06:37:15 INFO - ##### 06:37:15 INFO - ##### Running install step. 06:37:15 INFO - ##### 06:37:15 INFO - Running pre-action listener: _resource_record_pre_action 06:37:15 INFO - Running main action method: install 06:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:15 INFO - Reading from file tmpfile_stdout 06:37:15 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:15 INFO - Reading from file tmpfile_stdout 06:37:15 INFO - Output received: 06:37:15 INFO - Usage: mozinstall [options] installer 06:37:15 INFO - Options: 06:37:15 INFO - -h, --help show this help message and exit 06:37:15 INFO - -d DEST, --destination=DEST 06:37:15 INFO - Directory to install application into. [default: 06:37:15 INFO - "/builds/slave/test"] 06:37:15 INFO - --app=APP Application being installed. [default: firefox] 06:37:15 INFO - mkdir: /builds/slave/test/build/application 06:37:15 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:37:15 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:37:29 INFO - Reading from file tmpfile_stdout 06:37:29 INFO - Output received: 06:37:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:37:29 INFO - Running post-action listener: _resource_record_post_action 06:37:29 INFO - ##### 06:37:29 INFO - ##### Running run-tests step. 06:37:29 INFO - ##### 06:37:29 INFO - Running pre-action listener: _resource_record_pre_action 06:37:29 INFO - Running main action method: run_tests 06:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:29 INFO - Python 2.7.3 06:37:29 INFO - Return code: 0 06:37:29 INFO - grabbing minidump binary from tooltool 06:37: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:37:29 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 0x294e410>, '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 0x294f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x294f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:29 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:37:29 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:37:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:29 INFO - Return code: 0 06:37:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:37:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:37:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:37:30 INFO - Return code: 0 06:37:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:37:30 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:37:30 INFO - Using env: {'DISPLAY': ':0', 06:37:30 INFO - 'HOME': '/home/cltbld', 06:37:30 INFO - 'LANG': 'en_US.UTF-8', 06:37:30 INFO - 'LANGUAGE': 'en_US:en', 06:37:30 INFO - 'LOGNAME': 'cltbld', 06:37:30 INFO - 'MAIL': '/var/mail/cltbld', 06:37:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:30 INFO - 'MOZ_NO_REMOTE': '1', 06:37:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:30 INFO - 'NO_EM_RESTART': '1', 06:37:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:30 INFO - 'PWD': '/builds/slave/test', 06:37:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:30 INFO - 'SHELL': '/bin/bash', 06:37:30 INFO - 'SHLVL': '1', 06:37:30 INFO - 'TERM': 'linux', 06:37:30 INFO - 'TMOUT': '86400', 06:37:30 INFO - 'USER': 'cltbld', 06:37:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521', 06:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:30 INFO - '_': '/tools/buildbot/bin/python'} 06:37:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:37:30 INFO - mozversion application_buildid: 20160714034942 06:37:30 INFO - mozversion application_changeset: 81f987b98a91032913ef201143e2e91db9b77bf7 06:37:30 INFO - mozversion application_display_name: Firefox 06:37:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:30 INFO - mozversion application_name: Firefox 06:37:30 INFO - mozversion application_remotingname: firefox 06:37:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:37:30 INFO - mozversion application_vendor: Mozilla 06:37:30 INFO - mozversion application_version: 48.0 06:37:30 INFO - mozversion platform_buildid: 20160714034942 06:37:30 INFO - mozversion platform_changeset: 81f987b98a91032913ef201143e2e91db9b77bf7 06:37:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:37:30 INFO - mozversion platform_version: 48.0 06:37:30 INFO - using testdate: 1468503450 06:37:30 INFO - actual date: 1468503450 06:37:30 INFO - starting webserver on 'localhost:44331' 06:37:30 INFO - SUITE-START | Running 2 tests 06:37:30 INFO - TEST-START | dromaeo_css 06:37:30 INFO - operating with platform_type : linux_ 06:37:30 INFO - Initialising browser for dromaeo_css test... 06:37:30 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN3IzTi/profile http://localhost:44331/getInfo.html) 06:37:36 INFO - PROCESS | 3315 | 06:37:36 INFO - PROCESS | 3315 | (process:3392): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:37:36 INFO - PROCESS | 3315 | __metrics Screen width/height:1600/1200 06:37:36 INFO - PROCESS | 3315 | colorDepth:24 06:37:36 INFO - PROCESS | 3315 | Browser inner width/height: 1024/697 06:37:36 INFO - PROCESS | 3315 | __metrics 06:37:37 ERROR - PROCESS | 3315 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:37:38 INFO - TEST-INFO | 3315: exit 0 06:37:38 INFO - Browser initialized. 06:37:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:38 INFO - TEST-INFO | started process 3442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN3IzTi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:40 INFO - PROCESS | 3442 | 06:37:40 INFO - PROCESS | 3442 | (process:3512): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:37:50 INFO - PROCESS | 3442 | RSS: Main: 150581248 06:37:50 INFO - PROCESS | 3442 | 06:38:39 INFO - PROCESS | 3442 | 1468503519763 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:40:47 INFO - PROCESS | 3442 | Cycle 1(1): loaded http://localhost:44331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44331/tests/dromaeo/cssquery-ext.html) 06:40:48 INFO - PROCESS | 3442 | RSS: Main: 154177536 06:40:48 INFO - PROCESS | 3442 | 06:43:49 INFO - PROCESS | 3442 | Cycle 1(1): loaded http://localhost:44331/tests/dromaeo/cssquery-ext.html (next: http://localhost:44331/tests/dromaeo/cssquery-jquery.html) 06:43:50 INFO - PROCESS | 3442 | RSS: Main: 152477696 06:43:50 INFO - PROCESS | 3442 | 06:46:52 INFO - PROCESS | 3442 | Cycle 1(1): loaded http://localhost:44331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44331/tests/dromaeo/cssquery-mootools.html) 06:46:52 INFO - PROCESS | 3442 | RSS: Main: 152010752 06:46:52 INFO - PROCESS | 3442 | 06:49:54 INFO - PROCESS | 3442 | Cycle 1(1): loaded http://localhost:44331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44331/tests/dromaeo/cssquery-prototype.html) 06:49:55 INFO - PROCESS | 3442 | RSS: Main: 153530368 06:49:55 INFO - PROCESS | 3442 | 06:52:57 INFO - PROCESS | 3442 | Cycle 1(1): loaded http://localhost:44331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44331/tests/dromaeo/cssquery-yui.html) 06:52:58 INFO - PROCESS | 3442 | RSS: Main: 152195072 06:52:58 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | Cycle 1(1): loaded http://localhost:44331/tests/dromaeo/cssquery-yui.html (next: http://localhost:44331/tests/dromaeo/cssquery-dojo.html) 06:56:00 INFO - PROCESS | 3442 | RSS: Main: 155971584 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | __start_tp_report 06:56:00 INFO - PROCESS | 3442 | _x_x_mozilla_page_load 06:56:00 INFO - PROCESS | 3442 | _x_x_mozilla_page_load_details 06:56:00 INFO - PROCESS | 3442 | |i|pagename|runs| 06:56:00 INFO - PROCESS | 3442 | |0;dojo.html;3318.452455344868;3340.6993370596642;3353.0443823510304;3365.9663403365957;3381.6618338166186;5474.589405794572;5508.724563771811;5518.227448157261;5534.114541673333;5545.362283337412;5480.205370221325;5481.698506582136;5499.972500137504;5515.145152501369;5521.751521181546;5013.197888337867;5027.2207807789855;5037.798488060474;5084.13569693153;5086.745662716868;5025.14572522672;5074.594032477411;5096.362954630671;5102.923456148161;5161.225816127592;5079;5118.795248190068;5120.564751996085;5121.66709163905;5138.229265610151;5127.48725127488;5131.384233891957;5139.331886854722;5141.711938187508;5168.121419358699;4938.407391113054;5017.623678224111;5041.747912604355;5064.11378008847;5068.062408454411;5380.91928621071;5395.757190926418;5403.108487099624;5405.135178371442;5405.729713514309;5814.738336774855;5861.267341582302;5862.706864656793;5870.943230218559;5912.9113063304085;5791.884162316772;5951.166836642873;5970.611910225822;6037.275526936795;6041.093835924603;5506;5506.421825708283;5507.394186639466;5507.504324610764;5516.972415137939;5941.168236446901;5945.7621695132575;5993.760249590055;6005.819825405245;6017.548683848729;5771.653700777967;5801.883962320814;5814.156947242626;5818.854528636733;5898.410158984153;5886.823395298148;5902.38025007368;5903.763849445974;5961.940380596138;5964.493018093511;5737.397573254748;5741.569382296345;5809.477147056785;5849.6782676952325;5872.647641141545;5821.563382746311;5849.356570777296;5858.882822343529;5882.02946513829;5911.142884281841;4491.820327186876;4496.145732310851;4507.954920450819;4523.25366314561;4526.637868970541;4017.91964160721;4022.637962583323;4064.288749468831;4080.489938757655;4115.012397024752;5409.702466364309;5682.090865461506;5706.087026075808;5768.134779782982;5802.680852553066;5927.347991720907;5980.880382392328;5982.461578457873;5986.6707331097205;5992.910106348409;5534.280543529316;5716.714164291769;5780.450857168562;5798.391168927286;5815.302163740378;4969.676970996874;5001;5001.799928002912;5010.958358238679;5049.444561098277;6147.569670123048;6204.561795957494;6213.906791398133;6217.502599792006;6218.782342617987;5915.08316210988;5923.674197919069;5934.732937017759;5958;5979.611325263844;6182.907256391248;6237.688115594111;6247.125402443752;6254.718537665725;6262.499000079892;5741.62679425836;5781.248437703071;5820.854478637899;5853.531717462678;5863.970680146572;5876.382979787232;5877;5878.970605146947;5887.264091988502;5892.410758924073;5724.914126288192;5727.914081288867;5730.971345143247;5731.054376027909;5731.168980497888;5686.317641882835;5698.943010569841;5755.856103597276;5771.480566749013;5850.882982340244;5618.2415373924;5620.85947851307;5637.718114094361;5640.379558248672;5642.463965923231;5682.6306290091015;5732.914006289826;5744.827655170351;5771.624844385102;5779.797707080232;5628.155776633538;5670.489655930986;5735.082386818089;5738.9139162913425;5769.624974376652 06:56:00 INFO - PROCESS | 3442 | |1;ext.html;592.731554473427;661.900714892766;669.6450881033052;683.7367613468816;696.923338432772;39046;40063;40087.99999999996;40096.398554021674;40176.59823401765;40822.183556328855;41392.172156556924;41448;41542.37686434698;41574;8652.740417787461;8895.199432051115;8904.643814247454;8906.821863562725;8924.732258032269;8659.826803463928;8941.418807777474;8989.685361012365;8997.820043599124;9012.954935225314;8923.73228803137;8987.505687187202;8993.14565116313;8997.775055623597;9030.142136497023;8832.955835220815;8910.064443233465;8922.643094276222;9018.774530636787;9047.502387368691;8889.955550222272;8937.865932011026;8970.102989700978;9010.098990101003;9044.683436079771;40533;41184.1763164735;41227.175456491;41232.79383603093;41361.1727765443;3905.5703872573995;3942.1918506706056;4020.035191554035;4106.486689163855;4165.604267594574;33319.333613327595;33795.83102084474;33836;33837.49243761321;34037.31925361504;4436.378906953029;4504.842330518449;4587.4036375271;4637.814487420499;4683.789229484647;315247;315679.264811028;315890;316714;317611;65205;65434;65497;65834;65886.34113658898;68575.65712171407;69221;69916.6504167476;70089;70125.2987470129;19196;19297.614047718966;19377.4186774397;19463;19471.610567788564;15023.474178403922;15090.924545377204;15135.924320378328;15142.697146057237;15181.089134651735;20685.27601533939;20878.164873404894;20939;20962.266320678704;21022.684659730116;6663.233728121231;6669.566478178903;6790.354916282945;6818.20452615273;6818.8636227276165;986.3835103060587;987.4420952162005;996.6960077176531;1076.8908024734535;1187.5071845184152;33736.831315843265;35239.04681021112;35417.82291088528;35949.82025089858;36821.0007222731;1166.7258194324327;1231.6674497885522;1239.8698136695698;1275.910686251972;1280.7438512297579;16966.321347146222;17084.145792710315;17332.566685832957;17348.3060677574;17385.391511297043;538506;586806;593234;593849;692618;63329.68335158295;64451;64521;64529.67735161388;64763.352366476676;1522.7182971150373;1532.2721707188996;1543.9768403473956;1578.195120488559;1591.4986779164526;32368;32692.173322818708;33076;33463;33874.66125338715;54593.72703136618;54659.45340546703;55369.72315138399;55433;55448;454000;456299;456663;457504;458507;31127.688723113384;31325;31518.369632606762;31816.522752158275;31872.203194919384;48861;49372.50627493823;49917.50082499274;50472.747636261585;50552.74723626358;41466.1706765869;41971.790141049096;42490.1501969965;42865.14269714526;44299;41313.58686413218;41314.79342603268;41667.1666566673;42541.36187957245;43100.56899430966;43098.353524697784;44065.339019914085;44185.779071104436;44627.33059004183;44700.32949505825;34123;35904.28191436105;36651.45022824713;36692.63307366999;36705.63294367022;28123.156305310873;29040.854795726733;29138.854305728335;29269;29385.85307073451 06:56:00 INFO - PROCESS | 3442 | |2;jquery.html;436.73795722566456;440.47803353026666;441.11556329559227;447.0450323362573;448.41705782482774;18904.90547547264;18965.525861853443;19323;19427.514312142168;19589.608207835834;19423.514412139702;19942;20269.898650506762;20656.07047682854;20783.376498705024;5654.943450565494;5790.189373487715;5968.194293770329;5971.850703732398;5973.970130149365;5502.257195278647;5802;5811.099279611646;5849.210356601868;5900.055991041434;5661.264035675356;5826.038703613898;5853.004989151833;5853.941460585404;5858.53131749459;5972.19375384324;5981.491573216282;5982.341942386334;6004.609700369506;6022.247219097613;5811.186433899257;5813.6802475863815;5825.737841797087;5840.15317778924;5907.616004959664;13943.163410195319;14315.856841431556;14347.71304573913;14468.421263149461;17306.567335816704;2382.452036031705;2419.2621250518587;2440.841345312549;2506.2105436787356;2533.4679717259396;10411.791764164751;10655.680329590046;10723.517441715063;12473.50105995759;14835.742509629205;2064.7935206479383;2093.7382827146607;2120.321497120922;2137.754158271803;2146.162996431393;78559;79242;81275.18724812794;81901.18098819055;81981;11473.885261147281;11528.193026488065;11665.825012624817;11668.183227174186;12011.579594714143;16266.430674926321;16280.104594247194;16288.674226515403;16321.265543050591;16399;9041.141091596288;9080.22818060459;9151.359404841598;9257.722268331961;9436.395812711855;9292.72121836346;9375.249980001583;9398.389104708309;9463.479508627091;9505.192058674951;5033.144365457881;5149.922751158736;5175.741212939338;5214.139666954986;5239.214117882272;2062.6905964105504;2156.2129822614634;2159.5033142377342;2177.782221777841;2183.792539708725;956.1872408452759;1005.6681295172575;1047.7852040331713;1115.9609413670482;1125.487903004131;18650.90674546646;19025.90487047556;19047.1428785705;19314.806851931582;19755.111020004133;1058.9258751887294;1065.957361705523;1093.3221402730198;1098.1983152298708;1128.2440764687678;10669.89330106689;11003.17476189289;11156.944215279034;11197.552097916156;11210;496218;502727;506613;506918;510785;92071;92661;93320.53339733258;93942.53028734813;94677;1112.010310823368;1124.100719424457;1152;1171.812509998396;1176.746999395117;16457.259423326217;16577.83422165811;16712.66574668524;16924.32302707878;16972.49082527526;31327.686723132476;37238.8138059308;37631.62368376281;38048.23903521859;38367.42448863325;58292.708536457045;59789.402105978384;60040.69979650074;60060.09909851443;60133;8874.245689116238;9059.728208153765;9109.908900910907;9189;9197.678081267124;9783;13357.398917048951;13453.865461345653;13614.18314901109;13766.587002389944;11427.542898284308;11457.942710286396;11499.655010349703;11581.189316748083;11918.880811192124;11504.25222360544;11684.591039313584;11722.238054526428;12069.27584344942;12339.876601234231;11934;11943.701407464536;12073.698157546132;12128.09039322072;12507.312097834707;8841.469511829311;8936.329775267011;8948.552572371225;8979.191872731486;9106.726798196065;10841.512131953923;11824.349660768741;11872.703182420508;11921.52313907434;12044.578439754567 06:56:00 INFO - PROCESS | 3442 | |3;mootools.html;1562.851529104735;1583.8099428068633;1802.2160360243295;1905.8856468611893;1912.7895931447547;7753.457257991943;8278.420510564263;8477.660893564258;8678.305735541157;8688.522131282785;8482.321414286858;8583.828323433543;8586.91413085869;8606.655733770658;8628.611712472939;2504.3238325652064;2516.4338023944647;2530.734272901337;2537.746225377466;2537.8984840606445;2426.660267562534;2470.3824043989002;2474.604063349864;2479.0331770609478;2479.1075212923333;2463.790577800889;2489.6887889013874;2497.0386401235564;2499.237732491589;2505.1482495951373;2460.963085553718;2468.1978357033945;2476.777090061894;2488.1789009626777;2491.040949234558;2480.1567467061104;2486.7015958084967;2489.987550062256;2494.5634513960167;2533.3539947313316;8646.827063458759;8740.038595754462;8752.47485150893;8795.032546419889;8806.86789698155;5265.104932161542;5397.892042159135;5411.269478620376;5433.565314774848;5436.293281873371;3590.407582748843;3596.047047532406;3680.2271522980204;3810;3819.732618716691;1191.0888170549536;1199.232491205629;1207.1007099710685;1214.4959841665698;1257.0823298991788;12346.876531234753;12368;12375.566855160116;12376.195547289397;12384.380780960915;4858.004109157614;4940.901181976412;4956.4547899731;5001.124803159432;5030.647854650139;10540.104091152185;10546.26176167661;10567.577296908192;10567.894321056845;10571.20715946307;5620.859478512988;5631.577631677641;5631.633943793722;5637.3235211774845;5665.603407761417;4965.428975667773;5106.234064890222;5112.258722485219;5148.588112950955;5159.1229490986625;3960.782156981336;4004.7797371144866;4053.7162398632404;4063.6139566741113;4121.793910304473;1188.0436248819783;1193.3854065156452;1216.0514798457218;1219.530480764912;1264.4499642655474;1000;1003.5684655598017;1009.6668099527138;1012.9442880641635;1026.7484466305802;5930.495907847881;5951.166836642873;5993.220881285405;6059.21230240066;6128.1114238435175;493.88393727474016;494.0884068892887;515.7807931629043;517.1467079319153;518.1502336168686;3987.860424885115;4053.310937140693;4076.2458945095254;4085.7344272622186;4134.669226461936;10495.737606559744;11047.668569942914;11098.334099954029;11126.332420054823;11202.047825934724;10713.196510261761;10867.836982445111;10996.615118470816;11020.779584408427;11080.833787493195;8454.957725211458;8459.280961118375;8479.321654267767;8552.358573106918;8572.314214862921;5838.678872662044;5856.560757943086;5878.29460464747;5953.047512397996;6049.243844519435;9597.47213903242;9690.321677482509;9736.9026309736;9834.262430317613;9895.55470003866;9776.560054797694;9828;10085.394876307446;10105.343152695052;10273.229507786797;7201.279872012757;7335.816604584928;7356.77929662111;7574.621268936421;7655.196204398458;8050.074241462306;8085.514869107872;8090.838183236185;8107.756767296991;8134.511929284262;7132;7365.705371785069;7393.593352365671;7592;7616.466847320635;7006.124234470692;7056.435485161277;7100.254473280231;7164.641767911688;7270.236625154283;6933.306669333027;6938.548994315353;7001;7005.579665220103;7010.4041156500225;4955;4955.331030310862;4991.575716064175;5006.824761133343;5082.33929589151;5115.002574498086;5141.820036298712;5166.095933211598;5229.137192363218;5248.2390053442805 06:56:00 INFO - PROCESS | 3442 | |4;prototype.html;366.57477326301495;367.3076251266363;367.746255083992;372.3372397133104;376.4034006100331;6322.7470901164015;6377.075324078006;6382.425581697652;6447.387498187671;6471.838204044901;6336.461400780928;6401.583897046688;6465.579737317083;6488.545801793876;6508.056331831882;4993.25101234815;5010.448850626428;5018.874528136807;5025.04524140414;5026.723530205837;5017.448080711137;5022;5028.874278143057;5030.11972904742;5039.218921067222;4976.950230497703;4982.975085124569;4991.450940396553;4995.400551933773;4998.350214472113;4890.706557606537;4924.729139897304;4959.900801983977;4991.126552853254;5000.19996800512;4355.390245365651;4380.408644832939;4383.49589797171;4384.123175364908;4399.956000439986;6198.721057552421;6199.62802231863;6215.316315205324;6220.222472190976;6222.3466536013975;5655.519280861132;5752.9424705753245;5758.136279558058;5766.394528574523;5813.825585232407;6834.316568343126;6844.110265665481;6844.4182244509275;6852.349026842442;6860.862782744317;4859.246816743411;4879.56083952446;4884.633652476078;4891.755412229374;4900.485449027872;7067.22260551339;7130.893036604455;7136.179339375934;7138.393236574845;7144.857102857914;4875.926861097087;4973.8010479581135;5016.523430274118;5020.071286811878;5023.095842748267;4975.975120124449;5048.368953880765;5055.974720126376;5060.544550990428;5080.263361812516;5789.392113828072;5822;5822.359540450547;5835.241418615553;5835.708214589254;6864.279250678607;6916.930830691729;6918.515703900779;6920.204176519664;6927.688254028581;1783.5986902946734;1800.9369672061414;1803.0894398329021;1805.268866109228;1812.7280907863926;1185.875483074282;1190.7023244188954;1197.0662882951312;1199.4242763473408;1218.0085560109108;6595.670216489157;6632.834179145463;6651.933480665228;6665.266820649725;6666.366695163952;7018.543794653331;7027.543209691354;7040.577565346096;7060.3292687194635;7060.858782824417;6638.502112341594;6639.136912201479;6645.568038077607;6655;6656.267810540837;3744.3260213161348;3773.7924414156937;3779.848806047727;3803.2885201659365;3830.540335159799;7424.554526728413;7454.2545745426105;7503.62481875904;7545.056867891513;7555.16893141754;7301.963490182515;7310.232425595343;7318.707251709979;7326.67029983652;7338.376238019828;7482.1021477423055;7502.774916752506;7509.286617771303;7518.962405187939;7523.774286771296;6992.16094068715;7050.048243487064;7108.466864985044;7123.25205853378;7137.857242855218;6995.405390541861;7008.894866576903;7010.964945175241;7014.859702805813;7015.824604384931;7499;7503.737369192052;7504;7513.248675132661;7521.548707077593;4843.055604157296;4900.558949694545;4906.215005599087;4908.484609116134;4915.238138088602;6929.445644348541;7114.964425177841;7117.8576428470105;7122.5726456412785;7136.6788494518905;6852.486063545154;6855.245922948372;6891.586504809728;6892.379685828299;6902.482313826383;6822.079019332326;6850.691718872563;6869.450443964371;6884.552504087218;6885.758998435031;6721.663916804238;6760;6760.898586521108;6766.560173588701;6774.3225677431865;6805.353491418307;6934.687939042856;6943.826404339932;6948.722051117898;6959.234484206834;6666.899996500153;6706.195256569243;6713.328667133248;6720.697568609522;6722.6638668065425 06:56:00 INFO - PROCESS | 3442 | |5;yui.html;855.777497850559;896.3008853094589;912.3795818843186;926.2219735422244;951.7858481841591;15100.924495377536;15114.395424183032;15686.450974215904;15709.921450392732;15798.131102789328;14019.859801401983;14043.5084772033;14065;14120.43518259271;14133;889.3996552327186;904.3443503459988;911.0115524655756;917.1745429113818;920.6409500294891;929.1312622697766;933.3979583168853;933.4585940154728;934.3039435620439;935.9064093590655;952.5142177489496;957.3824882950493;957.8467445208768;959.0505399654327;959.0888655777005;952.4285428742699;953.0659953245788;954.298590535959;955.2596737528436;956.2063487305554;699.7375984005997;701.9789406317818;703.5180901082723;705.4532737128715;707.1690763353091;15676.529704108894;15763.527094187193;15812.683746325125;15829.60425989348;15846;14956.925215373962;15020.624484387869;15096.622584435367;15163.24183790817;15196.924015379853;11828.172027958046;11882.40587970598;12587.559435419716;12655.240685558803;12784.041196910175;3956.742811717258;3980.243753686819;3988.6011398860173;4086.244044851712;4156.418101465797;60964;61258.69370653163;61486.69256653688;61896;62477.37522624761;10267.332623379456;10413;10428.530716117793;10564.260501764802;10723.678289651323;20533.794662053486;20735;20742.792572074388;20784;20825.1669933204;8578.270846977952;8624.310055195694;8667.826643467222;8691.652333906573;8743.344249181337;5015.498450154955;5034.0686972910125;5063.924041139386;5065.189569668835;5087.567556757643;3526.7354948378975;3598.9640103599154;3601.3157500074904;3608.242269123461;3626.9455958160647;673.2762280548333;673.5049738442241;678.1116737074449;681.6830173969128;683.2552517755571;684.5584597934404;752.2890868129674;822.321584692631;831.6049876308826;832.9416940814206;9538.61845526185;9839.803203936024;9984.35101718386;10079.244056695778;10289.176865850714;642.8521440068811;775;811.4117264982958;819.6147810529042;822.461287856443;4513.142502924434;4657.4876763555985;4754.857354279377;4774.904501909942;4858.878528036827;68723.65638171877;69342.95985560221;69471;69499;69506;59443;59853.70073149694;60106.69946650239;62885.427864302845;63342;53269.2009619856;53327.20009199865;53424;54111.188332175836;54229.1865622016;9454.480003599869;9608;9657.951710241685;9668.129868311886;9796.216302695624;39599.80200098981;39657.603423966546;39861.40207896942;41173;41618.79190604028;46392;46862.53137468718;52389.7380513095;52805;53365.73317133389;10729.624463143753;11233.32600044;12829;12903.741925161257;13310.935125190155;14028.649283767987;14284.285785710881;14320.355583998537;14772.77840832367;15422.46021389291;13432.39554220082;13606.86393136056;13696.3836627354;14061.578152655436;14108.224047677477;13085.214887106804;13371.665708357368;13471.730565388832;13533.526326578916;13987.860121398655;13184.143030702973;13262.801057983945;13369.866301336862;13467.191968481922;13541.864581354454;11103.833442498531;11375.601853935073;11406.82889756671;11495.48270327854;11682.76634467323;10658.200634952254;10853.34879907208;10897.073748731447;11048.447577621248;11056.336619802838 06:56:00 INFO - PROCESS | 3442 | __end_tp_report 06:56:00 INFO - PROCESS | 3442 | __start_cc_report 06:56:00 INFO - PROCESS | 3442 | _x_x_mozilla_cycle_collect,341 06:56:00 INFO - PROCESS | 3442 | __end_cc_report 06:56:00 INFO - PROCESS | 3442 | __startTimestamp1468504560575__endTimestamp 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | ------- Summary: start ------- 06:56:00 INFO - PROCESS | 3442 | Number of tests: 6 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | [#0] dojo.html Cycles:165 Average:5500.21 Median:5730.97 stddev:603.83 (10.5%) stddev-sans-first:580.92 06:56:00 INFO - PROCESS | 3442 | Values: 3318.5 3340.7 3353.0 3366.0 3381.7 5474.6 5508.7 5518.2 5534.1 5545.4 5480.2 5481.7 5500.0 5515.1 5521.8 5013.2 5027.2 5037.8 5084.1 5086.7 5025.1 5074.6 5096.4 5102.9 5161.2 5079.0 5118.8 5120.6 5121.7 5138.2 5127.5 5131.4 5139.3 5141.7 5168.1 4938.4 5017.6 5041.7 5064.1 5068.1 5380.9 5395.8 5403.1 5405.1 5405.7 5814.7 5861.3 5862.7 5870.9 5912.9 5791.9 5951.2 5970.6 6037.3 6041.1 5506.0 5506.4 5507.4 5507.5 5517.0 5941.2 5945.8 5993.8 6005.8 6017.5 5771.7 5801.9 5814.2 5818.9 5898.4 5886.8 5902.4 5903.8 5961.9 5964.5 5737.4 5741.6 5809.5 5849.7 5872.6 5821.6 5849.4 5858.9 5882.0 5911.1 4491.8 4496.1 4508.0 4523.3 4526.6 4017.9 4022.6 4064.3 4080.5 4115.0 5409.7 5682.1 5706.1 5768.1 5802.7 5927.3 5980.9 5982.5 5986.7 5992.9 5534.3 5716.7 5780.5 5798.4 5815.3 4969.7 5001.0 5001.8 5011.0 5049.4 6147.6 6204.6 6213.9 6217.5 6218.8 5915.1 5923.7 5934.7 5958.0 5979.6 6182.9 6237.7 6247.1 6254.7 6262.5 5741.6 5781.2 5820.9 5853.5 5864.0 5876.4 5877.0 5879.0 5887.3 5892.4 5724.9 5727.9 5731.0 5731.1 5731.2 5686.3 5698.9 5755.9 5771.5 5850.9 5618.2 5620.9 5637.7 5640.4 5642.5 5682.6 5732.9 5744.8 5771.6 5779.8 5628.2 5670.5 5735.1 5738.9 5769.6 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | [#1] ext.html Cycles:180 Average:62924.89 Median:41819.48 stddev:125897.36 (301.0%) stddev-sans-first:126163.55 06:56:00 INFO - PROCESS | 3442 | Values: 592.7 661.9 669.6 683.7 696.9 39046.0 40063.0 40088.0 40096.4 40176.6 40822.2 41392.2 41448.0 41542.4 41574.0 8652.7 8895.2 8904.6 8906.8 8924.7 8659.8 8941.4 8989.7 8997.8 9013.0 8923.7 8987.5 8993.1 8997.8 9030.1 8833.0 8910.1 8922.6 9018.8 9047.5 8890.0 8937.9 8970.1 9010.1 9044.7 40533.0 41184.2 41227.2 41232.8 41361.2 3905.6 3942.2 4020.0 4106.5 4165.6 33319.3 33795.8 33836.0 33837.5 34037.3 4436.4 4504.8 4587.4 4637.8 4683.8 315247.0 315679.3 315890.0 316714.0 317611.0 65205.0 65434.0 65497.0 65834.0 65886.3 68575.7 69221.0 69916.7 70089.0 70125.3 19196.0 19297.6 19377.4 19463.0 19471.6 15023.5 15090.9 15135.9 15142.7 15181.1 20685.3 20878.2 20939.0 20962.3 21022.7 6663.2 6669.6 6790.4 6818.2 6818.9 986.4 987.4 996.7 1076.9 1187.5 33736.8 35239.0 35417.8 35949.8 36821.0 1166.7 1231.7 1239.9 1275.9 1280.7 16966.3 17084.1 17332.6 17348.3 17385.4 538506.0 586806.0 593234.0 593849.0 692618.0 63329.7 64451.0 64521.0 64529.7 64763.4 1522.7 1532.3 1544.0 1578.2 1591.5 32368.0 32692.2 33076.0 33463.0 33874.7 54593.7 54659.5 55369.7 55433.0 55448.0 454000.0 456299.0 456663.0 457504.0 458507.0 31127.7 31325.0 31518.4 31816.5 31872.2 48861.0 49372.5 49917.5 50472.7 50552.7 41466.2 41971.8 42490.2 42865.1 44299.0 41313.6 41314.8 41667.2 42541.4 43100.6 43098.4 44065.3 44185.8 44627.3 44700.3 34123.0 35904.3 36651.5 36692.6 36705.6 28123.2 29040.9 29138.9 29269.0 29385.9 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | [#2] jquery.html Cycles:180 Average:29373.14 Median:2168.64 stddev:83120.39 (3832.8%) stddev-sans-first:83325.17 06:56:00 INFO - PROCESS | 3442 | Values: 436.7 440.5 441.1 447.0 448.4 18904.9 18965.5 19323.0 19427.5 19589.6 19423.5 19942.0 20269.9 20656.1 20783.4 5654.9 5790.2 5968.2 5971.9 5974.0 5502.3 5802.0 5811.1 5849.2 5900.1 5661.3 5826.0 5853.0 5853.9 5858.5 5972.2 5981.5 5982.3 6004.6 6022.2 5811.2 5813.7 5825.7 5840.2 5907.6 13943.2 14315.9 14347.7 14468.4 17306.6 2382.5 2419.3 2440.8 2506.2 2533.5 10411.8 10655.7 10723.5 12473.5 14835.7 2064.8 2093.7 2120.3 2137.8 2146.2 78559.0 79242.0 81275.2 81901.2 81981.0 11473.9 11528.2 11665.8 11668.2 12011.6 16266.4 16280.1 16288.7 16321.3 16399.0 9041.1 9080.2 9151.4 9257.7 9436.4 9292.7 9375.2 9398.4 9463.5 9505.2 5033.1 5149.9 5175.7 5214.1 5239.2 2062.7 2156.2 2159.5 2177.8 2183.8 956.2 1005.7 1047.8 1116.0 1125.5 18650.9 19025.9 19047.1 19314.8 19755.1 1058.9 1066.0 1093.3 1098.2 1128.2 10669.9 11003.2 11156.9 11197.6 11210.0 496218.0 502727.0 506613.0 506918.0 510785.0 92071.0 92661.0 93320.5 93942.5 94677.0 1112.0 1124.1 1152.0 1171.8 1176.7 16457.3 16577.8 16712.7 16924.3 16972.5 31327.7 37238.8 37631.6 38048.2 38367.4 58292.7 59789.4 60040.7 60060.1 60133.0 8874.2 9059.7 9109.9 9189.0 9197.7 9783.0 13357.4 13453.9 13614.2 13766.6 11427.5 11457.9 11499.7 11581.2 11918.9 11504.3 11684.6 11722.2 12069.3 12339.9 11934.0 11943.7 12073.7 12128.1 12507.3 8841.5 8936.3 8948.6 8979.2 9106.7 10841.5 11824.3 11872.7 11921.5 12044.6 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | [#3] mootools.html Cycles:180 Average:5806.05 Median:4978.50 stddev:3232.27 (64.9%) stddev-sans-first:3225.61 06:56:00 INFO - PROCESS | 3442 | Values: 1562.9 1583.8 1802.2 1905.9 1912.8 7753.5 8278.4 8477.7 8678.3 8688.5 8482.3 8583.8 8586.9 8606.7 8628.6 2504.3 2516.4 2530.7 2537.7 2537.9 2426.7 2470.4 2474.6 2479.0 2479.1 2463.8 2489.7 2497.0 2499.2 2505.1 2461.0 2468.2 2476.8 2488.2 2491.0 2480.2 2486.7 2490.0 2494.6 2533.4 8646.8 8740.0 8752.5 8795.0 8806.9 5265.1 5397.9 5411.3 5433.6 5436.3 3590.4 3596.0 3680.2 3810.0 3819.7 1191.1 1199.2 1207.1 1214.5 1257.1 12346.9 12368.0 12375.6 12376.2 12384.4 4858.0 4940.9 4956.5 5001.1 5030.6 10540.1 10546.3 10567.6 10567.9 10571.2 5620.9 5631.6 5631.6 5637.3 5665.6 4965.4 5106.2 5112.3 5148.6 5159.1 3960.8 4004.8 4053.7 4063.6 4121.8 1188.0 1193.4 1216.1 1219.5 1264.4 1000.0 1003.6 1009.7 1012.9 1026.7 5930.5 5951.2 5993.2 6059.2 6128.1 493.9 494.1 515.8 517.1 518.2 3987.9 4053.3 4076.2 4085.7 4134.7 10495.7 11047.7 11098.3 11126.3 11202.0 10713.2 10867.8 10996.6 11020.8 11080.8 8455.0 8459.3 8479.3 8552.4 8572.3 5838.7 5856.6 5878.3 5953.0 6049.2 9597.5 9690.3 9736.9 9834.3 9895.6 9776.6 9828.0 10085.4 10105.3 10273.2 7201.3 7335.8 7356.8 7574.6 7655.2 8050.1 8085.5 8090.8 8107.8 8134.5 7132.0 7365.7 7393.6 7592.0 7616.5 7006.1 7056.4 7100.3 7164.6 7270.2 6933.3 6938.5 7001.0 7005.6 7010.4 4955.0 4955.3 4991.6 5006.8 5082.3 5115.0 5141.8 5166.1 5229.1 5248.2 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | [#4] prototype.html Cycles:180 Average:5785.77 Median:6614.25 stddev:1731.12 (26.2%) stddev-sans-first:1687.52 06:56:00 INFO - PROCESS | 3442 | Values: 366.6 367.3 367.7 372.3 376.4 6322.7 6377.1 6382.4 6447.4 6471.8 6336.5 6401.6 6465.6 6488.5 6508.1 4993.3 5010.4 5018.9 5025.0 5026.7 5017.4 5022.0 5028.9 5030.1 5039.2 4977.0 4983.0 4991.5 4995.4 4998.4 4890.7 4924.7 4959.9 4991.1 5000.2 4355.4 4380.4 4383.5 4384.1 4400.0 6198.7 6199.6 6215.3 6220.2 6222.3 5655.5 5752.9 5758.1 5766.4 5813.8 6834.3 6844.1 6844.4 6852.3 6860.9 4859.2 4879.6 4884.6 4891.8 4900.5 7067.2 7130.9 7136.2 7138.4 7144.9 4875.9 4973.8 5016.5 5020.1 5023.1 4976.0 5048.4 5056.0 5060.5 5080.3 5789.4 5822.0 5822.4 5835.2 5835.7 6864.3 6916.9 6918.5 6920.2 6927.7 1783.6 1800.9 1803.1 1805.3 1812.7 1185.9 1190.7 1197.1 1199.4 1218.0 6595.7 6632.8 6651.9 6665.3 6666.4 7018.5 7027.5 7040.6 7060.3 7060.9 6638.5 6639.1 6645.6 6655.0 6656.3 3744.3 3773.8 3779.8 3803.3 3830.5 7424.6 7454.3 7503.6 7545.1 7555.2 7302.0 7310.2 7318.7 7326.7 7338.4 7482.1 7502.8 7509.3 7519.0 7523.8 6992.2 7050.0 7108.5 7123.3 7137.9 6995.4 7008.9 7011.0 7014.9 7015.8 7499.0 7503.7 7504.0 7513.2 7521.5 4843.1 4900.6 4906.2 4908.5 4915.2 6929.4 7115.0 7117.9 7122.6 7136.7 6852.5 6855.2 6891.6 6892.4 6902.5 6822.1 6850.7 6869.5 6884.6 6885.8 6721.7 6760.0 6760.9 6766.6 6774.3 6805.4 6934.7 6943.8 6948.7 6959.2 6666.9 6706.2 6713.3 6720.7 6722.7 06:56:00 INFO - PROCESS | 3442 | 06:56:00 INFO - PROCESS | 3442 | [#5] yui.html Cycles:180 Average:16205.75 Median:25808.69 stddev:19101.76 (74.0%) stddev-sans-first:19120.57 06:56:00 INFO - PROCESS | 3442 | Values: 855.8 896.3 912.4 926.2 951.8 15100.9 15114.4 15686.5 15709.9 15798.1 14019.9 14043.5 14065.0 14120.4 14133.0 889.4 904.3 911.0 917.2 920.6 929.1 933.4 933.5 934.3 935.9 952.5 957.4 957.8 959.1 959.1 952.4 953.1 954.3 955.3 956.2 699.7 702.0 703.5 705.5 707.2 15676.5 15763.5 15812.7 15829.6 15846.0 14956.9 15020.6 15096.6 15163.2 15196.9 11828.2 11882.4 12587.6 12655.2 12784.0 3956.7 3980.2 3988.6 4086.2 4156.4 60964.0 61258.7 61486.7 61896.0 62477.4 10267.3 10413.0 10428.5 10564.3 10723.7 20533.8 20735.0 20742.8 20784.0 20825.2 8578.3 8624.3 8667.8 8691.7 8743.3 5015.5 5034.1 5063.9 5065.2 5087.6 3526.7 3599.0 3601.3 3608.2 3626.9 673.3 673.5 678.1 681.7 683.3 684.6 752.3 822.3 831.6 832.9 9538.6 9839.8 9984.4 10079.2 10289.2 642.9 775.0 811.4 819.6 822.5 4513.1 4657.5 4754.9 4774.9 4858.9 68723.7 69343.0 69471.0 69499.0 69506.0 59443.0 59853.7 60106.7 62885.4 63342.0 53269.2 53327.2 53424.0 54111.2 54229.2 9454.5 9608.0 9658.0 9668.1 9796.2 39599.8 39657.6 39861.4 41173.0 41618.8 46392.0 46862.5 52389.7 52805.0 53365.7 10729.6 11233.3 12829.0 12903.7 13310.9 14028.6 14284.3 14320.4 14772.8 15422.5 13432.4 13606.9 13696.4 14061.6 14108.2 13085.2 13371.7 13471.7 13533.5 13987.9 13184.1 13262.8 13369.9 13467.2 13541.9 11103.8 11375.6 11406.8 11495.5 11682.8 10658.2 10853.3 10897.1 11048.4 11056.3 06:56:00 INFO - PROCESS | 3442 | -------- Summary: end -------- 06:56:00 INFO - PROCESS | 3442 | 06:56:01 INFO - TEST-INFO | 3442: exit 0 06:56:01 INFO - TEST-OK | dromaeo_css | took 1110677ms 06:56:01 INFO - TEST-START | kraken 06:56:01 INFO - operating with platform_type : linux_ 06:56:01 INFO - Initialising browser for kraken test... 06:56:01 INFO - TEST-INFO | started process 3685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIHYT3o/profile http://localhost:44331/getInfo.html) 06:56:04 INFO - PROCESS | 3685 | 06:56:04 INFO - PROCESS | 3685 | (process:3762): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:56:05 INFO - PROCESS | 3685 | __metrics Screen width/height:1600/1200 06:56:05 INFO - PROCESS | 3685 | colorDepth:24 06:56:05 INFO - PROCESS | 3685 | Browser inner width/height: 1024/697 06:56:05 INFO - PROCESS | 3685 | __metrics 06:56:06 ERROR - PROCESS | 3685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:56:07 INFO - TEST-INFO | 3685: exit 0 06:56:07 INFO - Browser initialized. 06:56:07 INFO - Running cycle 1/1 for kraken test... 06:56:07 INFO - TEST-INFO | started process 3813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIHYT3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:08 INFO - PROCESS | 3813 | 06:56:08 INFO - PROCESS | 3813 | (process:3880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:56:18 INFO - PROCESS | 3813 | RSS: Main: 150491136 06:56:18 INFO - PROCESS | 3813 | 06:56:21 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44331/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:22 INFO - PROCESS | 3813 | RSS: Main: 156151808 06:56:22 INFO - PROCESS | 3813 | 06:56:24 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44331/tests/kraken/driver.html?testName=audio-dft) 06:56:25 INFO - PROCESS | 3813 | RSS: Main: 155828224 06:56:25 INFO - PROCESS | 3813 | 06:56:28 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44331/tests/kraken/driver.html?testName=audio-fft) 06:56:29 INFO - PROCESS | 3813 | RSS: Main: 156459008 06:56:29 INFO - PROCESS | 3813 | 06:56:31 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44331/tests/kraken/driver.html?testName=audio-oscillator) 06:56:31 INFO - PROCESS | 3813 | RSS: Main: 156319744 06:56:31 INFO - PROCESS | 3813 | 06:56:33 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:34 INFO - PROCESS | 3813 | RSS: Main: 156094464 06:56:34 INFO - PROCESS | 3813 | 06:56:37 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44331/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:38 INFO - PROCESS | 3813 | RSS: Main: 156598272 06:56:38 INFO - PROCESS | 3813 | 06:56:41 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44331/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:42 INFO - PROCESS | 3813 | RSS: Main: 156422144 06:56:42 INFO - PROCESS | 3813 | 06:56:44 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44331/tests/kraken/driver.html?testName=json-parse-financial) 06:56:45 INFO - PROCESS | 3813 | RSS: Main: 156160000 06:56:45 INFO - PROCESS | 3813 | 06:56:47 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:47 INFO - PROCESS | 3813 | RSS: Main: 155897856 06:56:47 INFO - PROCESS | 3813 | 06:56:49 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:49 INFO - PROCESS | 3813 | RSS: Main: 156028928 06:56:49 INFO - PROCESS | 3813 | 06:56:52 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:52 INFO - PROCESS | 3813 | RSS: Main: 156532736 06:56:52 INFO - PROCESS | 3813 | 06:56:55 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:55 INFO - PROCESS | 3813 | RSS: Main: 156901376 06:56:55 INFO - PROCESS | 3813 | 06:56:58 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:59 INFO - PROCESS | 3813 | RSS: Main: 157409280 06:56:59 INFO - PROCESS | 3813 | 06:57:00 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44331/tests/kraken/driver.html?testName=ai-astar) 06:57:01 INFO - PROCESS | 3813 | RSS: Main: 158146560 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | __start_tp_report 06:57:01 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 06:57:01 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 06:57:01 INFO - PROCESS | 3813 | |i|pagename|runs| 06:57:01 INFO - PROCESS | 3813 | |0;ai-astar;108;112;104;110;111;113;101;111;110;112 06:57:01 INFO - PROCESS | 3813 | |1;audio-beat-detection;152;137;163;171;128;158;157;135;174;134 06:57:01 INFO - PROCESS | 3813 | |2;audio-dft;160;162;163;160;161;163;162;160;160;163 06:57:01 INFO - PROCESS | 3813 | |3;audio-fft;76;74;76;169;74;76;78;77;171;76 06:57:01 INFO - PROCESS | 3813 | |4;audio-oscillator;92;92;155;93;93;92;141;95;93;142 06:57:01 INFO - PROCESS | 3813 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:57:01 INFO - PROCESS | 3813 | |6;imaging-darkroom;146;148;146;147;147;147;146;147;146;145 06:57:01 INFO - PROCESS | 3813 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;94 06:57:01 INFO - PROCESS | 3813 | |8;json-parse-financial;59;55;60;66;56;56;60;74;55;55 06:57:01 INFO - PROCESS | 3813 | |9;json-stringify-tinderbox;59;59;59;59;59;59;58;62;58;59 06:57:01 INFO - PROCESS | 3813 | |10;stanford-crypto-aes;74;74;73;81;82;81;74;74;74;74 06:57:01 INFO - PROCESS | 3813 | |11;stanford-crypto-ccm;115;115;122;115;121;119;117;119;134;133 06:57:01 INFO - PROCESS | 3813 | |12;stanford-crypto-pbkdf2;162;160;158;162;159;166;163;158;162;154 06:57:01 INFO - PROCESS | 3813 | |13;stanford-crypto-sha256-iterative;68;65;70;68;67;66;66;65;69;68 06:57:01 INFO - PROCESS | 3813 | __end_tp_report 06:57:01 INFO - PROCESS | 3813 | __start_cc_report 06:57:01 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,831 06:57:01 INFO - PROCESS | 3813 | __end_cc_report 06:57:01 INFO - PROCESS | 3813 | __startTimestamp1468504621198__endTimestamp 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | ------- Summary: start ------- 06:57:01 INFO - PROCESS | 3813 | Number of tests: 14 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.85 (3.5%) stddev-sans-first:4.06 06:57:01 INFO - PROCESS | 3813 | Values: 108.0 112.0 104.0 110.0 111.0 113.0 101.0 111.0 110.0 112.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:157.50 stddev:16.43 (10.4%) stddev-sans-first:17.42 06:57:01 INFO - PROCESS | 3813 | Values: 152.0 137.0 163.0 171.0 128.0 158.0 157.0 135.0 174.0 134.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.33 06:57:01 INFO - PROCESS | 3813 | Values: 160.0 162.0 163.0 160.0 161.0 163.0 162.0 160.0 160.0 163.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.71 (52.2%) stddev-sans-first:41.54 06:57:01 INFO - PROCESS | 3813 | Values: 76.0 74.0 76.0 169.0 74.0 76.0 78.0 77.0 171.0 76.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.50 stddev:25.95 (28.1%) stddev-sans-first:26.80 06:57:01 INFO - PROCESS | 3813 | Values: 92.0 92.0 155.0 93.0 93.0 92.0 141.0 95.0 93.0 142.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:57:01 INFO - PROCESS | 3813 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 06:57:01 INFO - PROCESS | 3813 | Values: 146.0 148.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 145.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:57:01 INFO - PROCESS | 3813 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:6.13 (10.3%) stddev-sans-first:6.50 06:57:01 INFO - PROCESS | 3813 | Values: 59.0 55.0 60.0 66.0 56.0 56.0 60.0 74.0 55.0 55.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:1.10 (1.9%) stddev-sans-first:1.17 06:57:01 INFO - PROCESS | 3813 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 58.0 62.0 58.0 59.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:74.00 stddev:3.63 (4.9%) stddev-sans-first:3.77 06:57:01 INFO - PROCESS | 3813 | Values: 74.0 74.0 73.0 81.0 82.0 81.0 74.0 74.0 74.0 74.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.00 stddev:7.04 (5.9%) stddev-sans-first:7.12 06:57:01 INFO - PROCESS | 3813 | Values: 115.0 115.0 122.0 115.0 121.0 119.0 117.0 119.0 134.0 133.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:162.00 stddev:3.34 (2.1%) stddev-sans-first:3.49 06:57:01 INFO - PROCESS | 3813 | Values: 162.0 160.0 158.0 162.0 159.0 166.0 163.0 158.0 162.0 154.0 06:57:01 INFO - PROCESS | 3813 | 06:57:01 INFO - PROCESS | 3813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.69 (2.5%) stddev-sans-first:1.76 06:57:01 INFO - PROCESS | 3813 | Values: 68.0 65.0 70.0 68.0 67.0 66.0 66.0 65.0 69.0 68.0 06:57:01 INFO - PROCESS | 3813 | -------- Summary: end -------- 06:57:01 INFO - PROCESS | 3813 | 06:57:02 INFO - TEST-INFO | 3813: exit 0 06:57:02 INFO - TEST-OK | kraken | took 60862ms 06:57:02 INFO - SUITE-END | took 1171s 06:57:02 INFO - Completed test suite (00:19:31) 06:57:02 INFO - javascript benchmark 06:57:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.452455344868, 3340.6993370596642, 3353.0443823510304, 3365.9663403365957, 3381.6618338166186, 5474.589405794572, 5508.724563771811, 5518.227448157261, 5534.114541673333, 5545.362283337412, 5480.205370221325, 5481.698506582136, 5499.972500137504, 5515.145152501369, 5521.751521181546, 5013.197888337867, 5027.2207807789855, 5037.798488060474, 5084.13569693153, 5086.745662716868, 5025.14572522672, 5074.594032477411, 5096.362954630671, 5102.923456148161, 5161.225816127592, 5079.0, 5118.795248190068, 5120.564751996085, 5121.66709163905, 5138.229265610151, 5127.48725127488, 5131.384233891957, 5139.331886854722, 5141.711938187508, 5168.121419358699, 4938.407391113054, 5017.623678224111, 5041.747912604355, 5064.11378008847, 5068.062408454411, 5380.91928621071, 5395.757190926418, 5403.108487099624, 5405.135178371442, 5405.729713514309, 5814.738336774855, 5861.267341582302, 5862.706864656793, 5870.943230218559, 5912.9113063304085, 5791.884162316772, 5951.166836642873, 5970.611910225822, 6037.275526936795, 6041.093835924603, 5506.0, 5506.421825708283, 5507.394186639466, 5507.504324610764, 5516.972415137939, 5941.168236446901, 5945.7621695132575, 5993.760249590055, 6005.819825405245, 6017.548683848729, 5771.653700777967, 5801.883962320814, 5814.156947242626, 5818.854528636733, 5898.410158984153, 5886.823395298148, 5902.38025007368, 5903.763849445974, 5961.940380596138, 5964.493018093511, 5737.397573254748, 5741.569382296345, 5809.477147056785, 5849.6782676952325, 5872.647641141545, 5821.563382746311, 5849.356570777296, 5858.882822343529, 5882.02946513829, 5911.142884281841, 4491.820327186876, 4496.145732310851, 4507.954920450819, 4523.25366314561, 4526.637868970541, 4017.91964160721, 4022.637962583323, 4064.288749468831, 4080.489938757655, 4115.012397024752, 5409.702466364309, 5682.090865461506, 5706.087026075808, 5768.134779782982, 5802.680852553066, 5927.347991720907, 5980.880382392328, 5982.461578457873, 5986.6707331097205, 5992.910106348409, 5534.280543529316, 5716.714164291769, 5780.450857168562, 5798.391168927286, 5815.302163740378, 4969.676970996874, 5001.0, 5001.799928002912, 5010.958358238679, 5049.444561098277, 6147.569670123048, 6204.561795957494, 6213.906791398133, 6217.502599792006, 6218.782342617987, 5915.08316210988, 5923.674197919069, 5934.732937017759, 5958.0, 5979.611325263844, 6182.907256391248, 6237.688115594111, 6247.125402443752, 6254.718537665725, 6262.499000079892, 5741.62679425836, 5781.248437703071, 5820.854478637899, 5853.531717462678, 5863.970680146572, 5876.382979787232, 5877.0, 5878.970605146947, 5887.264091988502, 5892.410758924073, 5724.914126288192, 5727.914081288867, 5730.971345143247, 5731.054376027909, 5731.168980497888, 5686.317641882835, 5698.943010569841, 5755.856103597276, 5771.480566749013, 5850.882982340244, 5618.2415373924, 5620.85947851307, 5637.718114094361, 5640.379558248672, 5642.463965923231, 5682.6306290091015, 5732.914006289826, 5744.827655170351, 5771.624844385102, 5779.797707080232, 5628.155776633538, 5670.489655930986, 5735.082386818089, 5738.9139162913425, 5769.624974376652], "value": 5461.548718329795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.731554473427, 661.900714892766, 669.6450881033052, 683.7367613468816, 696.923338432772, 39046.0, 40063.0, 40087.99999999996, 40096.398554021674, 40176.59823401765, 40822.183556328855, 41392.172156556924, 41448.0, 41542.37686434698, 41574.0, 8652.740417787461, 8895.199432051115, 8904.643814247454, 8906.821863562725, 8924.732258032269, 8659.826803463928, 8941.418807777474, 8989.685361012365, 8997.820043599124, 9012.954935225314, 8923.73228803137, 8987.505687187202, 8993.14565116313, 8997.775055623597, 9030.142136497023, 8832.955835220815, 8910.064443233465, 8922.643094276222, 9018.774530636787, 9047.502387368691, 8889.955550222272, 8937.865932011026, 8970.102989700978, 9010.098990101003, 9044.683436079771, 40533.0, 41184.1763164735, 41227.175456491, 41232.79383603093, 41361.1727765443, 3905.5703872573995, 3942.1918506706056, 4020.035191554035, 4106.486689163855, 4165.604267594574, 33319.333613327595, 33795.83102084474, 33836.0, 33837.49243761321, 34037.31925361504, 4436.378906953029, 4504.842330518449, 4587.4036375271, 4637.814487420499, 4683.789229484647, 315247.0, 315679.264811028, 315890.0, 316714.0, 317611.0, 65205.0, 65434.0, 65497.0, 65834.0, 65886.34113658898, 68575.65712171407, 69221.0, 69916.6504167476, 70089.0, 70125.2987470129, 19196.0, 19297.614047718966, 19377.4186774397, 19463.0, 19471.610567788564, 15023.474178403922, 15090.924545377204, 15135.924320378328, 15142.697146057237, 15181.089134651735, 20685.27601533939, 20878.164873404894, 20939.0, 20962.266320678704, 21022.684659730116, 6663.233728121231, 6669.566478178903, 6790.354916282945, 6818.20452615273, 6818.8636227276165, 986.3835103060587, 987.4420952162005, 996.6960077176531, 1076.8908024734535, 1187.5071845184152, 33736.831315843265, 35239.04681021112, 35417.82291088528, 35949.82025089858, 36821.0007222731, 1166.7258194324327, 1231.6674497885522, 1239.8698136695698, 1275.910686251972, 1280.7438512297579, 16966.321347146222, 17084.145792710315, 17332.566685832957, 17348.3060677574, 17385.391511297043, 538506.0, 586806.0, 593234.0, 593849.0, 692618.0, 63329.68335158295, 64451.0, 64521.0, 64529.67735161388, 64763.352366476676, 1522.7182971150373, 1532.2721707188996, 1543.9768403473956, 1578.195120488559, 1591.4986779164526, 32368.0, 32692.173322818708, 33076.0, 33463.0, 33874.66125338715, 54593.72703136618, 54659.45340546703, 55369.72315138399, 55433.0, 55448.0, 454000.0, 456299.0, 456663.0, 457504.0, 458507.0, 31127.688723113384, 31325.0, 31518.369632606762, 31816.522752158275, 31872.203194919384, 48861.0, 49372.50627493823, 49917.50082499274, 50472.747636261585, 50552.74723626358, 41466.1706765869, 41971.790141049096, 42490.1501969965, 42865.14269714526, 44299.0, 41313.58686413218, 41314.79342603268, 41667.1666566673, 42541.36187957245, 43100.56899430966, 43098.353524697784, 44065.339019914085, 44185.779071104436, 44627.33059004183, 44700.32949505825, 34123.0, 35904.28191436105, 36651.45022824713, 36692.63307366999, 36705.63294367022, 28123.156305310873, 29040.854795726733, 29138.854305728335, 29269.0, 29385.85307073451], "value": 21118.293107324556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.73795722566456, 440.47803353026666, 441.11556329559227, 447.0450323362573, 448.41705782482774, 18904.90547547264, 18965.525861853443, 19323.0, 19427.514312142168, 19589.608207835834, 19423.514412139702, 19942.0, 20269.898650506762, 20656.07047682854, 20783.376498705024, 5654.943450565494, 5790.189373487715, 5968.194293770329, 5971.850703732398, 5973.970130149365, 5502.257195278647, 5802.0, 5811.099279611646, 5849.210356601868, 5900.055991041434, 5661.264035675356, 5826.038703613898, 5853.004989151833, 5853.941460585404, 5858.53131749459, 5972.19375384324, 5981.491573216282, 5982.341942386334, 6004.609700369506, 6022.247219097613, 5811.186433899257, 5813.6802475863815, 5825.737841797087, 5840.15317778924, 5907.616004959664, 13943.163410195319, 14315.856841431556, 14347.71304573913, 14468.421263149461, 17306.567335816704, 2382.452036031705, 2419.2621250518587, 2440.841345312549, 2506.2105436787356, 2533.4679717259396, 10411.791764164751, 10655.680329590046, 10723.517441715063, 12473.50105995759, 14835.742509629205, 2064.7935206479383, 2093.7382827146607, 2120.321497120922, 2137.754158271803, 2146.162996431393, 78559.0, 79242.0, 81275.18724812794, 81901.18098819055, 81981.0, 11473.885261147281, 11528.193026488065, 11665.825012624817, 11668.183227174186, 12011.579594714143, 16266.430674926321, 16280.104594247194, 16288.674226515403, 16321.265543050591, 16399.0, 9041.141091596288, 9080.22818060459, 9151.359404841598, 9257.722268331961, 9436.395812711855, 9292.72121836346, 9375.249980001583, 9398.389104708309, 9463.479508627091, 9505.192058674951, 5033.144365457881, 5149.922751158736, 5175.741212939338, 5214.139666954986, 5239.214117882272, 2062.6905964105504, 2156.2129822614634, 2159.5033142377342, 2177.782221777841, 2183.792539708725, 956.1872408452759, 1005.6681295172575, 1047.7852040331713, 1115.9609413670482, 1125.487903004131, 18650.90674546646, 19025.90487047556, 19047.1428785705, 19314.806851931582, 19755.111020004133, 1058.9258751887294, 1065.957361705523, 1093.3221402730198, 1098.1983152298708, 1128.2440764687678, 10669.89330106689, 11003.17476189289, 11156.944215279034, 11197.552097916156, 11210.0, 496218.0, 502727.0, 506613.0, 506918.0, 510785.0, 92071.0, 92661.0, 93320.53339733258, 93942.53028734813, 94677.0, 1112.010310823368, 1124.100719424457, 1152.0, 1171.812509998396, 1176.746999395117, 16457.259423326217, 16577.83422165811, 16712.66574668524, 16924.32302707878, 16972.49082527526, 31327.686723132476, 37238.8138059308, 37631.62368376281, 38048.23903521859, 38367.42448863325, 58292.708536457045, 59789.402105978384, 60040.69979650074, 60060.09909851443, 60133.0, 8874.245689116238, 9059.728208153765, 9109.908900910907, 9189.0, 9197.678081267124, 9783.0, 13357.398917048951, 13453.865461345653, 13614.18314901109, 13766.587002389944, 11427.542898284308, 11457.942710286396, 11499.655010349703, 11581.189316748083, 11918.880811192124, 11504.25222360544, 11684.591039313584, 11722.238054526428, 12069.27584344942, 12339.876601234231, 11934.0, 11943.701407464536, 12073.698157546132, 12128.09039322072, 12507.312097834707, 8841.469511829311, 8936.329775267011, 8948.552572371225, 8979.191872731486, 9106.726798196065, 10841.512131953923, 11824.349660768741, 11872.703182420508, 11921.52313907434, 12044.578439754567], "value": 9495.265926499078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.851529104735, 1583.8099428068633, 1802.2160360243295, 1905.8856468611893, 1912.7895931447547, 7753.457257991943, 8278.420510564263, 8477.660893564258, 8678.305735541157, 8688.522131282785, 8482.321414286858, 8583.828323433543, 8586.91413085869, 8606.655733770658, 8628.611712472939, 2504.3238325652064, 2516.4338023944647, 2530.734272901337, 2537.746225377466, 2537.8984840606445, 2426.660267562534, 2470.3824043989002, 2474.604063349864, 2479.0331770609478, 2479.1075212923333, 2463.790577800889, 2489.6887889013874, 2497.0386401235564, 2499.237732491589, 2505.1482495951373, 2460.963085553718, 2468.1978357033945, 2476.777090061894, 2488.1789009626777, 2491.040949234558, 2480.1567467061104, 2486.7015958084967, 2489.987550062256, 2494.5634513960167, 2533.3539947313316, 8646.827063458759, 8740.038595754462, 8752.47485150893, 8795.032546419889, 8806.86789698155, 5265.104932161542, 5397.892042159135, 5411.269478620376, 5433.565314774848, 5436.293281873371, 3590.407582748843, 3596.047047532406, 3680.2271522980204, 3810.0, 3819.732618716691, 1191.0888170549536, 1199.232491205629, 1207.1007099710685, 1214.4959841665698, 1257.0823298991788, 12346.876531234753, 12368.0, 12375.566855160116, 12376.195547289397, 12384.380780960915, 4858.004109157614, 4940.901181976412, 4956.4547899731, 5001.124803159432, 5030.647854650139, 10540.104091152185, 10546.26176167661, 10567.577296908192, 10567.894321056845, 10571.20715946307, 5620.859478512988, 5631.577631677641, 5631.633943793722, 5637.3235211774845, 5665.603407761417, 4965.428975667773, 5106.234064890222, 5112.258722485219, 5148.588112950955, 5159.1229490986625, 3960.782156981336, 4004.7797371144866, 4053.7162398632404, 4063.6139566741113, 4121.793910304473, 1188.0436248819783, 1193.3854065156452, 1216.0514798457218, 1219.530480764912, 1264.4499642655474, 1000.0, 1003.5684655598017, 1009.6668099527138, 1012.9442880641635, 1026.7484466305802, 5930.495907847881, 5951.166836642873, 5993.220881285405, 6059.21230240066, 6128.1114238435175, 493.88393727474016, 494.0884068892887, 515.7807931629043, 517.1467079319153, 518.1502336168686, 3987.860424885115, 4053.310937140693, 4076.2458945095254, 4085.7344272622186, 4134.669226461936, 10495.737606559744, 11047.668569942914, 11098.334099954029, 11126.332420054823, 11202.047825934724, 10713.196510261761, 10867.836982445111, 10996.615118470816, 11020.779584408427, 11080.833787493195, 8454.957725211458, 8459.280961118375, 8479.321654267767, 8552.358573106918, 8572.314214862921, 5838.678872662044, 5856.560757943086, 5878.29460464747, 5953.047512397996, 6049.243844519435, 9597.47213903242, 9690.321677482509, 9736.9026309736, 9834.262430317613, 9895.55470003866, 9776.560054797694, 9828.0, 10085.394876307446, 10105.343152695052, 10273.229507786797, 7201.279872012757, 7335.816604584928, 7356.77929662111, 7574.621268936421, 7655.196204398458, 8050.074241462306, 8085.514869107872, 8090.838183236185, 8107.756767296991, 8134.511929284262, 7132.0, 7365.705371785069, 7393.593352365671, 7592.0, 7616.466847320635, 7006.124234470692, 7056.435485161277, 7100.254473280231, 7164.641767911688, 7270.236625154283, 6933.306669333027, 6938.548994315353, 7001.0, 7005.579665220103, 7010.4041156500225, 4955.0, 4955.331030310862, 4991.575716064175, 5006.824761133343, 5082.33929589151, 5115.002574498086, 5141.820036298712, 5166.095933211598, 5229.137192363218, 5248.2390053442805], "value": 4641.33761341319, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.57477326301495, 367.3076251266363, 367.746255083992, 372.3372397133104, 376.4034006100331, 6322.7470901164015, 6377.075324078006, 6382.425581697652, 6447.387498187671, 6471.838204044901, 6336.461400780928, 6401.583897046688, 6465.579737317083, 6488.545801793876, 6508.056331831882, 4993.25101234815, 5010.448850626428, 5018.874528136807, 5025.04524140414, 5026.723530205837, 5017.448080711137, 5022.0, 5028.874278143057, 5030.11972904742, 5039.218921067222, 4976.950230497703, 4982.975085124569, 4991.450940396553, 4995.400551933773, 4998.350214472113, 4890.706557606537, 4924.729139897304, 4959.900801983977, 4991.126552853254, 5000.19996800512, 4355.390245365651, 4380.408644832939, 4383.49589797171, 4384.123175364908, 4399.956000439986, 6198.721057552421, 6199.62802231863, 6215.316315205324, 6220.222472190976, 6222.3466536013975, 5655.519280861132, 5752.9424705753245, 5758.136279558058, 5766.394528574523, 5813.825585232407, 6834.316568343126, 6844.110265665481, 6844.4182244509275, 6852.349026842442, 6860.862782744317, 4859.246816743411, 4879.56083952446, 4884.633652476078, 4891.755412229374, 4900.485449027872, 7067.22260551339, 7130.893036604455, 7136.179339375934, 7138.393236574845, 7144.857102857914, 4875.926861097087, 4973.8010479581135, 5016.523430274118, 5020.071286811878, 5023.095842748267, 4975.975120124449, 5048.368953880765, 5055.974720126376, 5060.544550990428, 5080.263361812516, 5789.392113828072, 5822.0, 5822.359540450547, 5835.241418615553, 5835.708214589254, 6864.279250678607, 6916.930830691729, 6918.515703900779, 6920.204176519664, 6927.688254028581, 1783.5986902946734, 1800.9369672061414, 1803.0894398329021, 1805.268866109228, 1812.7280907863926, 1185.875483074282, 1190.7023244188954, 1197.0662882951312, 1199.4242763473408, 1218.0085560109108, 6595.670216489157, 6632.834179145463, 6651.933480665228, 6665.266820649725, 6666.366695163952, 7018.543794653331, 7027.543209691354, 7040.577565346096, 7060.3292687194635, 7060.858782824417, 6638.502112341594, 6639.136912201479, 6645.568038077607, 6655.0, 6656.267810540837, 3744.3260213161348, 3773.7924414156937, 3779.848806047727, 3803.2885201659365, 3830.540335159799, 7424.554526728413, 7454.2545745426105, 7503.62481875904, 7545.056867891513, 7555.16893141754, 7301.963490182515, 7310.232425595343, 7318.707251709979, 7326.67029983652, 7338.376238019828, 7482.1021477423055, 7502.774916752506, 7509.286617771303, 7518.962405187939, 7523.774286771296, 6992.16094068715, 7050.048243487064, 7108.466864985044, 7123.25205853378, 7137.857242855218, 6995.405390541861, 7008.894866576903, 7010.964945175241, 7014.859702805813, 7015.824604384931, 7499.0, 7503.737369192052, 7504.0, 7513.248675132661, 7521.548707077593, 4843.055604157296, 4900.558949694545, 4906.215005599087, 4908.484609116134, 4915.238138088602, 6929.445644348541, 7114.964425177841, 7117.8576428470105, 7122.5726456412785, 7136.6788494518905, 6852.486063545154, 6855.245922948372, 6891.586504809728, 6892.379685828299, 6902.482313826383, 6822.079019332326, 6850.691718872563, 6869.450443964371, 6884.552504087218, 6885.758998435031, 6721.663916804238, 6760.0, 6760.898586521108, 6766.560173588701, 6774.3225677431865, 6805.353491418307, 6934.687939042856, 6943.826404339932, 6948.722051117898, 6959.234484206834, 6666.899996500153, 6706.195256569243, 6713.328667133248, 6720.697568609522, 6722.6638668065425], "value": 5226.729901838536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.777497850559, 896.3008853094589, 912.3795818843186, 926.2219735422244, 951.7858481841591, 15100.924495377536, 15114.395424183032, 15686.450974215904, 15709.921450392732, 15798.131102789328, 14019.859801401983, 14043.5084772033, 14065.0, 14120.43518259271, 14133.0, 889.3996552327186, 904.3443503459988, 911.0115524655756, 917.1745429113818, 920.6409500294891, 929.1312622697766, 933.3979583168853, 933.4585940154728, 934.3039435620439, 935.9064093590655, 952.5142177489496, 957.3824882950493, 957.8467445208768, 959.0505399654327, 959.0888655777005, 952.4285428742699, 953.0659953245788, 954.298590535959, 955.2596737528436, 956.2063487305554, 699.7375984005997, 701.9789406317818, 703.5180901082723, 705.4532737128715, 707.1690763353091, 15676.529704108894, 15763.527094187193, 15812.683746325125, 15829.60425989348, 15846.0, 14956.925215373962, 15020.624484387869, 15096.622584435367, 15163.24183790817, 15196.924015379853, 11828.172027958046, 11882.40587970598, 12587.559435419716, 12655.240685558803, 12784.041196910175, 3956.742811717258, 3980.243753686819, 3988.6011398860173, 4086.244044851712, 4156.418101465797, 60964.0, 61258.69370653163, 61486.69256653688, 61896.0, 62477.37522624761, 10267.332623379456, 10413.0, 10428.530716117793, 10564.260501764802, 10723.678289651323, 20533.794662053486, 20735.0, 20742.792572074388, 20784.0, 20825.1669933204, 8578.270846977952, 8624.310055195694, 8667.826643467222, 8691.652333906573, 8743.344249181337, 5015.498450154955, 5034.0686972910125, 5063.924041139386, 5065.189569668835, 5087.567556757643, 3526.7354948378975, 3598.9640103599154, 3601.3157500074904, 3608.242269123461, 3626.9455958160647, 673.2762280548333, 673.5049738442241, 678.1116737074449, 681.6830173969128, 683.2552517755571, 684.5584597934404, 752.2890868129674, 822.321584692631, 831.6049876308826, 832.9416940814206, 9538.61845526185, 9839.803203936024, 9984.35101718386, 10079.244056695778, 10289.176865850714, 642.8521440068811, 775.0, 811.4117264982958, 819.6147810529042, 822.461287856443, 4513.142502924434, 4657.4876763555985, 4754.857354279377, 4774.904501909942, 4858.878528036827, 68723.65638171877, 69342.95985560221, 69471.0, 69499.0, 69506.0, 59443.0, 59853.70073149694, 60106.69946650239, 62885.427864302845, 63342.0, 53269.2009619856, 53327.20009199865, 53424.0, 54111.188332175836, 54229.1865622016, 9454.480003599869, 9608.0, 9657.951710241685, 9668.129868311886, 9796.216302695624, 39599.80200098981, 39657.603423966546, 39861.40207896942, 41173.0, 41618.79190604028, 46392.0, 46862.53137468718, 52389.7380513095, 52805.0, 53365.73317133389, 10729.624463143753, 11233.32600044, 12829.0, 12903.741925161257, 13310.935125190155, 14028.649283767987, 14284.285785710881, 14320.355583998537, 14772.77840832367, 15422.46021389291, 13432.39554220082, 13606.86393136056, 13696.3836627354, 14061.578152655436, 14108.224047677477, 13085.214887106804, 13371.665708357368, 13471.730565388832, 13533.526326578916, 13987.860121398655, 13184.143030702973, 13262.801057983945, 13369.866301336862, 13467.191968481922, 13541.864581354454, 11103.833442498531, 11375.601853935073, 11406.82889756671, 11495.48270327854, 11682.76634467323, 10658.200634952254, 10853.34879907208, 10897.073748731447, 11048.447577621248, 11056.336619802838], "value": 7313.417409451174, "unit": "score"}], "name": "dromaeo_css", "value": 7610.604167865034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 104.0, 110.0, 111.0, 113.0, 101.0, 111.0, 110.0, 112.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 137.0, 163.0, 171.0, 128.0, 158.0, 157.0, 135.0, 174.0, 134.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 160.0, 161.0, 163.0, 162.0, 160.0, 160.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 169.0, 74.0, 76.0, 78.0, 77.0, 171.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 93.0, 93.0, 92.0, 141.0, 95.0, 93.0, 142.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 60.0, 66.0, 56.0, 56.0, 60.0, 74.0, 55.0, 55.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 62.0, 58.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 81.0, 82.0, 81.0, 74.0, 74.0, 74.0, 74.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 122.0, 115.0, 121.0, 119.0, 117.0, 119.0, 134.0, 133.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 158.0, 162.0, 159.0, 166.0, 163.0, 158.0, 162.0, 154.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 70.0, 68.0, 67.0, 66.0, 66.0, 65.0, 69.0, 68.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1526.8999999999999, "alertThreshold": 2.0}]} 06:57:02 INFO - Return code: 0 06:57:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:57:02 ERROR - # TBPL SUCCESS # 06:57:02 INFO - Running post-action listener: _resource_record_post_action 06:57:02 INFO - Running post-run listener: _resource_record_post_run 06:57:03 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 7667712; Write bytes: 350048256; Read time: 2036; Write time: 342204 06:57:03 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 5672960; Read time: 0; Write time: 5576 06:57:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5906432; Write bytes: 344018944; Read time: 1980; Write time: 336608 06:57:03 INFO - Running post-run listener: _upload_blobber_files 06:57:03 INFO - Blob upload gear active. 06:57:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:57:03 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'] 06:57:03 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 06:57:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:57:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:04 INFO - (blobuploader) - INFO - Done attempting. 06:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:05 INFO - (blobuploader) - INFO - Done attempting. 06:57:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:05 INFO - Return code: 0 06:57:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341a611ec889ace04fd2b506f5c8df3c7e5633d4e8aeb144b5df26a2b0d3b99f9bde23607786c2ac698db0ce3fc72861e38642f39d9bec67826c9dde5a6fb19c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01c2b08d9e587db5764a29fce2f4aad1e60f6eff5468825057c3b8c06776300762156d4fb86bbcc7124109380921edee92049760b27a605846139bb39bfdbdf7"} 06:57:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:05 INFO - Contents: 06:57:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341a611ec889ace04fd2b506f5c8df3c7e5633d4e8aeb144b5df26a2b0d3b99f9bde23607786c2ac698db0ce3fc72861e38642f39d9bec67826c9dde5a6fb19c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01c2b08d9e587db5764a29fce2f4aad1e60f6eff5468825057c3b8c06776300762156d4fb86bbcc7124109380921edee92049760b27a605846139bb39bfdbdf7"} 06:57:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:05 INFO - Copying logs to upload dir... 06:57:05 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.089794 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-14 06:57:05.593731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:05.597754) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341a611ec889ace04fd2b506f5c8df3c7e5633d4e8aeb144b5df26a2b0d3b99f9bde23607786c2ac698db0ce3fc72861e38642f39d9bec67826c9dde5a6fb19c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01c2b08d9e587db5764a29fce2f4aad1e60f6eff5468825057c3b8c06776300762156d4fb86bbcc7124109380921edee92049760b27a605846139bb39bfdbdf7"} build_url:https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/C-t-RWKxQFab9l_up8zQUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341a611ec889ace04fd2b506f5c8df3c7e5633d4e8aeb144b5df26a2b0d3b99f9bde23607786c2ac698db0ce3fc72861e38642f39d9bec67826c9dde5a6fb19c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01c2b08d9e587db5764a29fce2f4aad1e60f6eff5468825057c3b8c06776300762156d4fb86bbcc7124109380921edee92049760b27a605846139bb39bfdbdf7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:05.624628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:05.625143) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468502897.947198-1603341521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:05.710941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:57:05.711520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:57:05.712065) ========= ========= Total master_lag: 0.29 =========