builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1466254470.19 results: success (0) buildid: 20160618031522 builduid: 162c044dae014cdb9ee9341d299a9c63 revision: cec857b11eaf51d6c04368f65fef17e017a0f96c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.187672) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.188357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.188788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.228145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.228472) ========= 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=923d835db2ba3686ebe126b700000192-1466249473.521666-488531644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 05:54:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-18 05:54:31 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081195 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.337071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.337389) ========= 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=923d835db2ba3686ebe126b700000192-1466249473.521666-488531644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.387175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:30.387974) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cec857b11eaf51d6c04368f65fef17e017a0f96c --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 cec857b11eaf51d6c04368f65fef17e017a0f96c --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=923d835db2ba3686ebe126b700000192-1466249473.521666-488531644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 05:54:31,469 truncating revision to first 12 chars 2016-06-18 05:54:31,469 Setting DEBUG logging. 2016-06-18 05:54:31,469 attempt 1/10 2016-06-18 05:54:31,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cec857b11eaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 05:54:31,811 unpacking tar archive at: mozilla-beta-cec857b11eaf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675406 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:31.088950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:31.089257) ========= script_repo_revision: cec857b11eaf51d6c04368f65fef17e017a0f96c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:31.089691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:31.089989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:31.104339) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-18 05:54:31.104645) ========= /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=923d835db2ba3686ebe126b700000192-1466249473.521666-488531644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:32 INFO - MultiFileLogger online at 20160618 05:54:32 in /builds/slave/test 05:54:32 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 05:54:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:32 INFO - {'append_to_log': False, 05:54:32 INFO - 'base_work_dir': '/builds/slave/test', 05:54:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:54:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:32 INFO - 'branch': 'Mozilla-Beta', 05:54:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:32 INFO - 'config_files': ('talos/linux_config.py',), 05:54:32 INFO - 'default_actions': ('clobber', 05:54:32 INFO - 'read-buildbot-config', 05:54:32 INFO - 'download-and-extract', 05:54:32 INFO - 'populate-webroot', 05:54:32 INFO - 'create-virtualenv', 05:54:32 INFO - 'install', 05:54:32 INFO - 'run-tests'), 05:54:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:32 INFO - 'download_minidump_stackwalk': True, 05:54:32 INFO - 'download_symbols': 'ondemand', 05:54:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:32 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:32 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:32 INFO - 'installer_path': 'installer.exe', 05:54:32 INFO - 'log_level': 'info', 05:54:32 INFO - 'log_name': 'talos', 05:54:32 INFO - 'log_to_console': True, 05:54:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:32 INFO - 'opt_config_files': (), 05:54:32 INFO - 'pip_index': False, 05:54:32 INFO - 'sps_profile': False, 05:54:32 INFO - 'sps_profile_interval': 0, 05:54:32 INFO - 'suite': 'dromaeojs-e10s', 05:54:32 INFO - 'system_bits': '32', 05:54:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:32 INFO - 'title': 'talos-linux64-ix-007', 05:54:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:32 INFO - 'use_talos_json': True, 05:54:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:32 INFO - 'work_dir': 'build'} 05:54:32 INFO - ##### 05:54:32 INFO - ##### Running clobber step. 05:54:32 INFO - ##### 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: clobber 05:54:32 INFO - rmtree: /builds/slave/test/build 05:54:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - ##### 05:54:32 INFO - ##### Running read-buildbot-config step. 05:54:32 INFO - ##### 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: read_buildbot_config 05:54:32 INFO - Using buildbot properties: 05:54:32 INFO - { 05:54:32 INFO - "project": "", 05:54:32 INFO - "product": "firefox", 05:54:32 INFO - "script_repo_revision": "production", 05:54:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:54:32 INFO - "repository": "", 05:54:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:54:32 INFO - "buildid": "20160618031522", 05:54:32 INFO - "pgo_build": "True", 05:54:32 INFO - "basedir": "/builds/slave/test", 05:54:32 INFO - "buildnumber": 140, 05:54:32 INFO - "slavename": "talos-linux64-ix-007", 05:54:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:54:32 INFO - "platform": "ubuntu64_hw", 05:54:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:54:32 INFO - "branch": "mozilla-beta", 05:54:32 INFO - "repo_path": "releases/mozilla-beta", 05:54:32 INFO - "revision": "cec857b11eaf51d6c04368f65fef17e017a0f96c", 05:54:32 INFO - "stage_platform": "linux64-pgo", 05:54:32 INFO - "builduid": "162c044dae014cdb9ee9341d299a9c63", 05:54:32 INFO - "slavebuilddir": "test" 05:54:32 INFO - } 05:54:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - ##### 05:54:32 INFO - ##### Running download-and-extract step. 05:54:32 INFO - ##### 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: download_and_extract 05:54:32 INFO - mkdir: /builds/slave/test/build/tests 05:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:32 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:54:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:33 INFO - Downloaded 1327 bytes. 05:54:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:33 INFO - Using the following test package requirements: 05:54:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:54:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:54:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'jsshell-linux-x86_64.zip'], 05:54:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:54:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:54:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:54:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:33 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:36 INFO - Downloaded 24185047 bytes. 05:54:36 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'] 05:54:36 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 05:54:38 INFO - Return code: 0 05:54:38 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 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:38 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:40 INFO - Downloaded 24185047 bytes. 05:54:40 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'] 05:54:40 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 05:54:41 INFO - Return code: 0 05:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:41 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:54:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:54:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:54:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:42 INFO - Downloaded 10840145 bytes. 05:54:42 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'] 05:54:42 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 05:54:42 INFO - Return code: 0 05:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:42 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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 05:54:45 INFO - Downloaded 55996741 bytes. 05:54:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:45 INFO - mkdir: /builds/slave/test/properties 05:54:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:45 INFO - Contents: 05:54:45 INFO - build_url:https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - Running post-action listener: set_extra_try_arguments 05:54:46 INFO - ##### 05:54:46 INFO - ##### Running populate-webroot step. 05:54:46 INFO - ##### 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: populate_webroot 05:54:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:46 INFO - '--tppagecycles', 05:54:46 INFO - '7'], 05:54:46 INFO - 'tests': ['tsvgm']}}, 05:54:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['damp', 'tps']}, 05:54:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'tests': ['damp', 'tps']}, 05:54:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['dromaeo_dom']}, 05:54:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['a11yr', 05:54:46 INFO - 'ts_paint', 05:54:46 INFO - 'tpaint', 05:54:46 INFO - 'sessionrestore', 05:54:46 INFO - 'sessionrestore_no_auto_restore', 05:54:46 INFO - 'tabpaint']}, 05:54:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tsvgx', 05:54:46 INFO - 'tsvgr_opacity', 05:54:46 INFO - 'tart', 05:54:46 INFO - 'tscrollx', 05:54:46 INFO - 'cart']}, 05:54:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:46 INFO - 'tsvgr_opacity', 05:54:46 INFO - 'tart', 05:54:46 INFO - 'tscrollx', 05:54:46 INFO - 'cart']}, 05:54:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s'], 05:54:46 INFO - 'tests': ['tp5o']}, 05:54:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'tests': ['tp5o']}, 05:54:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--disable-e10s', 05:54:46 INFO - '--xperf_path', 05:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:46 INFO - 'tests': ['tp5n']}, 05:54:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:46 INFO - 'talos_options': ['--xperf_path', 05:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:46 INFO - 'tests': ['tp5n']}}, 05:54:46 INFO - 'talos.zip': {'path': '', 05:54:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - ##### 05:54:46 INFO - ##### Running create-virtualenv step. 05:54:46 INFO - ##### 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: create_virtualenv 05:54:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:46 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 05:54:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:46 INFO - Using real prefix '/usr' 05:54:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:48 INFO - Installing pip.................done. 05:54:48 INFO - Return code: 0 05:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:48 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')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:54:48 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 05:54:48 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 05:54:48 INFO - Using env: {'DISPLAY': ':0', 05:54:48 INFO - 'HOME': '/home/cltbld', 05:54:48 INFO - 'LANG': 'en_US.UTF-8', 05:54:48 INFO - 'LANGUAGE': 'en_US:en', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MAIL': '/var/mail/cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SHLVL': '1', 05:54:48 INFO - 'TERM': 'linux', 05:54:48 INFO - 'TMOUT': '86400', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:49 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 05:54:49 INFO - Cleaning up... 05:54:49 INFO - Return code: 0 05:54:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:54:49 INFO - Using env: {'DISPLAY': ':0', 05:54:49 INFO - 'HOME': '/home/cltbld', 05:54:49 INFO - 'LANG': 'en_US.UTF-8', 05:54:49 INFO - 'LANGUAGE': 'en_US:en', 05:54:49 INFO - 'LOGNAME': 'cltbld', 05:54:49 INFO - 'MAIL': '/var/mail/cltbld', 05:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:49 INFO - 'MOZ_NO_REMOTE': '1', 05:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:49 INFO - 'NO_EM_RESTART': '1', 05:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:49 INFO - 'PWD': '/builds/slave/test', 05:54:49 INFO - 'SHELL': '/bin/bash', 05:54:49 INFO - 'SHLVL': '1', 05:54:49 INFO - 'TERM': 'linux', 05:54:49 INFO - 'TMOUT': '86400', 05:54:49 INFO - 'USER': 'cltbld', 05:54:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:49 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:49 INFO - Downloading/unpacking psutil>=0.7.1 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:51 INFO - Installing collected packages: psutil 05:54:51 INFO - Running setup.py install for psutil 05:54:51 INFO - building 'psutil._psutil_linux' extension 05:54:51 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 05:54:51 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 05:54:51 INFO - building 'psutil._psutil_posix' extension 05:54:51 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 05:54:51 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 05:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:51 INFO - Successfully installed psutil 05:54:51 INFO - Cleaning up... 05:54:51 INFO - Return code: 0 05:54:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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', '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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:54: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:54: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 mozsystemmonitor==0.0.0 05:54:51 INFO - Using env: {'DISPLAY': ':0', 05:54:51 INFO - 'HOME': '/home/cltbld', 05:54:51 INFO - 'LANG': 'en_US.UTF-8', 05:54:51 INFO - 'LANGUAGE': 'en_US:en', 05:54:51 INFO - 'LOGNAME': 'cltbld', 05:54:51 INFO - 'MAIL': '/var/mail/cltbld', 05:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:51 INFO - 'MOZ_NO_REMOTE': '1', 05:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:51 INFO - 'NO_EM_RESTART': '1', 05:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:51 INFO - 'PWD': '/builds/slave/test', 05:54:51 INFO - 'SHELL': '/bin/bash', 05:54:51 INFO - 'SHLVL': '1', 05:54:51 INFO - 'TERM': 'linux', 05:54:51 INFO - 'TMOUT': '86400', 05:54:51 INFO - 'USER': 'cltbld', 05:54:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:51 INFO - '_': '/tools/buildbot/bin/python'} 05:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:54 INFO - Installing collected packages: mozsystemmonitor 05:54:54 INFO - Running setup.py install for mozsystemmonitor 05:54:54 INFO - Successfully installed mozsystemmonitor 05:54:54 INFO - Cleaning up... 05:54:54 INFO - Return code: 0 05:54:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:54:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:54 INFO - Using env: {'DISPLAY': ':0', 05:54:54 INFO - 'HOME': '/home/cltbld', 05:54:54 INFO - 'LANG': 'en_US.UTF-8', 05:54:54 INFO - 'LANGUAGE': 'en_US:en', 05:54:54 INFO - 'LOGNAME': 'cltbld', 05:54:54 INFO - 'MAIL': '/var/mail/cltbld', 05:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:54 INFO - 'MOZ_NO_REMOTE': '1', 05:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:54 INFO - 'NO_EM_RESTART': '1', 05:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:54 INFO - 'PWD': '/builds/slave/test', 05:54:54 INFO - 'SHELL': '/bin/bash', 05:54:54 INFO - 'SHLVL': '1', 05:54:54 INFO - 'TERM': 'linux', 05:54:54 INFO - 'TMOUT': '86400', 05:54:54 INFO - 'USER': 'cltbld', 05:54:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:54 INFO - '_': '/tools/buildbot/bin/python'} 05:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 INFO - Downloading docopt-0.6.1.tar.gz 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:57 INFO - Running setup.py install for blobuploader 05:54:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:57 INFO - Running setup.py install for requests 05:54:57 INFO - Running setup.py install for docopt 05:54:57 INFO - Successfully installed blobuploader requests docopt 05:54:57 INFO - Cleaning up... 05:54:57 INFO - Return code: 0 05:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:54:57 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 05:54:57 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 05:54:57 INFO - Using env: {'DISPLAY': ':0', 05:54:57 INFO - 'HOME': '/home/cltbld', 05:54:57 INFO - 'LANG': 'en_US.UTF-8', 05:54:57 INFO - 'LANGUAGE': 'en_US:en', 05:54:57 INFO - 'LOGNAME': 'cltbld', 05:54:57 INFO - 'MAIL': '/var/mail/cltbld', 05:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:57 INFO - 'MOZ_NO_REMOTE': '1', 05:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:57 INFO - 'NO_EM_RESTART': '1', 05:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:57 INFO - 'PWD': '/builds/slave/test', 05:54:57 INFO - 'SHELL': '/bin/bash', 05:54:57 INFO - 'SHLVL': '1', 05:54:57 INFO - 'TERM': 'linux', 05:54:57 INFO - 'TMOUT': '86400', 05:54:57 INFO - 'USER': 'cltbld', 05:54:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:57 INFO - '_': '/tools/buildbot/bin/python'} 05:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:57 INFO - Running setup.py (path:/tmp/pip-NkaQCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:57 INFO - Running setup.py (path:/tmp/pip-3lKIgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:57 INFO - Running setup.py (path:/tmp/pip-D0x027-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:58 INFO - Running setup.py (path:/tmp/pip-Dh1nEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:58 INFO - Running setup.py (path:/tmp/pip-Aie584-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:58 INFO - Running setup.py (path:/tmp/pip-oF2zpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:58 INFO - Running setup.py (path:/tmp/pip-bgjG6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:58 INFO - Running setup.py (path:/tmp/pip-NPf4hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:58 INFO - Running setup.py (path:/tmp/pip-_bH0fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:58 INFO - Running setup.py (path:/tmp/pip-s3SGc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:58 INFO - Running setup.py (path:/tmp/pip-3wnLPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:58 INFO - Running setup.py (path:/tmp/pip-acNC9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:58 INFO - Running setup.py (path:/tmp/pip-qYoTgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:58 INFO - Running setup.py (path:/tmp/pip-oIn1rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:58 INFO - Running setup.py (path:/tmp/pip-bJXylj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:58 INFO - Running setup.py (path:/tmp/pip-WvTYK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:58 INFO - Running setup.py (path:/tmp/pip-yTdYYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:59 INFO - Running setup.py install for manifestparser 05:54:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozcrash 05:54:59 INFO - Running setup.py install for mozdebug 05:54:59 INFO - Running setup.py install for mozdevice 05:54:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozfile 05:54:59 INFO - Running setup.py install for mozhttpd 05:54:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozinfo 05:54:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozInstall 05:54:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozleak 05:54:59 INFO - Running setup.py install for mozlog 05:55:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Running setup.py install for moznetwork 05:55:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Running setup.py install for mozprocess 05:55:00 INFO - Running setup.py install for mozprofile 05:55:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Running setup.py install for mozrunner 05:55:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Running setup.py install for mozscreenshot 05:55:00 INFO - Running setup.py install for moztest 05:55:00 INFO - Running setup.py install for mozversion 05:55:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:00 INFO - Cleaning up... 05:55:00 INFO - Return code: 0 05:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:00 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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:55:00 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 05:55:00 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 05:55:00 INFO - Using env: {'DISPLAY': ':0', 05:55:00 INFO - 'HOME': '/home/cltbld', 05:55:00 INFO - 'LANG': 'en_US.UTF-8', 05:55:00 INFO - 'LANGUAGE': 'en_US:en', 05:55:00 INFO - 'LOGNAME': 'cltbld', 05:55:00 INFO - 'MAIL': '/var/mail/cltbld', 05:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:00 INFO - 'MOZ_NO_REMOTE': '1', 05:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:00 INFO - 'NO_EM_RESTART': '1', 05:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:00 INFO - 'PWD': '/builds/slave/test', 05:55:00 INFO - 'SHELL': '/bin/bash', 05:55:00 INFO - 'SHLVL': '1', 05:55:00 INFO - 'TERM': 'linux', 05:55:00 INFO - 'TMOUT': '86400', 05:55:00 INFO - 'USER': 'cltbld', 05:55:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:00 INFO - '_': '/tools/buildbot/bin/python'} 05:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:01 INFO - Running setup.py (path:/tmp/pip-5I0Smt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:01 INFO - Running setup.py (path:/tmp/pip-UDxTgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:01 INFO - Running setup.py (path:/tmp/pip-J2efob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:01 INFO - Running setup.py (path:/tmp/pip-GRQywG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:01 INFO - Running setup.py (path:/tmp/pip-ZFMEnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:01 INFO - Running setup.py (path:/tmp/pip-Jne2Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:01 INFO - Running setup.py (path:/tmp/pip-efSyRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:01 INFO - Running setup.py (path:/tmp/pip-4euVZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:01 INFO - Running setup.py (path:/tmp/pip-O880hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:01 INFO - Running setup.py (path:/tmp/pip-Vn5rvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:01 INFO - Running setup.py (path:/tmp/pip-vdufl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:01 INFO - Running setup.py (path:/tmp/pip-dDx8HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 INFO - Running setup.py (path:/tmp/pip-mCDrPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 INFO - Running setup.py (path:/tmp/pip-NhB41r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:02 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)) 05:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:02 INFO - Running setup.py (path:/tmp/pip-bwLaOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:02 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)) 05:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:02 INFO - Running setup.py (path:/tmp/pip-PYPUf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:02 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)) 05:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:02 INFO - Running setup.py (path:/tmp/pip-OaDJMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:04 INFO - Downloading blessings-1.6.tar.gz 05:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:04 INFO - Installing collected packages: blessings 05:55:04 INFO - Running setup.py install for blessings 05:55:04 INFO - Successfully installed blessings 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:04 INFO - Reading from file tmpfile_stdout 05:55:04 INFO - Current package versions: 05:55:04 INFO - argparse == 1.2.1 05:55:04 INFO - blessings == 1.6 05:55:04 INFO - blobuploader == 1.2.4 05:55:04 INFO - docopt == 0.6.1 05:55:04 INFO - manifestparser == 1.1 05:55:04 INFO - mozInstall == 1.12 05:55:04 INFO - mozcrash == 0.17 05:55:04 INFO - mozdebug == 0.1 05:55:04 INFO - mozdevice == 0.48 05:55:04 INFO - mozfile == 1.2 05:55:04 INFO - mozhttpd == 0.7 05:55:04 INFO - mozinfo == 0.9 05:55:04 INFO - mozleak == 0.1 05:55:04 INFO - mozlog == 3.1 05:55:04 INFO - moznetwork == 0.27 05:55:04 INFO - mozprocess == 0.22 05:55:04 INFO - mozprofile == 0.28 05:55:04 INFO - mozrunner == 6.11 05:55:04 INFO - mozscreenshot == 0.1 05:55:04 INFO - mozsystemmonitor == 0.0 05:55:04 INFO - moztest == 0.7 05:55:04 INFO - mozversion == 1.4 05:55:04 INFO - psutil == 3.1.1 05:55:04 INFO - requests == 1.2.3 05:55:04 INFO - wsgiref == 0.1.2 05:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:55:04 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 05:55:04 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 05:55:04 INFO - Using env: {'DISPLAY': ':0', 05:55:04 INFO - 'HOME': '/home/cltbld', 05:55:04 INFO - 'LANG': 'en_US.UTF-8', 05:55:04 INFO - 'LANGUAGE': 'en_US:en', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MAIL': '/var/mail/cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SHLVL': '1', 05:55:04 INFO - 'TERM': 'linux', 05:55:04 INFO - 'TMOUT': '86400', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - '_': '/tools/buildbot/bin/python'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 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 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:55:04 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 05:55:04 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 05:55:04 INFO - Using env: {'DISPLAY': ':0', 05:55:04 INFO - 'HOME': '/home/cltbld', 05:55:04 INFO - 'LANG': 'en_US.UTF-8', 05:55:04 INFO - 'LANGUAGE': 'en_US:en', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MAIL': '/var/mail/cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SHLVL': '1', 05:55:04 INFO - 'TERM': 'linux', 05:55:04 INFO - 'TMOUT': '86400', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - '_': '/tools/buildbot/bin/python'} 05:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:05 INFO - Downloading/unpacking jsonschema 05:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:07 INFO - warning: no files found matching '*.txt' 05:55:07 INFO - no previously-included directories found matching 'build' 05:55:07 INFO - no previously-included directories found matching 'dist' 05:55:07 INFO - no previously-included directories found matching '.git*' 05:55:07 INFO - Installing collected packages: jsonschema, functools32 05:55:07 INFO - Running setup.py install for functools32 05:55:07 INFO - warning: no files found matching '*.txt' 05:55:07 INFO - no previously-included directories found matching 'build' 05:55:07 INFO - no previously-included directories found matching 'dist' 05:55:07 INFO - no previously-included directories found matching '.git*' 05:55:07 INFO - Successfully installed jsonschema functools32 05:55:07 INFO - Cleaning up... 05:55:07 INFO - Return code: 0 05:55:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d4a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, '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': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', '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 05:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:55:07 INFO - Using env: {'DISPLAY': ':0', 05:55:07 INFO - 'HOME': '/home/cltbld', 05:55:07 INFO - 'LANG': 'en_US.UTF-8', 05:55:07 INFO - 'LANGUAGE': 'en_US:en', 05:55:07 INFO - 'LOGNAME': 'cltbld', 05:55:07 INFO - 'MAIL': '/var/mail/cltbld', 05:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:07 INFO - 'MOZ_NO_REMOTE': '1', 05:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:07 INFO - 'NO_EM_RESTART': '1', 05:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:07 INFO - 'PWD': '/builds/slave/test', 05:55:07 INFO - 'SHELL': '/bin/bash', 05:55:07 INFO - 'SHLVL': '1', 05:55:07 INFO - 'TERM': 'linux', 05:55:07 INFO - 'TMOUT': '86400', 05:55:07 INFO - 'USER': 'cltbld', 05:55:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:07 INFO - '_': '/tools/buildbot/bin/python'} 05:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:07 INFO - Downloading/unpacking flake8 05:55:07 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 05:55:07 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 05:55:07 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 05:55:07 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 05:55:07 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 05:55:07 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 05:55:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:55:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:55:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:10 INFO - no previously-included directories found matching 'docs/_build' 05:55:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:55:10 INFO - Running setup.py install for pep8 05:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:10 INFO - no previously-included directories found matching 'docs/_build' 05:55:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:55:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:55:10 INFO - Cleaning up... 05:55:10 INFO - Return code: 0 05:55:10 INFO - Running post-action listener: _resource_record_post_action 05:55:10 INFO - Running post-action listener: _start_resource_monitoring 05:55:10 INFO - Starting resource monitoring. 05:55:10 INFO - ##### 05:55:10 INFO - ##### Running install step. 05:55:10 INFO - ##### 05:55:10 INFO - Running pre-action listener: _resource_record_pre_action 05:55:10 INFO - Running main action method: install 05:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:10 INFO - Reading from file tmpfile_stdout 05:55:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:10 INFO - Reading from file tmpfile_stdout 05:55:10 INFO - Output received: 05:55:10 INFO - Usage: mozinstall [options] installer 05:55:10 INFO - Options: 05:55:10 INFO - -h, --help show this help message and exit 05:55:10 INFO - -d DEST, --destination=DEST 05:55:10 INFO - Directory to install application into. [default: 05:55:10 INFO - "/builds/slave/test"] 05:55:10 INFO - --app=APP Application being installed. [default: firefox] 05:55:10 INFO - mkdir: /builds/slave/test/build/application 05:55:10 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'] 05:55:10 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 05:55:24 INFO - Reading from file tmpfile_stdout 05:55:24 INFO - Output received: 05:55:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:24 INFO - Running post-action listener: _resource_record_post_action 05:55:24 INFO - ##### 05:55:24 INFO - ##### Running run-tests step. 05:55:24 INFO - ##### 05:55:24 INFO - Running pre-action listener: _resource_record_pre_action 05:55:24 INFO - Running main action method: run_tests 05:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:24 INFO - Python 2.7.3 05:55:24 INFO - Return code: 0 05:55:24 INFO - grabbing minidump binary from tooltool 05:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:24 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 0x1b19410>, '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 0x1b1a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:24 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 05:55:24 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 05:55:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:24 INFO - Return code: 0 05:55:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:55:25 INFO - Return code: 0 05:55:25 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/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:55:25 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/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 05:55:25 INFO - Using env: {'DISPLAY': ':0', 05:55:25 INFO - 'HOME': '/home/cltbld', 05:55:25 INFO - 'LANG': 'en_US.UTF-8', 05:55:25 INFO - 'LANGUAGE': 'en_US:en', 05:55:25 INFO - 'LOGNAME': 'cltbld', 05:55:25 INFO - 'MAIL': '/var/mail/cltbld', 05:55:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:25 INFO - 'MOZ_NO_REMOTE': '1', 05:55:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:25 INFO - 'NO_EM_RESTART': '1', 05:55:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:25 INFO - 'PWD': '/builds/slave/test', 05:55:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:25 INFO - 'SHELL': '/bin/bash', 05:55:25 INFO - 'SHLVL': '1', 05:55:25 INFO - 'TERM': 'linux', 05:55:25 INFO - 'TMOUT': '86400', 05:55:25 INFO - 'USER': 'cltbld', 05:55:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466249473.521666-488531644', 05:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:25 INFO - '_': '/tools/buildbot/bin/python'} 05:55:25 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/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:55:25 INFO - mozversion application_buildid: 20160618031522 05:55:25 INFO - mozversion application_changeset: cec857b11eaf51d6c04368f65fef17e017a0f96c 05:55:25 INFO - mozversion application_display_name: Firefox 05:55:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:25 INFO - mozversion application_name: Firefox 05:55:25 INFO - mozversion application_remotingname: firefox 05:55:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:55:25 INFO - mozversion application_vendor: Mozilla 05:55:25 INFO - mozversion application_version: 48.0 05:55:25 INFO - mozversion platform_buildid: 20160618031522 05:55:25 INFO - mozversion platform_changeset: cec857b11eaf51d6c04368f65fef17e017a0f96c 05:55:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:55:25 INFO - mozversion platform_version: 48.0 05:55:25 INFO - using testdate: 1466254525 05:55:25 INFO - actual date: 1466254525 05:55:25 INFO - starting webserver on 'localhost:41880' 05:55:25 INFO - SUITE-START | Running 2 tests 05:55:25 INFO - TEST-START | dromaeo_css 05:55:25 INFO - operating with platform_type : linux_ 05:55:25 INFO - Initialising browser for dromaeo_css test... 05:55:25 INFO - TEST-INFO | started process 16751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MbIX4/profile http://localhost:41880/getInfo.html) 05:55:28 INFO - PROCESS | 16751 | 05:55:28 INFO - PROCESS | 16751 | (process:16832): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:55:29 INFO - PROCESS | 16751 | __metrics Screen width/height:1600/1200 05:55:29 INFO - PROCESS | 16751 | colorDepth:24 05:55:29 INFO - PROCESS | 16751 | Browser inner width/height: 1024/697 05:55:29 INFO - PROCESS | 16751 | __metrics 05:55:29 ERROR - PROCESS | 16751 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 05:55:30 INFO - TEST-INFO | 16751: exit 0 05:55:30 INFO - Browser initialized. 05:55:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:30 INFO - TEST-INFO | started process 16883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MbIX4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:32 INFO - PROCESS | 16883 | 05:55:32 INFO - PROCESS | 16883 | (process:16950): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:55:42 INFO - PROCESS | 16883 | RSS: Main: 150626304 05:55:42 INFO - PROCESS | 16883 | 05:56:32 INFO - PROCESS | 16883 | 1466254592212 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] 05:58:39 INFO - PROCESS | 16883 | Cycle 1(1): loaded http://localhost:41880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41880/tests/dromaeo/cssquery-ext.html) 05:58:40 INFO - PROCESS | 16883 | RSS: Main: 154640384 05:58:40 INFO - PROCESS | 16883 | 06:01:42 INFO - PROCESS | 16883 | Cycle 1(1): loaded http://localhost:41880/tests/dromaeo/cssquery-ext.html (next: http://localhost:41880/tests/dromaeo/cssquery-jquery.html) 06:01:43 INFO - PROCESS | 16883 | RSS: Main: 152629248 06:01:43 INFO - PROCESS | 16883 | 06:04:44 INFO - PROCESS | 16883 | Cycle 1(1): loaded http://localhost:41880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41880/tests/dromaeo/cssquery-mootools.html) 06:04:45 INFO - PROCESS | 16883 | RSS: Main: 152227840 06:04:45 INFO - PROCESS | 16883 | 06:07:46 INFO - PROCESS | 16883 | Cycle 1(1): loaded http://localhost:41880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41880/tests/dromaeo/cssquery-prototype.html) 06:07:47 INFO - PROCESS | 16883 | RSS: Main: 153358336 06:07:47 INFO - PROCESS | 16883 | 06:10:49 INFO - PROCESS | 16883 | Cycle 1(1): loaded http://localhost:41880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41880/tests/dromaeo/cssquery-yui.html) 06:10:50 INFO - PROCESS | 16883 | RSS: Main: 152080384 06:10:50 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | Cycle 1(1): loaded http://localhost:41880/tests/dromaeo/cssquery-yui.html (next: http://localhost:41880/tests/dromaeo/cssquery-dojo.html) 06:13:52 INFO - PROCESS | 16883 | RSS: Main: 155820032 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | __start_tp_report 06:13:52 INFO - PROCESS | 16883 | _x_x_mozilla_page_load 06:13:52 INFO - PROCESS | 16883 | _x_x_mozilla_page_load_details 06:13:52 INFO - PROCESS | 16883 | |i|pagename|runs| 06:13:52 INFO - PROCESS | 16883 | |0;dojo.html;3359.546461227734;3406.267652454722;3414.880479183228;3445.0181698215997;3447.0865220716514;5574.888502229953;5616.157576363547;5625.943740562593;5633.859153521164;5646.153077038442;5566.693831839248;5621.690807005613;5640.097584386499;5643.181738647893;5651.124075768253;5071.594272458195;5110.616703747215;5116.258142569325;5124.871878203037;5151.5106064923775;5109.3357863477695;5214.374275086995;5252.238425428311;5252.894942101156;5272.209168624718;5098.617603679721;5168.819091331804;5240.737963101829;5243.659162154467;5310.230016647583;5185.507376799198;5193.480651934814;5196.168613021936;5197.922031169535;5221.895562088775;5016.974915125401;5036.748162591855;5107.61692873036;5159.329287192679;5169.4313625501545;5470.589705772043;5504.889902201933;5526.115821468546;5544.667319960815;5596.300462442195;6018.067199584071;6026.457618814284;6026.939730602681;6044.24446944132;6046.3349031606485;5992.670403127826;6092.451679348836;6094.6952652367645;6122.1735065766;6133.570650054498;5732.541396688297;5735.1970724098655;5735.913961290584;5740.8851822963725;5769.682667453289;6241.625502469867;6259.029850373199;6259.092431597484;6259.123722678829;6263.342349053375;5792.9420705793245;5898.2332296802;5919.822405327761;6027;6037.516998640186;6005.609635373687;6006.879862402728;6014.188084608521;6026.5178785697035;6057.1519987200945;5922.940770592239;5931.228940237827;5975.551833612496;5979.760809567569;5986.610870293417;5945.672987985702;5985.401459854067;6035.758569657252;6076.635401875813;6138.815835524852;4554.043650833296;4559.498455169929;4564.269716845355;4566.292224705176;4581.5647513486165;4055.8986025349604;4055.918881622351;4091.3453847384276;4106.445629839934;4106.486689163855;5722.141678748221;5845.064789633639;5858.150568167592;5875.471207591338;5903.822885313448;5984.910226346608;6023.126646636213;6037.1246169305205;6063.90849647059;6067.969660151671;5701.800436984686;5771.0477771168125;5784.074548072373;5784.971075144597;5785.450382213683;5083.74581270935;5154.974225128851;5164.8192313268855;5171.482851714798;5194.4805519447755;6191.938080619136;6209.875802484015;6270.184875966095;6304.527160462983;6325.652089135142;6079.452849243412;6094.573379863367;6128.019516877456;6135.233095863017;6137.96931015342;6263.248410190807;6289.779857704958;6337.112804207322;6339.207599050119;6359.300476947439;6025.909611355745;6045.335013148638;6048.153258543895;6048.637081775108;6056.06131049688;5988.640681559121;6115.480184184395;6142.017277235621;6143.477804386677;6171.352008039271;5801.129830525286;5832.912506312324;5836.241288632451;5837.94162058374;5859.56053296013;5754.424557544212;5821.330546987151;5825.854353641193;5831.35855055952;5872.412758724094;5723.542116630742;5801.303843538633;5857.150713146485;5905.822825315247;5914.2311499504785;5882.852928676817;5993.310769261417;6006.189164462917;6033.879322413615;6048.425399587032;5904.704764761831;5905.232319798571;5906.173135760911;5915.024021036653;5922.881542369215 06:13:52 INFO - PROCESS | 16883 | |1;ext.html;669.8660267946409;677.1400321591582;686.4474098350828;733.0397179694597;749.6589051981348;41849.581504184986;42117.3682394764;42129.57870421299;42145.57854421455;42254.36618450726;44712.32931506022;45177.54822451775;45192.77403612986;45368.092638147216;45461.545384546145;8837.911620883773;9000.639974401016;9011.143941325563;9018.278537717;9027.368084234105;8837.337199710015;8893.77765555863;8904.51025193614;9142.542872856331;9162.954185229064;9208.26333893287;9246.67636632718;9279.211267042276;9298.070192980715;9326.72019839406;9150.450972941644;9197.862032069525;9227.953860230724;9228.492432916188;9243.07569243077;9111.726648200565;9260.953695231548;9265.814683706356;9284.025177356416;9291.907080929172;44545.33182002272;45204.77397613024;45298.54701453009;45322.77338613319;45349;3896.415537669344;4184.623383895434;4261.147770445923;4402.3176407656865;4657.4876763555985;33004.33991320184;33387.49918751221;33549.83225083883;33945.49081763776;34633;4672.3925889634465;4683.906321873577;4702.224133018048;4735.360726301939;4749.4775574686755;317969;318468;318828;319110;319921;39661.40507892384;40251.79874100611;65499;65749;65868;37892.43161352582;37982.81008594995;38114.047148821504;38229;38385;16563;16666.250018749186;16676.916615416845;16686.082265475274;16775.2451139699;14016.579502614937;14092.436302547783;14120.082194657314;14141.575752727435;14174.85825141756;9537.666181683608;9760.902390976142;9802.313838031268;9847.310688251897;9852.064053914866;3742.4947632069866;3744.3260213161893;3847.2882516734494;3857.267119247334;3896.2597106549665;1081.6052140968648;1124.4321617583068;1130.3895896216115;1134.6539305511733;1137.5392965848844;34007.82996085053;34402.65597344044;34466.655333446346;34486.31027379489;35125.12187195289;1223.4494477485168;1263.4819723913151;1323.2523624152516;1335.5659410691565;1372.8695773901663;17302.394416195373;17809.643807123786;17883.01643409625;18021.909890450726;18057.819421805878;496377;501254;503214;839655;880092;60345.69827150924;61237;61238.38761612327;61303.38696613066;61399.38600614026;1536.46991787833;1561.0789634115927;1574.8031496062993;1579.5577238373503;1580.138824340737;32776.705630605626;34987.82506087555;36540.451893222154;36605.450918236784;37211.06972325713;58742.706286468296;59470.40529594649;59551;59660.40339596722;59848.70075649594;440674;443844;444085;445795;446480;48513;48850.267245990624;48932.75533622309;49818.25272620986;50197.24704129368;53291.20063198978;53634;53974;54401.45598544122;54572;43912.560874390845;44959;45456;45854.770726146155;46435;43491.13017739691;44459.777701111285;44653.82098305901;45122.54877451184;45260.32109518294;44858;45034;45499.77250113728;45873.082538348375;46169.15323387161;37810.43284350682;38853.805730971166;39180.2163956725;39536.802315988236;39906.60093399029;29371.55942660819;29781.404371912005;30376;30420.239494012825;30727.2318192047 06:13:52 INFO - PROCESS | 16883 | |2;jquery.html;441.36663887321697;447.3205499060627;448.4752839178161;450.1851648516186;458.68809209737384;20035.499112522175;20432.182712691512;20939.267125650604;21278;21327.57344853102;16713.66572668546;17989.640207195847;20506.897465512688;20513.897430512825;20613.1754729811;5574.1917421973785;5982.940170598304;5999.6700181490005;6009.399060094;6024.759009639631;5864.266966629171;5969.462748352647;5983.491403230731;5994.340622531518;5997.970010149965;5766.711664416784;5969.283685957691;5970.492508136792;5972.25346831646;5973;5839.240898683186;5843.444872737105;5849.415058494159;5904.940950590525;5915.970420147914;5417.8103766367985;5642.943570564283;5689.402612725646;5699.373068962411;5723.084306510938;14234.430622775077;16188.75716864248;22450;22950.885245573667;22977.88511057434;2273.374821923984;2324.837261391703;2363.420961864354;2407.0010945457616;2498.0757119865766;9868.654597089138;10209.38743675382;10218.386896786142;10542.209334299958;10552.31409958358;1861.171778558542;1868.6075924055965;1914.827665510097;1919.4529559075597;2024.1498570600384;76844.23155768427;78255.21744782536;79899;81200;82767.17232827716;11821.408929553489;11838.230515016496;11955.222910510789;11981.400929953468;12102.213356131822;16768.58078548046;16778.916105419394;16957.321707131578;16990.065546395068;17096.48710538686;8940.68707595231;8972.237359824358;9020.684276050306;9059.547022648841;9096.454212747256;8945.73162805117;8955.820883582423;8990.640374385082;9010.50442225684;9127.680531181377;4810.182269014276;4855.150348688965;4875.804967801319;5032.496750324938;5322.973385133049;2102.295730930125;2114.1120729293734;2124.479502521861;2173.3697227804078;2210.7789221077765;998.201438848918;1036.1814166808288;1036.5750042482546;1047.6903870162298;1150.649052039136;18888.33890813815;19325.13036913342;19436.51408714765;19464.610707786047;19846.70229946552;1041.9218558608134;1092.6121226964472;1100.8568886044764;1128.8476055732372;1148.9195756296979;10734.409607471664;11025.779484410266;11042.447877606088;11045.226834121535;11064.502097405637;489026;502830;505069;505331;508314;93184.53407732918;94173.5291323539;94645.52677236707;95025.5248723752;97954;1061.601899287767;1065.9360438373722;1085.4898197846999;1116.1405717597568;1135.5741596901162;16949.830501694825;17106;17323.393681221096;17450.563735906704;17456;40693.389599155445;41141;41249.79375103105;41565.33738650541;42649.147017058865;58649.413505864395;61250.38749612625;61484;61514.64776675083;62348.37651623607;8716;8955.865662015205;8970.865437018581;9030.63877444895;9076;13242.20546767197;13773.862261377659;14059;14222.786658200343;14578.416863325348;10989.780204395707;11522.366269855238;12051.939740301243;12505.187162834387;12620.242785432903;12119.575814846437;12269.079819013788;12288.569900053455;12296.877031229573;12516.687082823002;11865.881341186478;11937.462814173557;12694.555690551157;12697.55558555446;12717.93641031826;9295.256379489489;9410.858837117587;9434.622615095319;9498.335116541775;9571.138597526256;12154.331511766584;12446.937765311477;12537.498500059895;12619.242845429304;12785.36073196355 06:13:52 INFO - PROCESS | 16883 | |3;mootools.html;1556.9221538923055;1571.1594297051076;1760.4102625620417;1889.640968216038;1926.412444204518;7762.49543779654;8451.619677114544;8517.616707248173;8736.082711315308;8757;8439.19827616377;8481.703140390073;8595.699150529732;8614.181652742995;8621.353398495106;2456.66834977278;2464.2607217834666;2464.667269918565;2472.913448029319;2491.5888878335054;2434.160214725917;2477.9008839646394;2489.788367988723;2489.950200995988;2501.737317581646;2477.095860011101;2491.501699660066;2514.647949287092;2514.9119780807673;2517.874106294687;2450.779429851313;2495.663085483455;2499.3751562109474;2505.624156376558;2507.699076110869;2433.586290330648;2454.2882564056404;2462.236706620953;2471.9741307357426;2509.623556466526;8769.123087691243;8873.600687968992;8875.822483550357;8883.289336853037;8894.555272236363;5563.082091454905;5683.3464151622675;5700.714964251771;5704.429557044304;5718;3673.981630091859;3690.926181476382;3737.2712321097397;3751.3435148848844;3753.2868754936476;1231.1382032577142;1257.1953949472345;1279.181323952671;1288.8646692097288;1290.7870201416754;12303.32331721755;12313.507459701512;12360.196587221802;12402.503899843996;12404.503819847196;4896.902061958741;4925.162722337212;5026.447090820006;5183.81856635016;5183.844484665466;10474.423906685206;10520.368777873353;10535.683929482127;10548.050675439248;10555.683329500127;5657.547396208293;5672.801451949162;5682.488576028178;5732;5737.913931291034;4531.071130418256;5080.237964305384;5193.818216362409;5202.817901373433;5212.296339994128;4230.323148296257;4255.255330317182;4281.7002809803635;4312.7627980461375;4335.653147748236;1394.6652803327129;1412.053923871009;1413.441690532234;1437.3531910640254;1438.8489208633152;922.898481167071;1036.259074761549;1039.9688009359731;1065.2862582070031;1097.9615713449991;5978.923793717173;6156.815295541141;6179.227596550431;6220.098085777537;6293.181886354744;468.20872725094483;481.0139214610035;495.2571143285072;502.69586899925747;517.3791450259704;4175.269327867611;4297.226499230169;4320.65434765218;4328.264195086843;4401.075774087413;10672.733181670521;10846.837297440545;10885.455727213608;10970.561177552809;10993.285436446606;10603.84094238587;10701.89298107009;10779.299345542515;10827.025567698787;10834.349939003685;8270.586470676442;8320.8335833283;8342.082370939192;8371.246587807127;8432.78918027042;5796.94203057964;5863.1791549184;5952.910706339495;6022.066579680157;6046.818595442144;9470.526473676426;9585.952070239604;9612.855807162758;9703.369280996712;9759.9024009759;9679.758006049906;9813.9018609813;9884.555195016097;9959.900400996186;10123.848142278019;7452;7642.465027448247;7676.884846727416;7820.061592608923;7912.881306780288;8085.272325490734;8111.06722726894;8161.877571836309;8182.099969003524;8211.507309561446;7376.114866216089;7572.886406703794;7598.164201937893;7655.234476552523;7709.151993280847;7232.276772322725;7306.159791623819;7366.96316518414;7404.592747398945;7441.218672039575;6703.798886033427;6858.931410686029;6893.138357705287;6895.103636527219;6917.066196063467;5229.267902493578;5323.920141197963;5372.059889519241;5445.50990410865;5468.28912241406;5386.569074473954;5451.127819548853;5486.506214440719;5500.064988951968;5512.145617429305 06:13:52 INFO - PROCESS | 16883 | |4;prototype.html;363.09589123083515;363.8617325416342;364.1097516571981;369.0478565301519;373.1343283582091;6668.166479190101;6677.599344039355;6681.799546013622;6686.632235227061;6741.898871516931;6705.195376554808;6710.597364158154;6714.899276510856;6717.731290748364;6728.9327106728915;4862;4956.132676781567;4957.5042495750495;4984.725840078794;5000.924986125211;5025.271335656327;5032.949670503303;5033.84898453047;5035.370578677665;5037.672551284155;4994.625403094764;4995;5004.948960718253;5005.349304590398;5009.273655319977;4990.875228119308;4993.650444468889;4994.325766021595;5020.849374518771;5025.422076461217;4341.826326946918;4350.71720338177;4351.042770590497;4354.477462704464;4356.324769660676;6305.716242769086;6473.611583305017;6484.319146489598;6489.734501772156;6515.3484651534945;5818.185454036438;5847.619904706181;5861.589688721791;5864.5894787364905;5877.764889404419;7114.822129446753;7118.110236220473;7118.430525557943;7122.537035092702;7123.180834204081;4820.734859582722;4823.686460380064;4830.661853670244;4832.613390928753;4846.854594362175;7335.633218339061;7389.187189409161;7396.371308438789;7406.148292946273;7423;4780.1873681474235;4912.778924948386;4934.1118598651865;4942.159832828428;4954.133026720309;4962.851114466572;4976.676516026447;4987.700737955734;4993.675411098267;4996.200607902791;5829.970850145722;5838.241028666246;5838.4453476919625;5843.590948633555;5852.707364631751;7134.857302854018;7160.391366733782;7164.247753985756;7166.713331466683;7170.42636589082;1746.05712915027;1761.5419990802484;1761.9119044047745;1763.8941663500232;1766.6466706658462;1142.3488611491537;1190.696372425026;1223.6573759347398;1231.6181983584938;1232.6363722701824;6696.46428285736;6741.898871516931;6818.795436136924;6823.317668233137;6828.931710682829;7194.532355396883;7274.963625181946;7306.305900939402;7320.633968301564;7338.522996005243;6903.930960690429;6917.89623155643;6926.722931082701;6931.202911665122;6939.063226464464;3952.782596957195;4013.418054382098;4014.5182578090817;4018.2967980603275;4025.77858217795;7693.92285080078;7756.728514502078;7757.146713861471;7760.417968652374;7768.184340644264;7344.502869024451;7600;7615.961920190363;7629.160792312841;7680.577568233801;7654.540727556365;7672.884906726404;7673.539587624648;7688.769336919901;7762.495437796638;7418.851622967619;7425.925740742523;7430.256974302527;7436.73971410998;7439.851202976019;7341.375983041287;7344.192138864827;7344.8898266524975;7344.8898266524975;7350.154732205651;7620.885686714593;7748.8450230996195;7754.379649628129;7767.9223207769455;7770.53376797394;4947.950520494893;4956.578690811321;4965.155923492943;4992.076465853828;4999.950000499948;7353.5955522446775;7421;7424.220456851953;7430.814229644302;7436.59098749574;7086.50394472382;7143.82140446493;7183.640817959185;7184.1019872515935;7203.603801790951;6977.511574189758;7129.180144283267;7168.103987001625;7182.497225194186;7183.425325973805;7023.964880175567;7026.578405295699;7028.402585780266;7043.084399028094;7056.470764692771;7186.892196617159;7187.532810367309;7206.603636800026;7220.277972202738;7223.349898508949;6963.199232088375;6996.720131194696;7044.366007059184;7060;7060.258672839278 06:13:52 INFO - PROCESS | 16883 | |5;yui.html;915.4370062411617;929.7396728915902;938.3431597881482;943.9433633981957;944.3814301632433;15274;15360.310365859774;15390.153541555237;15502.534923952286;15521.611959700998;15666.451674191378;15764.132972686497;15795.131267780267;15815.446459373925;15859.603509912258;914.6524320758102;918.591226904028;929.9070092990714;930.3441074042818;938.8638647396124;933.0110083311712;935.2658163341778;941.0683423410842;941.6892425499568;942.5051847779936;992.4938281476462;994.6319861651162;995.8655581496478;1000.6197644894929;1001.2040427859832;986.0484632329765;986.3637953519975;987.8320685483485;987.9555420006081;990.9851352229722;711.9679614417312;713;714.610537257196;726.5422783646322;731.2906480713752;14422.639434014234;14479.493217737434;14505.41978320866;14529.273536323142;14574;14478.85521144796;14499.275036248146;14502.637434064127;14561.854381456156;14598;11857.288562686266;11946.761064778655;12095.17613345717;12106.213096148722;12243.32661703606;3950.940735888964;3993.341098718708;4015.0765323975356;4022.416749571296;4040.2929487339597;58071.128933065615;58505.707471462796;60029.699851500896;60479.69760151171;60836.391636083514;11484.712882177846;11511.884881151082;11710.473028713728;11719.707007324885;11837.644870653894;20155.798442015686;20419.285325013552;20457.693134602992;20561.280355187497;20563.177472900916;8492.965841225368;8698.521581313089;8940.821183576421;9063;9191.816163676689;4760.571548560646;4826.227803551415;5038.2190760432195;5076.593872490266;5216.035033518811;3714.647108524686;3742.700583953277;3749.081475038633;3778.792166430873;3784.4323351496946;634.9682515874188;692.4875592061838;697.4141720954423;698.434268242725;699.1156187422914;749.2657195948002;777.6228529163351;783.6160281462043;811.9350451963946;825.3809642767924;10458.921020801894;10731.195160363004;10908.69259991326;10989.340639561651;10999.23005389615;791.8099656082499;813.0446725097986;814.8573999550055;828.5484410996022;845.572985642259;4575;4834.95165048352;4891.070696567641;4910.263460480956;4988.127077761377;64747.67626161839;66191.33808661852;66236.66881665657;66673;67077.32922670711;55807.441925581035;55995;58260.41739582635;58772.41227587755;58846.11730824041;51588.74205628948;51857.7407112962;51878.22182667263;52568.737156313975;52810.73594632002;10163.988471355857;10305.175585952957;10392.42841643717;10506.789864202827;10603.045725884707;38707.80646096751;38984.220315594095;39348.606513934494;39792.60207397889;40306.79846600748;44746.3288050673;44927.775361122985;47348.52651473441;48923.02153956972;50087;12185.96419304369;12634.178778379375;12718.682032949251;12982.480700771863;13088.411021503865;12530.874691253335;12856.678583035498;13200.20798752078;13346.866531334563;13831.446742130202;13115.213087214797;13144.34278286101;13215.207087574776;13226.735465290833;13513.662158446117;12083.57707480234;12482.063845211827;13054.608361749162;13220.206787592775;13294.734105318033;12911.5480958166;13038.54365097255;13193.538226162422;13724.107932984323;14328.856711433169;10516.211284153873;10564.788704226026;10681.19891008193;10978.835317470084;11193.104551635686;11311.208215424842;11316.60083579482;11360.318380897173;11464.4267786612;11475.196736228383 06:13:52 INFO - PROCESS | 16883 | __end_tp_report 06:13:52 INFO - PROCESS | 16883 | __start_cc_report 06:13:52 INFO - PROCESS | 16883 | _x_x_mozilla_cycle_collect,324 06:13:52 INFO - PROCESS | 16883 | __end_cc_report 06:13:52 INFO - PROCESS | 16883 | __startTimestamp1466255632823__endTimestamp 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | ------- Summary: start ------- 06:13:52 INFO - PROCESS | 16883 | Number of tests: 6 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | [#0] dojo.html Cycles:165 Average:5630.19 Median:5845.06 stddev:633.80 (10.8%) stddev-sans-first:610.20 06:13:52 INFO - PROCESS | 16883 | Values: 3359.5 3406.3 3414.9 3445.0 3447.1 5574.9 5616.2 5625.9 5633.9 5646.2 5566.7 5621.7 5640.1 5643.2 5651.1 5071.6 5110.6 5116.3 5124.9 5151.5 5109.3 5214.4 5252.2 5252.9 5272.2 5098.6 5168.8 5240.7 5243.7 5310.2 5185.5 5193.5 5196.2 5197.9 5221.9 5017.0 5036.7 5107.6 5159.3 5169.4 5470.6 5504.9 5526.1 5544.7 5596.3 6018.1 6026.5 6026.9 6044.2 6046.3 5992.7 6092.5 6094.7 6122.2 6133.6 5732.5 5735.2 5735.9 5740.9 5769.7 6241.6 6259.0 6259.1 6259.1 6263.3 5792.9 5898.2 5919.8 6027.0 6037.5 6005.6 6006.9 6014.2 6026.5 6057.2 5922.9 5931.2 5975.6 5979.8 5986.6 5945.7 5985.4 6035.8 6076.6 6138.8 4554.0 4559.5 4564.3 4566.3 4581.6 4055.9 4055.9 4091.3 4106.4 4106.5 5722.1 5845.1 5858.2 5875.5 5903.8 5984.9 6023.1 6037.1 6063.9 6068.0 5701.8 5771.0 5784.1 5785.0 5785.5 5083.7 5155.0 5164.8 5171.5 5194.5 6191.9 6209.9 6270.2 6304.5 6325.7 6079.5 6094.6 6128.0 6135.2 6138.0 6263.2 6289.8 6337.1 6339.2 6359.3 6025.9 6045.3 6048.2 6048.6 6056.1 5988.6 6115.5 6142.0 6143.5 6171.4 5801.1 5832.9 5836.2 5837.9 5859.6 5754.4 5821.3 5825.9 5831.4 5872.4 5723.5 5801.3 5857.2 5905.8 5914.2 5882.9 5993.3 6006.2 6033.9 6048.4 5904.7 5905.2 5906.2 5915.0 5922.9 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | [#1] ext.html Cycles:180 Average:63524.43 Median:44683.08 stddev:133333.27 (298.4%) stddev-sans-first:133623.78 06:13:52 INFO - PROCESS | 16883 | Values: 669.9 677.1 686.4 733.0 749.7 41849.6 42117.4 42129.6 42145.6 42254.4 44712.3 45177.5 45192.8 45368.1 45461.5 8837.9 9000.6 9011.1 9018.3 9027.4 8837.3 8893.8 8904.5 9142.5 9163.0 9208.3 9246.7 9279.2 9298.1 9326.7 9150.5 9197.9 9228.0 9228.5 9243.1 9111.7 9261.0 9265.8 9284.0 9291.9 44545.3 45204.8 45298.5 45322.8 45349.0 3896.4 4184.6 4261.1 4402.3 4657.5 33004.3 33387.5 33549.8 33945.5 34633.0 4672.4 4683.9 4702.2 4735.4 4749.5 317969.0 318468.0 318828.0 319110.0 319921.0 39661.4 40251.8 65499.0 65749.0 65868.0 37892.4 37982.8 38114.0 38229.0 38385.0 16563.0 16666.3 16676.9 16686.1 16775.2 14016.6 14092.4 14120.1 14141.6 14174.9 9537.7 9760.9 9802.3 9847.3 9852.1 3742.5 3744.3 3847.3 3857.3 3896.3 1081.6 1124.4 1130.4 1134.7 1137.5 34007.8 34402.7 34466.7 34486.3 35125.1 1223.4 1263.5 1323.3 1335.6 1372.9 17302.4 17809.6 17883.0 18021.9 18057.8 496377.0 501254.0 503214.0 839655.0 880092.0 60345.7 61237.0 61238.4 61303.4 61399.4 1536.5 1561.1 1574.8 1579.6 1580.1 32776.7 34987.8 36540.5 36605.5 37211.1 58742.7 59470.4 59551.0 59660.4 59848.7 440674.0 443844.0 444085.0 445795.0 446480.0 48513.0 48850.3 48932.8 49818.3 50197.2 53291.2 53634.0 53974.0 54401.5 54572.0 43912.6 44959.0 45456.0 45854.8 46435.0 43491.1 44459.8 44653.8 45122.5 45260.3 44858.0 45034.0 45499.8 45873.1 46169.2 37810.4 38853.8 39180.2 39536.8 39906.6 29371.6 29781.4 30376.0 30420.2 30727.2 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | [#2] jquery.html Cycles:180 Average:29721.09 Median:12361.69 stddev:82742.23 (669.3%) stddev-sans-first:82945.13 06:13:52 INFO - PROCESS | 16883 | Values: 441.4 447.3 448.5 450.2 458.7 20035.5 20432.2 20939.3 21278.0 21327.6 16713.7 17989.6 20506.9 20513.9 20613.2 5574.2 5982.9 5999.7 6009.4 6024.8 5864.3 5969.5 5983.5 5994.3 5998.0 5766.7 5969.3 5970.5 5972.3 5973.0 5839.2 5843.4 5849.4 5904.9 5916.0 5417.8 5642.9 5689.4 5699.4 5723.1 14234.4 16188.8 22450.0 22950.9 22977.9 2273.4 2324.8 2363.4 2407.0 2498.1 9868.7 10209.4 10218.4 10542.2 10552.3 1861.2 1868.6 1914.8 1919.5 2024.1 76844.2 78255.2 79899.0 81200.0 82767.2 11821.4 11838.2 11955.2 11981.4 12102.2 16768.6 16778.9 16957.3 16990.1 17096.5 8940.7 8972.2 9020.7 9059.5 9096.5 8945.7 8955.8 8990.6 9010.5 9127.7 4810.2 4855.2 4875.8 5032.5 5323.0 2102.3 2114.1 2124.5 2173.4 2210.8 998.2 1036.2 1036.6 1047.7 1150.6 18888.3 19325.1 19436.5 19464.6 19846.7 1041.9 1092.6 1100.9 1128.8 1148.9 10734.4 11025.8 11042.4 11045.2 11064.5 489026.0 502830.0 505069.0 505331.0 508314.0 93184.5 94173.5 94645.5 95025.5 97954.0 1061.6 1065.9 1085.5 1116.1 1135.6 16949.8 17106.0 17323.4 17450.6 17456.0 40693.4 41141.0 41249.8 41565.3 42649.1 58649.4 61250.4 61484.0 61514.6 62348.4 8716.0 8955.9 8970.9 9030.6 9076.0 13242.2 13773.9 14059.0 14222.8 14578.4 10989.8 11522.4 12051.9 12505.2 12620.2 12119.6 12269.1 12288.6 12296.9 12516.7 11865.9 11937.5 12694.6 12697.6 12717.9 9295.3 9410.9 9434.6 9498.3 9571.1 12154.3 12446.9 12537.5 12619.2 12785.4 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | [#3] mootools.html Cycles:180 Average:5859.28 Median:5183.83 stddev:3197.80 (61.7%) stddev-sans-first:3190.43 06:13:52 INFO - PROCESS | 16883 | Values: 1556.9 1571.2 1760.4 1889.6 1926.4 7762.5 8451.6 8517.6 8736.1 8757.0 8439.2 8481.7 8595.7 8614.2 8621.4 2456.7 2464.3 2464.7 2472.9 2491.6 2434.2 2477.9 2489.8 2490.0 2501.7 2477.1 2491.5 2514.6 2514.9 2517.9 2450.8 2495.7 2499.4 2505.6 2507.7 2433.6 2454.3 2462.2 2472.0 2509.6 8769.1 8873.6 8875.8 8883.3 8894.6 5563.1 5683.3 5700.7 5704.4 5718.0 3674.0 3690.9 3737.3 3751.3 3753.3 1231.1 1257.2 1279.2 1288.9 1290.8 12303.3 12313.5 12360.2 12402.5 12404.5 4896.9 4925.2 5026.4 5183.8 5183.8 10474.4 10520.4 10535.7 10548.1 10555.7 5657.5 5672.8 5682.5 5732.0 5737.9 4531.1 5080.2 5193.8 5202.8 5212.3 4230.3 4255.3 4281.7 4312.8 4335.7 1394.7 1412.1 1413.4 1437.4 1438.8 922.9 1036.3 1040.0 1065.3 1098.0 5978.9 6156.8 6179.2 6220.1 6293.2 468.2 481.0 495.3 502.7 517.4 4175.3 4297.2 4320.7 4328.3 4401.1 10672.7 10846.8 10885.5 10970.6 10993.3 10603.8 10701.9 10779.3 10827.0 10834.3 8270.6 8320.8 8342.1 8371.2 8432.8 5796.9 5863.2 5952.9 6022.1 6046.8 9470.5 9586.0 9612.9 9703.4 9759.9 9679.8 9813.9 9884.6 9959.9 10123.8 7452.0 7642.5 7676.9 7820.1 7912.9 8085.3 8111.1 8161.9 8182.1 8211.5 7376.1 7572.9 7598.2 7655.2 7709.2 7232.3 7306.2 7367.0 7404.6 7441.2 6703.8 6858.9 6893.1 6895.1 6917.1 5229.3 5323.9 5372.1 5445.5 5468.3 5386.6 5451.1 5486.5 5500.1 5512.1 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | [#4] prototype.html Cycles:180 Average:5946.49 Median:6741.90 stddev:1833.62 (27.2%) stddev-sans-first:1790.23 06:13:52 INFO - PROCESS | 16883 | Values: 363.1 363.9 364.1 369.0 373.1 6668.2 6677.6 6681.8 6686.6 6741.9 6705.2 6710.6 6714.9 6717.7 6728.9 4862.0 4956.1 4957.5 4984.7 5000.9 5025.3 5032.9 5033.8 5035.4 5037.7 4994.6 4995.0 5004.9 5005.3 5009.3 4990.9 4993.7 4994.3 5020.8 5025.4 4341.8 4350.7 4351.0 4354.5 4356.3 6305.7 6473.6 6484.3 6489.7 6515.3 5818.2 5847.6 5861.6 5864.6 5877.8 7114.8 7118.1 7118.4 7122.5 7123.2 4820.7 4823.7 4830.7 4832.6 4846.9 7335.6 7389.2 7396.4 7406.1 7423.0 4780.2 4912.8 4934.1 4942.2 4954.1 4962.9 4976.7 4987.7 4993.7 4996.2 5830.0 5838.2 5838.4 5843.6 5852.7 7134.9 7160.4 7164.2 7166.7 7170.4 1746.1 1761.5 1761.9 1763.9 1766.6 1142.3 1190.7 1223.7 1231.6 1232.6 6696.5 6741.9 6818.8 6823.3 6828.9 7194.5 7275.0 7306.3 7320.6 7338.5 6903.9 6917.9 6926.7 6931.2 6939.1 3952.8 4013.4 4014.5 4018.3 4025.8 7693.9 7756.7 7757.1 7760.4 7768.2 7344.5 7600.0 7616.0 7629.2 7680.6 7654.5 7672.9 7673.5 7688.8 7762.5 7418.9 7425.9 7430.3 7436.7 7439.9 7341.4 7344.2 7344.9 7344.9 7350.2 7620.9 7748.8 7754.4 7767.9 7770.5 4948.0 4956.6 4965.2 4992.1 5000.0 7353.6 7421.0 7424.2 7430.8 7436.6 7086.5 7143.8 7183.6 7184.1 7203.6 6977.5 7129.2 7168.1 7182.5 7183.4 7024.0 7026.6 7028.4 7043.1 7056.5 7186.9 7187.5 7206.6 7220.3 7223.3 6963.2 6996.7 7044.4 7060.0 7060.3 06:13:52 INFO - PROCESS | 16883 | 06:13:52 INFO - PROCESS | 16883 | [#5] yui.html Cycles:180 Average:15818.34 Median:21871.77 stddev:18187.11 (83.2%) stddev-sans-first:18203.69 06:13:52 INFO - PROCESS | 16883 | Values: 915.4 929.7 938.3 943.9 944.4 15274.0 15360.3 15390.2 15502.5 15521.6 15666.5 15764.1 15795.1 15815.4 15859.6 914.7 918.6 929.9 930.3 938.9 933.0 935.3 941.1 941.7 942.5 992.5 994.6 995.9 1000.6 1001.2 986.0 986.4 987.8 988.0 991.0 712.0 713.0 714.6 726.5 731.3 14422.6 14479.5 14505.4 14529.3 14574.0 14478.9 14499.3 14502.6 14561.9 14598.0 11857.3 11946.8 12095.2 12106.2 12243.3 3950.9 3993.3 4015.1 4022.4 4040.3 58071.1 58505.7 60029.7 60479.7 60836.4 11484.7 11511.9 11710.5 11719.7 11837.6 20155.8 20419.3 20457.7 20561.3 20563.2 8493.0 8698.5 8940.8 9063.0 9191.8 4760.6 4826.2 5038.2 5076.6 5216.0 3714.6 3742.7 3749.1 3778.8 3784.4 635.0 692.5 697.4 698.4 699.1 749.3 777.6 783.6 811.9 825.4 10458.9 10731.2 10908.7 10989.3 10999.2 791.8 813.0 814.9 828.5 845.6 4575.0 4835.0 4891.1 4910.3 4988.1 64747.7 66191.3 66236.7 66673.0 67077.3 55807.4 55995.0 58260.4 58772.4 58846.1 51588.7 51857.7 51878.2 52568.7 52810.7 10164.0 10305.2 10392.4 10506.8 10603.0 38707.8 38984.2 39348.6 39792.6 40306.8 44746.3 44927.8 47348.5 48923.0 50087.0 12186.0 12634.2 12718.7 12982.5 13088.4 12530.9 12856.7 13200.2 13346.9 13831.4 13115.2 13144.3 13215.2 13226.7 13513.7 12083.6 12482.1 13054.6 13220.2 13294.7 12911.5 13038.5 13193.5 13724.1 14328.9 10516.2 10564.8 10681.2 10978.8 11193.1 11311.2 11316.6 11360.3 11464.4 11475.2 06:13:52 INFO - PROCESS | 16883 | -------- Summary: end -------- 06:13:52 INFO - PROCESS | 16883 | 06:13:53 INFO - TEST-INFO | 16883: exit 0 06:13:53 INFO - TEST-OK | dromaeo_css | took 1108169ms 06:13:53 INFO - TEST-START | kraken 06:13:53 INFO - operating with platform_type : linux_ 06:13:53 INFO - Initialising browser for kraken test... 06:13:53 INFO - TEST-INFO | started process 17121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIz0U5/profile http://localhost:41880/getInfo.html) 06:13:56 INFO - PROCESS | 17121 | 06:13:56 INFO - PROCESS | 17121 | (process:17200): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:13:57 INFO - PROCESS | 17121 | __metrics Screen width/height:1600/1200 06:13:57 INFO - PROCESS | 17121 | colorDepth:24 06:13:57 INFO - PROCESS | 17121 | Browser inner width/height: 1024/697 06:13:57 INFO - PROCESS | 17121 | __metrics 06:13:57 ERROR - PROCESS | 17121 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:13:58 INFO - TEST-INFO | 17121: exit 0 06:13:58 INFO - Browser initialized. 06:13:58 INFO - Running cycle 1/1 for kraken test... 06:13:58 INFO - TEST-INFO | started process 17250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEIz0U5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:00 INFO - PROCESS | 17250 | 06:14:00 INFO - PROCESS | 17250 | (process:17316): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:14:10 INFO - PROCESS | 17250 | RSS: Main: 150925312 06:14:10 INFO - PROCESS | 17250 | 06:14:12 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41880/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:13 INFO - PROCESS | 17250 | RSS: Main: 156536832 06:14:13 INFO - PROCESS | 17250 | 06:14:16 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41880/tests/kraken/driver.html?testName=audio-dft) 06:14:16 INFO - PROCESS | 17250 | RSS: Main: 156291072 06:14:16 INFO - PROCESS | 17250 | 06:14:19 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41880/tests/kraken/driver.html?testName=audio-fft) 06:14:20 INFO - PROCESS | 17250 | RSS: Main: 156442624 06:14:20 INFO - PROCESS | 17250 | 06:14:22 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41880/tests/kraken/driver.html?testName=audio-oscillator) 06:14:23 INFO - PROCESS | 17250 | RSS: Main: 156147712 06:14:23 INFO - PROCESS | 17250 | 06:14:25 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:25 INFO - PROCESS | 17250 | RSS: Main: 156164096 06:14:25 INFO - PROCESS | 17250 | 06:14:28 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41880/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:29 INFO - PROCESS | 17250 | RSS: Main: 156532736 06:14:29 INFO - PROCESS | 17250 | 06:14:32 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41880/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:33 INFO - PROCESS | 17250 | RSS: Main: 156585984 06:14:33 INFO - PROCESS | 17250 | 06:14:36 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41880/tests/kraken/driver.html?testName=json-parse-financial) 06:14:36 INFO - PROCESS | 17250 | RSS: Main: 156479488 06:14:36 INFO - PROCESS | 17250 | 06:14:38 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:39 INFO - PROCESS | 17250 | RSS: Main: 156340224 06:14:39 INFO - PROCESS | 17250 | 06:14:40 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:41 INFO - PROCESS | 17250 | RSS: Main: 156110848 06:14:41 INFO - PROCESS | 17250 | 06:14:43 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:44 INFO - PROCESS | 17250 | RSS: Main: 157212672 06:14:44 INFO - PROCESS | 17250 | 06:14:46 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:47 INFO - PROCESS | 17250 | RSS: Main: 157126656 06:14:47 INFO - PROCESS | 17250 | 06:14:49 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:50 INFO - PROCESS | 17250 | RSS: Main: 157077504 06:14:50 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | Cycle 1(1): loaded http://localhost:41880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41880/tests/kraken/driver.html?testName=ai-astar) 06:14:52 INFO - PROCESS | 17250 | RSS: Main: 158851072 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | __start_tp_report 06:14:52 INFO - PROCESS | 17250 | _x_x_mozilla_page_load 06:14:52 INFO - PROCESS | 17250 | _x_x_mozilla_page_load_details 06:14:52 INFO - PROCESS | 17250 | |i|pagename|runs| 06:14:52 INFO - PROCESS | 17250 | |0;ai-astar;108;110;104;110;110;111;102;110;112;109 06:14:52 INFO - PROCESS | 17250 | |1;audio-beat-detection;151;134;163;181;129;157;156;127;174;130 06:14:52 INFO - PROCESS | 17250 | |2;audio-dft;162;160;163;163;162;163;162;165;162;163 06:14:52 INFO - PROCESS | 17250 | |3;audio-fft;76;72;76;169;79;77;75;78;175;76 06:14:52 INFO - PROCESS | 17250 | |4;audio-oscillator;93;92;151;93;92;91;142;93;92;153 06:14:52 INFO - PROCESS | 17250 | |5;imaging-gaussian-blur;117;117;117;120;122;117;117;117;117;117 06:14:52 INFO - PROCESS | 17250 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;146;146 06:14:52 INFO - PROCESS | 17250 | |7;imaging-desaturate;95;96;95;98;95;95;95;95;95;95 06:14:52 INFO - PROCESS | 17250 | |8;json-parse-financial;55;58;61;57;57;60;58;73;56;59 06:14:52 INFO - PROCESS | 17250 | |9;json-stringify-tinderbox;58;59;61;59;59;59;58;60;59;59 06:14:52 INFO - PROCESS | 17250 | |10;stanford-crypto-aes;72;73;81;74;83;74;74;75;83;75 06:14:52 INFO - PROCESS | 17250 | |11;stanford-crypto-ccm;118;117;113;124;119;117;119;113;139;137 06:14:52 INFO - PROCESS | 17250 | |12;stanford-crypto-pbkdf2;163;166;161;162;166;163;165;165;159;157 06:14:52 INFO - PROCESS | 17250 | |13;stanford-crypto-sha256-iterative;66;67;67;68;70;68;64;68;66;70 06:14:52 INFO - PROCESS | 17250 | __end_tp_report 06:14:52 INFO - PROCESS | 17250 | __start_cc_report 06:14:52 INFO - PROCESS | 17250 | _x_x_mozilla_cycle_collect,848 06:14:52 INFO - PROCESS | 17250 | __end_cc_report 06:14:52 INFO - PROCESS | 17250 | __startTimestamp1466255692405__endTimestamp 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | ------- Summary: start ------- 06:14:52 INFO - PROCESS | 17250 | Number of tests: 14 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.17 (2.9%) stddev-sans-first:3.35 06:14:52 INFO - PROCESS | 17250 | Values: 108.0 110.0 104.0 110.0 110.0 111.0 102.0 110.0 112.0 109.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:156.50 stddev:19.49 (12.5%) stddev-sans-first:20.67 06:14:52 INFO - PROCESS | 17250 | Values: 151.0 134.0 163.0 181.0 129.0 157.0 156.0 127.0 174.0 130.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 06:14:52 INFO - PROCESS | 17250 | Values: 162.0 160.0 163.0 163.0 162.0 163.0 162.0 165.0 162.0 163.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:40.49 (53.3%) stddev-sans-first:42.34 06:14:52 INFO - PROCESS | 17250 | Values: 76.0 72.0 76.0 169.0 79.0 77.0 75.0 78.0 175.0 76.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.38 (29.8%) stddev-sans-first:28.41 06:14:52 INFO - PROCESS | 17250 | Values: 93.0 92.0 151.0 93.0 92.0 91.0 142.0 93.0 92.0 153.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:1.75 (1.5%) stddev-sans-first:1.83 06:14:52 INFO - PROCESS | 17250 | Values: 117.0 117.0 117.0 120.0 122.0 117.0 117.0 117.0 117.0 117.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:14:52 INFO - PROCESS | 17250 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 06:14:52 INFO - PROCESS | 17250 | Values: 95.0 96.0 95.0 98.0 95.0 95.0 95.0 95.0 95.0 95.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:58.50 stddev:5.10 (8.7%) stddev-sans-first:5.16 06:14:52 INFO - PROCESS | 17250 | Values: 55.0 58.0 61.0 57.0 57.0 60.0 58.0 73.0 56.0 59.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.83 06:14:52 INFO - PROCESS | 17250 | Values: 58.0 59.0 61.0 59.0 59.0 59.0 58.0 60.0 59.0 59.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:75.00 stddev:4.22 (5.6%) stddev-sans-first:4.17 06:14:52 INFO - PROCESS | 17250 | Values: 72.0 73.0 81.0 74.0 83.0 74.0 74.0 75.0 83.0 75.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:119.00 stddev:9.20 (7.7%) stddev-sans-first:9.67 06:14:52 INFO - PROCESS | 17250 | Values: 118.0 117.0 113.0 124.0 119.0 117.0 119.0 113.0 139.0 137.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:164.00 stddev:3.02 (1.8%) stddev-sans-first:3.20 06:14:52 INFO - PROCESS | 17250 | Values: 163.0 166.0 161.0 162.0 166.0 163.0 165.0 165.0 159.0 157.0 06:14:52 INFO - PROCESS | 17250 | 06:14:52 INFO - PROCESS | 17250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.88 06:14:52 INFO - PROCESS | 17250 | Values: 66.0 67.0 67.0 68.0 70.0 68.0 64.0 68.0 66.0 70.0 06:14:52 INFO - PROCESS | 17250 | -------- Summary: end -------- 06:14:52 INFO - PROCESS | 17250 | 06:14:53 INFO - TEST-INFO | 17250: exit 0 06:14:53 INFO - TEST-OK | kraken | took 59986ms 06:14:53 INFO - SUITE-END | took 1168s 06:14:53 INFO - Completed test suite (00:19:28) 06:14:53 INFO - javascript benchmark 06:14:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.546461227734, 3406.267652454722, 3414.880479183228, 3445.0181698215997, 3447.0865220716514, 5574.888502229953, 5616.157576363547, 5625.943740562593, 5633.859153521164, 5646.153077038442, 5566.693831839248, 5621.690807005613, 5640.097584386499, 5643.181738647893, 5651.124075768253, 5071.594272458195, 5110.616703747215, 5116.258142569325, 5124.871878203037, 5151.5106064923775, 5109.3357863477695, 5214.374275086995, 5252.238425428311, 5252.894942101156, 5272.209168624718, 5098.617603679721, 5168.819091331804, 5240.737963101829, 5243.659162154467, 5310.230016647583, 5185.507376799198, 5193.480651934814, 5196.168613021936, 5197.922031169535, 5221.895562088775, 5016.974915125401, 5036.748162591855, 5107.61692873036, 5159.329287192679, 5169.4313625501545, 5470.589705772043, 5504.889902201933, 5526.115821468546, 5544.667319960815, 5596.300462442195, 6018.067199584071, 6026.457618814284, 6026.939730602681, 6044.24446944132, 6046.3349031606485, 5992.670403127826, 6092.451679348836, 6094.6952652367645, 6122.1735065766, 6133.570650054498, 5732.541396688297, 5735.1970724098655, 5735.913961290584, 5740.8851822963725, 5769.682667453289, 6241.625502469867, 6259.029850373199, 6259.092431597484, 6259.123722678829, 6263.342349053375, 5792.9420705793245, 5898.2332296802, 5919.822405327761, 6027.0, 6037.516998640186, 6005.609635373687, 6006.879862402728, 6014.188084608521, 6026.5178785697035, 6057.1519987200945, 5922.940770592239, 5931.228940237827, 5975.551833612496, 5979.760809567569, 5986.610870293417, 5945.672987985702, 5985.401459854067, 6035.758569657252, 6076.635401875813, 6138.815835524852, 4554.043650833296, 4559.498455169929, 4564.269716845355, 4566.292224705176, 4581.5647513486165, 4055.8986025349604, 4055.918881622351, 4091.3453847384276, 4106.445629839934, 4106.486689163855, 5722.141678748221, 5845.064789633639, 5858.150568167592, 5875.471207591338, 5903.822885313448, 5984.910226346608, 6023.126646636213, 6037.1246169305205, 6063.90849647059, 6067.969660151671, 5701.800436984686, 5771.0477771168125, 5784.074548072373, 5784.971075144597, 5785.450382213683, 5083.74581270935, 5154.974225128851, 5164.8192313268855, 5171.482851714798, 5194.4805519447755, 6191.938080619136, 6209.875802484015, 6270.184875966095, 6304.527160462983, 6325.652089135142, 6079.452849243412, 6094.573379863367, 6128.019516877456, 6135.233095863017, 6137.96931015342, 6263.248410190807, 6289.779857704958, 6337.112804207322, 6339.207599050119, 6359.300476947439, 6025.909611355745, 6045.335013148638, 6048.153258543895, 6048.637081775108, 6056.06131049688, 5988.640681559121, 6115.480184184395, 6142.017277235621, 6143.477804386677, 6171.352008039271, 5801.129830525286, 5832.912506312324, 5836.241288632451, 5837.94162058374, 5859.56053296013, 5754.424557544212, 5821.330546987151, 5825.854353641193, 5831.35855055952, 5872.412758724094, 5723.542116630742, 5801.303843538633, 5857.150713146485, 5905.822825315247, 5914.2311499504785, 5882.852928676817, 5993.310769261417, 6006.189164462917, 6033.879322413615, 6048.425399587032, 5904.704764761831, 5905.232319798571, 5906.173135760911, 5915.024021036653, 5922.881542369215], "value": 5588.430346290046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.8660267946409, 677.1400321591582, 686.4474098350828, 733.0397179694597, 749.6589051981348, 41849.581504184986, 42117.3682394764, 42129.57870421299, 42145.57854421455, 42254.36618450726, 44712.32931506022, 45177.54822451775, 45192.77403612986, 45368.092638147216, 45461.545384546145, 8837.911620883773, 9000.639974401016, 9011.143941325563, 9018.278537717, 9027.368084234105, 8837.337199710015, 8893.77765555863, 8904.51025193614, 9142.542872856331, 9162.954185229064, 9208.26333893287, 9246.67636632718, 9279.211267042276, 9298.070192980715, 9326.72019839406, 9150.450972941644, 9197.862032069525, 9227.953860230724, 9228.492432916188, 9243.07569243077, 9111.726648200565, 9260.953695231548, 9265.814683706356, 9284.025177356416, 9291.907080929172, 44545.33182002272, 45204.77397613024, 45298.54701453009, 45322.77338613319, 45349.0, 3896.415537669344, 4184.623383895434, 4261.147770445923, 4402.3176407656865, 4657.4876763555985, 33004.33991320184, 33387.49918751221, 33549.83225083883, 33945.49081763776, 34633.0, 4672.3925889634465, 4683.906321873577, 4702.224133018048, 4735.360726301939, 4749.4775574686755, 317969.0, 318468.0, 318828.0, 319110.0, 319921.0, 39661.40507892384, 40251.79874100611, 65499.0, 65749.0, 65868.0, 37892.43161352582, 37982.81008594995, 38114.047148821504, 38229.0, 38385.0, 16563.0, 16666.250018749186, 16676.916615416845, 16686.082265475274, 16775.2451139699, 14016.579502614937, 14092.436302547783, 14120.082194657314, 14141.575752727435, 14174.85825141756, 9537.666181683608, 9760.902390976142, 9802.313838031268, 9847.310688251897, 9852.064053914866, 3742.4947632069866, 3744.3260213161893, 3847.2882516734494, 3857.267119247334, 3896.2597106549665, 1081.6052140968648, 1124.4321617583068, 1130.3895896216115, 1134.6539305511733, 1137.5392965848844, 34007.82996085053, 34402.65597344044, 34466.655333446346, 34486.31027379489, 35125.12187195289, 1223.4494477485168, 1263.4819723913151, 1323.2523624152516, 1335.5659410691565, 1372.8695773901663, 17302.394416195373, 17809.643807123786, 17883.01643409625, 18021.909890450726, 18057.819421805878, 496377.0, 501254.0, 503214.0, 839655.0, 880092.0, 60345.69827150924, 61237.0, 61238.38761612327, 61303.38696613066, 61399.38600614026, 1536.46991787833, 1561.0789634115927, 1574.8031496062993, 1579.5577238373503, 1580.138824340737, 32776.705630605626, 34987.82506087555, 36540.451893222154, 36605.450918236784, 37211.06972325713, 58742.706286468296, 59470.40529594649, 59551.0, 59660.40339596722, 59848.70075649594, 440674.0, 443844.0, 444085.0, 445795.0, 446480.0, 48513.0, 48850.267245990624, 48932.75533622309, 49818.25272620986, 50197.24704129368, 53291.20063198978, 53634.0, 53974.0, 54401.45598544122, 54572.0, 43912.560874390845, 44959.0, 45456.0, 45854.770726146155, 46435.0, 43491.13017739691, 44459.777701111285, 44653.82098305901, 45122.54877451184, 45260.32109518294, 44858.0, 45034.0, 45499.77250113728, 45873.082538348375, 46169.15323387161, 37810.43284350682, 38853.805730971166, 39180.2163956725, 39536.802315988236, 39906.60093399029, 29371.55942660819, 29781.404371912005, 30376.0, 30420.239494012825, 30727.2318192047], "value": 20688.158692083292, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.36663887321697, 447.3205499060627, 448.4752839178161, 450.1851648516186, 458.68809209737384, 20035.499112522175, 20432.182712691512, 20939.267125650604, 21278.0, 21327.57344853102, 16713.66572668546, 17989.640207195847, 20506.897465512688, 20513.897430512825, 20613.1754729811, 5574.1917421973785, 5982.940170598304, 5999.6700181490005, 6009.399060094, 6024.759009639631, 5864.266966629171, 5969.462748352647, 5983.491403230731, 5994.340622531518, 5997.970010149965, 5766.711664416784, 5969.283685957691, 5970.492508136792, 5972.25346831646, 5973.0, 5839.240898683186, 5843.444872737105, 5849.415058494159, 5904.940950590525, 5915.970420147914, 5417.8103766367985, 5642.943570564283, 5689.402612725646, 5699.373068962411, 5723.084306510938, 14234.430622775077, 16188.75716864248, 22450.0, 22950.885245573667, 22977.88511057434, 2273.374821923984, 2324.837261391703, 2363.420961864354, 2407.0010945457616, 2498.0757119865766, 9868.654597089138, 10209.38743675382, 10218.386896786142, 10542.209334299958, 10552.31409958358, 1861.171778558542, 1868.6075924055965, 1914.827665510097, 1919.4529559075597, 2024.1498570600384, 76844.23155768427, 78255.21744782536, 79899.0, 81200.0, 82767.17232827716, 11821.408929553489, 11838.230515016496, 11955.222910510789, 11981.400929953468, 12102.213356131822, 16768.58078548046, 16778.916105419394, 16957.321707131578, 16990.065546395068, 17096.48710538686, 8940.68707595231, 8972.237359824358, 9020.684276050306, 9059.547022648841, 9096.454212747256, 8945.73162805117, 8955.820883582423, 8990.640374385082, 9010.50442225684, 9127.680531181377, 4810.182269014276, 4855.150348688965, 4875.804967801319, 5032.496750324938, 5322.973385133049, 2102.295730930125, 2114.1120729293734, 2124.479502521861, 2173.3697227804078, 2210.7789221077765, 998.201438848918, 1036.1814166808288, 1036.5750042482546, 1047.6903870162298, 1150.649052039136, 18888.33890813815, 19325.13036913342, 19436.51408714765, 19464.610707786047, 19846.70229946552, 1041.9218558608134, 1092.6121226964472, 1100.8568886044764, 1128.8476055732372, 1148.9195756296979, 10734.409607471664, 11025.779484410266, 11042.447877606088, 11045.226834121535, 11064.502097405637, 489026.0, 502830.0, 505069.0, 505331.0, 508314.0, 93184.53407732918, 94173.5291323539, 94645.52677236707, 95025.5248723752, 97954.0, 1061.601899287767, 1065.9360438373722, 1085.4898197846999, 1116.1405717597568, 1135.5741596901162, 16949.830501694825, 17106.0, 17323.393681221096, 17450.563735906704, 17456.0, 40693.389599155445, 41141.0, 41249.79375103105, 41565.33738650541, 42649.147017058865, 58649.413505864395, 61250.38749612625, 61484.0, 61514.64776675083, 62348.37651623607, 8716.0, 8955.865662015205, 8970.865437018581, 9030.63877444895, 9076.0, 13242.20546767197, 13773.862261377659, 14059.0, 14222.786658200343, 14578.416863325348, 10989.780204395707, 11522.366269855238, 12051.939740301243, 12505.187162834387, 12620.242785432903, 12119.575814846437, 12269.079819013788, 12288.569900053455, 12296.877031229573, 12516.687082823002, 11865.881341186478, 11937.462814173557, 12694.555690551157, 12697.55558555446, 12717.93641031826, 9295.256379489489, 9410.858837117587, 9434.622615095319, 9498.335116541775, 9571.138597526256, 12154.331511766584, 12446.937765311477, 12537.498500059895, 12619.242845429304, 12785.36073196355], "value": 9616.862770498872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1556.9221538923055, 1571.1594297051076, 1760.4102625620417, 1889.640968216038, 1926.412444204518, 7762.49543779654, 8451.619677114544, 8517.616707248173, 8736.082711315308, 8757.0, 8439.19827616377, 8481.703140390073, 8595.699150529732, 8614.181652742995, 8621.353398495106, 2456.66834977278, 2464.2607217834666, 2464.667269918565, 2472.913448029319, 2491.5888878335054, 2434.160214725917, 2477.9008839646394, 2489.788367988723, 2489.950200995988, 2501.737317581646, 2477.095860011101, 2491.501699660066, 2514.647949287092, 2514.9119780807673, 2517.874106294687, 2450.779429851313, 2495.663085483455, 2499.3751562109474, 2505.624156376558, 2507.699076110869, 2433.586290330648, 2454.2882564056404, 2462.236706620953, 2471.9741307357426, 2509.623556466526, 8769.123087691243, 8873.600687968992, 8875.822483550357, 8883.289336853037, 8894.555272236363, 5563.082091454905, 5683.3464151622675, 5700.714964251771, 5704.429557044304, 5718.0, 3673.981630091859, 3690.926181476382, 3737.2712321097397, 3751.3435148848844, 3753.2868754936476, 1231.1382032577142, 1257.1953949472345, 1279.181323952671, 1288.8646692097288, 1290.7870201416754, 12303.32331721755, 12313.507459701512, 12360.196587221802, 12402.503899843996, 12404.503819847196, 4896.902061958741, 4925.162722337212, 5026.447090820006, 5183.81856635016, 5183.844484665466, 10474.423906685206, 10520.368777873353, 10535.683929482127, 10548.050675439248, 10555.683329500127, 5657.547396208293, 5672.801451949162, 5682.488576028178, 5732.0, 5737.913931291034, 4531.071130418256, 5080.237964305384, 5193.818216362409, 5202.817901373433, 5212.296339994128, 4230.323148296257, 4255.255330317182, 4281.7002809803635, 4312.7627980461375, 4335.653147748236, 1394.6652803327129, 1412.053923871009, 1413.441690532234, 1437.3531910640254, 1438.8489208633152, 922.898481167071, 1036.259074761549, 1039.9688009359731, 1065.2862582070031, 1097.9615713449991, 5978.923793717173, 6156.815295541141, 6179.227596550431, 6220.098085777537, 6293.181886354744, 468.20872725094483, 481.0139214610035, 495.2571143285072, 502.69586899925747, 517.3791450259704, 4175.269327867611, 4297.226499230169, 4320.65434765218, 4328.264195086843, 4401.075774087413, 10672.733181670521, 10846.837297440545, 10885.455727213608, 10970.561177552809, 10993.285436446606, 10603.84094238587, 10701.89298107009, 10779.299345542515, 10827.025567698787, 10834.349939003685, 8270.586470676442, 8320.8335833283, 8342.082370939192, 8371.246587807127, 8432.78918027042, 5796.94203057964, 5863.1791549184, 5952.910706339495, 6022.066579680157, 6046.818595442144, 9470.526473676426, 9585.952070239604, 9612.855807162758, 9703.369280996712, 9759.9024009759, 9679.758006049906, 9813.9018609813, 9884.555195016097, 9959.900400996186, 10123.848142278019, 7452.0, 7642.465027448247, 7676.884846727416, 7820.061592608923, 7912.881306780288, 8085.272325490734, 8111.06722726894, 8161.877571836309, 8182.099969003524, 8211.507309561446, 7376.114866216089, 7572.886406703794, 7598.164201937893, 7655.234476552523, 7709.151993280847, 7232.276772322725, 7306.159791623819, 7366.96316518414, 7404.592747398945, 7441.218672039575, 6703.798886033427, 6858.931410686029, 6893.138357705287, 6895.103636527219, 6917.066196063467, 5229.267902493578, 5323.920141197963, 5372.059889519241, 5445.50990410865, 5468.28912241406, 5386.569074473954, 5451.127819548853, 5486.506214440719, 5500.064988951968, 5512.145617429305], "value": 4710.070476424826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.09589123083515, 363.8617325416342, 364.1097516571981, 369.0478565301519, 373.1343283582091, 6668.166479190101, 6677.599344039355, 6681.799546013622, 6686.632235227061, 6741.898871516931, 6705.195376554808, 6710.597364158154, 6714.899276510856, 6717.731290748364, 6728.9327106728915, 4862.0, 4956.132676781567, 4957.5042495750495, 4984.725840078794, 5000.924986125211, 5025.271335656327, 5032.949670503303, 5033.84898453047, 5035.370578677665, 5037.672551284155, 4994.625403094764, 4995.0, 5004.948960718253, 5005.349304590398, 5009.273655319977, 4990.875228119308, 4993.650444468889, 4994.325766021595, 5020.849374518771, 5025.422076461217, 4341.826326946918, 4350.71720338177, 4351.042770590497, 4354.477462704464, 4356.324769660676, 6305.716242769086, 6473.611583305017, 6484.319146489598, 6489.734501772156, 6515.3484651534945, 5818.185454036438, 5847.619904706181, 5861.589688721791, 5864.5894787364905, 5877.764889404419, 7114.822129446753, 7118.110236220473, 7118.430525557943, 7122.537035092702, 7123.180834204081, 4820.734859582722, 4823.686460380064, 4830.661853670244, 4832.613390928753, 4846.854594362175, 7335.633218339061, 7389.187189409161, 7396.371308438789, 7406.148292946273, 7423.0, 4780.1873681474235, 4912.778924948386, 4934.1118598651865, 4942.159832828428, 4954.133026720309, 4962.851114466572, 4976.676516026447, 4987.700737955734, 4993.675411098267, 4996.200607902791, 5829.970850145722, 5838.241028666246, 5838.4453476919625, 5843.590948633555, 5852.707364631751, 7134.857302854018, 7160.391366733782, 7164.247753985756, 7166.713331466683, 7170.42636589082, 1746.05712915027, 1761.5419990802484, 1761.9119044047745, 1763.8941663500232, 1766.6466706658462, 1142.3488611491537, 1190.696372425026, 1223.6573759347398, 1231.6181983584938, 1232.6363722701824, 6696.46428285736, 6741.898871516931, 6818.795436136924, 6823.317668233137, 6828.931710682829, 7194.532355396883, 7274.963625181946, 7306.305900939402, 7320.633968301564, 7338.522996005243, 6903.930960690429, 6917.89623155643, 6926.722931082701, 6931.202911665122, 6939.063226464464, 3952.782596957195, 4013.418054382098, 4014.5182578090817, 4018.2967980603275, 4025.77858217795, 7693.92285080078, 7756.728514502078, 7757.146713861471, 7760.417968652374, 7768.184340644264, 7344.502869024451, 7600.0, 7615.961920190363, 7629.160792312841, 7680.577568233801, 7654.540727556365, 7672.884906726404, 7673.539587624648, 7688.769336919901, 7762.495437796638, 7418.851622967619, 7425.925740742523, 7430.256974302527, 7436.73971410998, 7439.851202976019, 7341.375983041287, 7344.192138864827, 7344.8898266524975, 7344.8898266524975, 7350.154732205651, 7620.885686714593, 7748.8450230996195, 7754.379649628129, 7767.9223207769455, 7770.53376797394, 4947.950520494893, 4956.578690811321, 4965.155923492943, 4992.076465853828, 4999.950000499948, 7353.5955522446775, 7421.0, 7424.220456851953, 7430.814229644302, 7436.59098749574, 7086.50394472382, 7143.82140446493, 7183.640817959185, 7184.1019872515935, 7203.603801790951, 6977.511574189758, 7129.180144283267, 7168.103987001625, 7182.497225194186, 7183.425325973805, 7023.964880175567, 7026.578405295699, 7028.402585780266, 7043.084399028094, 7056.470764692771, 7186.892196617159, 7187.532810367309, 7206.603636800026, 7220.277972202738, 7223.349898508949, 6963.199232088375, 6996.720131194696, 7044.366007059184, 7060.0, 7060.258672839278], "value": 5347.17680969586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.4370062411617, 929.7396728915902, 938.3431597881482, 943.9433633981957, 944.3814301632433, 15274.0, 15360.310365859774, 15390.153541555237, 15502.534923952286, 15521.611959700998, 15666.451674191378, 15764.132972686497, 15795.131267780267, 15815.446459373925, 15859.603509912258, 914.6524320758102, 918.591226904028, 929.9070092990714, 930.3441074042818, 938.8638647396124, 933.0110083311712, 935.2658163341778, 941.0683423410842, 941.6892425499568, 942.5051847779936, 992.4938281476462, 994.6319861651162, 995.8655581496478, 1000.6197644894929, 1001.2040427859832, 986.0484632329765, 986.3637953519975, 987.8320685483485, 987.9555420006081, 990.9851352229722, 711.9679614417312, 713.0, 714.610537257196, 726.5422783646322, 731.2906480713752, 14422.639434014234, 14479.493217737434, 14505.41978320866, 14529.273536323142, 14574.0, 14478.85521144796, 14499.275036248146, 14502.637434064127, 14561.854381456156, 14598.0, 11857.288562686266, 11946.761064778655, 12095.17613345717, 12106.213096148722, 12243.32661703606, 3950.940735888964, 3993.341098718708, 4015.0765323975356, 4022.416749571296, 4040.2929487339597, 58071.128933065615, 58505.707471462796, 60029.699851500896, 60479.69760151171, 60836.391636083514, 11484.712882177846, 11511.884881151082, 11710.473028713728, 11719.707007324885, 11837.644870653894, 20155.798442015686, 20419.285325013552, 20457.693134602992, 20561.280355187497, 20563.177472900916, 8492.965841225368, 8698.521581313089, 8940.821183576421, 9063.0, 9191.816163676689, 4760.571548560646, 4826.227803551415, 5038.2190760432195, 5076.593872490266, 5216.035033518811, 3714.647108524686, 3742.700583953277, 3749.081475038633, 3778.792166430873, 3784.4323351496946, 634.9682515874188, 692.4875592061838, 697.4141720954423, 698.434268242725, 699.1156187422914, 749.2657195948002, 777.6228529163351, 783.6160281462043, 811.9350451963946, 825.3809642767924, 10458.921020801894, 10731.195160363004, 10908.69259991326, 10989.340639561651, 10999.23005389615, 791.8099656082499, 813.0446725097986, 814.8573999550055, 828.5484410996022, 845.572985642259, 4575.0, 4834.95165048352, 4891.070696567641, 4910.263460480956, 4988.127077761377, 64747.67626161839, 66191.33808661852, 66236.66881665657, 66673.0, 67077.32922670711, 55807.441925581035, 55995.0, 58260.41739582635, 58772.41227587755, 58846.11730824041, 51588.74205628948, 51857.7407112962, 51878.22182667263, 52568.737156313975, 52810.73594632002, 10163.988471355857, 10305.175585952957, 10392.42841643717, 10506.789864202827, 10603.045725884707, 38707.80646096751, 38984.220315594095, 39348.606513934494, 39792.60207397889, 40306.79846600748, 44746.3288050673, 44927.775361122985, 47348.52651473441, 48923.02153956972, 50087.0, 12185.96419304369, 12634.178778379375, 12718.682032949251, 12982.480700771863, 13088.411021503865, 12530.874691253335, 12856.678583035498, 13200.20798752078, 13346.866531334563, 13831.446742130202, 13115.213087214797, 13144.34278286101, 13215.207087574776, 13226.735465290833, 13513.662158446117, 12083.57707480234, 12482.063845211827, 13054.608361749162, 13220.206787592775, 13294.734105318033, 12911.5480958166, 13038.54365097255, 13193.538226162422, 13724.107932984323, 14328.856711433169, 10516.211284153873, 10564.788704226026, 10681.19891008193, 10978.835317470084, 11193.104551635686, 11311.208215424842, 11316.60083579482, 11360.318380897173, 11464.4267786612, 11475.196736228383], "value": 7332.7825598749505, "unit": "score"}], "name": "dromaeo_css", "value": 7680.989757198211, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 104.0, 110.0, 110.0, 111.0, 102.0, 110.0, 112.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 134.0, 163.0, 181.0, 129.0, 157.0, 156.0, 127.0, 174.0, 130.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 163.0, 162.0, 163.0, 162.0, 165.0, 162.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 76.0, 169.0, 79.0, 77.0, 75.0, 78.0, 175.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 151.0, 93.0, 92.0, 91.0, 142.0, 93.0, 92.0, 153.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 120.0, 122.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 61.0, 57.0, 57.0, 60.0, 58.0, 73.0, 56.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 61.0, 59.0, 59.0, 59.0, 58.0, 60.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 81.0, 74.0, 83.0, 74.0, 74.0, 75.0, 83.0, 75.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 113.0, 124.0, 119.0, 117.0, 119.0, 113.0, 139.0, 137.0], "value": 121.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 161.0, 162.0, 166.0, 163.0, 165.0, 165.0, 159.0, 157.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 70.0, 68.0, 64.0, 68.0, 66.0, 70.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1531.3999999999999, "alertThreshold": 2.0}]} 06:14:53 INFO - Return code: 0 06:14:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:14:53 ERROR - # TBPL SUCCESS # 06:14:53 INFO - Running post-action listener: _resource_record_post_action 06:14:53 INFO - Running post-run listener: _resource_record_post_run 06:14:54 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 474599424; Read time: 0; Write time: 334476 06:14:54 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 203710464; Read time: 0; Write time: 204632 06:14:54 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 224010240; Read time: 0; Write time: 116488 06:14:54 INFO - Running post-run listener: _upload_blobber_files 06:14:54 INFO - Blob upload gear active. 06:14:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:54 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:14:54 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:14:54 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:14:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:56 INFO - (blobuploader) - INFO - Done attempting. 06:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:14:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:56 INFO - (blobuploader) - INFO - Done attempting. 06:14:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:56 INFO - Return code: 0 06:14:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdbece446be4bd29afa86481748f5f4ee58715300eb1b5d5c966eb07cf682733b99f3bf85ca570ea1118c658f910a2be02d657e51c6f07c7081b5ac19e85070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2cdbe099930d65f95e02560112bef8603f76b26d54610d43c7f41251c6918e358c66a1db00a627d0184ba94586a4c83ac2b185d4500d52115564e55f1847a67"} 06:14:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:56 INFO - Contents: 06:14:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdbece446be4bd29afa86481748f5f4ee58715300eb1b5d5c966eb07cf682733b99f3bf85ca570ea1118c658f910a2be02d657e51c6f07c7081b5ac19e85070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2cdbe099930d65f95e02560112bef8603f76b26d54610d43c7f41251c6918e358c66a1db00a627d0184ba94586a4c83ac2b185d4500d52115564e55f1847a67"} 06:14:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:56 INFO - Copying logs to upload dir... 06:14:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.790262 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-18 06:14:55.908528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:55.911921) ========= 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=923d835db2ba3686ebe126b700000192-1466249473.521666-488531644 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/8bdbece446be4bd29afa86481748f5f4ee58715300eb1b5d5c966eb07cf682733b99f3bf85ca570ea1118c658f910a2be02d657e51c6f07c7081b5ac19e85070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2cdbe099930d65f95e02560112bef8603f76b26d54610d43c7f41251c6918e358c66a1db00a627d0184ba94586a4c83ac2b185d4500d52115564e55f1847a67"} build_url:https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011897 build_url: 'https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/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/8bdbece446be4bd29afa86481748f5f4ee58715300eb1b5d5c966eb07cf682733b99f3bf85ca570ea1118c658f910a2be02d657e51c6f07c7081b5ac19e85070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2cdbe099930d65f95e02560112bef8603f76b26d54610d43c7f41251c6918e358c66a1db00a627d0184ba94586a4c83ac2b185d4500d52115564e55f1847a67"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:55.937746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:55.938069) ========= 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=923d835db2ba3686ebe126b700000192-1466249473.521666-488531644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:56.025113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:14:56.025867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:14:56.026494) ========= ========= Total master_lag: 0.19 =========