builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1468476086.22 results: success (0) buildid: 20160713154642 builduid: 0219f93640ac4a39933847396c8d0f21 revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.223625) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.224083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.224359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.239499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.239907) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:01:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.7M=0.001s 2016-07-13 23:01:26 (17.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.418383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.421866) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.471402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:26.474928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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=a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:01:26,770 truncating revision to first 12 chars 2016-07-13 23:01:26,770 Setting DEBUG logging. 2016-07-13 23:01:26,770 attempt 1/10 2016-07-13 23:01:26,771 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/84c59d136a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:01:27,081 unpacking tar archive at: mozilla-beta-84c59d136a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:27.164166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:27.164471) ========= script_repo_revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:27.168155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:27.168444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:01:27.179236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-13 23:01:27.179638) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:01:27 INFO - MultiFileLogger online at 20160713 23:01:27 in /builds/slave/test 23:01:27 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 23:01:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:01:27 INFO - {'append_to_log': False, 23:01:27 INFO - 'base_work_dir': '/builds/slave/test', 23:01:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:01:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:01:27 INFO - 'branch': 'Mozilla-Beta', 23:01:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:01:27 INFO - 'config_files': ('talos/linux_config.py',), 23:01:27 INFO - 'default_actions': ('clobber', 23:01:27 INFO - 'read-buildbot-config', 23:01:27 INFO - 'download-and-extract', 23:01:27 INFO - 'populate-webroot', 23:01:27 INFO - 'create-virtualenv', 23:01:27 INFO - 'install', 23:01:27 INFO - 'run-tests'), 23:01:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:01:27 INFO - 'download_minidump_stackwalk': True, 23:01:27 INFO - 'download_symbols': 'ondemand', 23:01:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:01:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:01:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:01:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:01:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:01:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:01:27 INFO - 'installer_path': 'installer.exe', 23:01:27 INFO - 'log_level': 'info', 23:01:27 INFO - 'log_name': 'talos', 23:01:27 INFO - 'log_to_console': True, 23:01:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:01:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:01:27 INFO - 'opt_config_files': (), 23:01:27 INFO - 'pip_index': False, 23:01:27 INFO - 'sps_profile': False, 23:01:27 INFO - 'sps_profile_interval': 0, 23:01:27 INFO - 'suite': 'dromaeojs-e10s', 23:01:27 INFO - 'system_bits': '32', 23:01:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:01:27 INFO - 'title': 'talos-linux64-ix-064', 23:01:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:01:27 INFO - 'use_talos_json': True, 23:01:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:01:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:01:27 INFO - 'work_dir': 'build'} 23:01:27 INFO - ##### 23:01:27 INFO - ##### Running clobber step. 23:01:27 INFO - ##### 23:01:27 INFO - Running pre-action listener: _resource_record_pre_action 23:01:27 INFO - Running main action method: clobber 23:01:27 INFO - rmtree: /builds/slave/test/build 23:01:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:01:28 INFO - Running post-action listener: _resource_record_post_action 23:01:28 INFO - ##### 23:01:28 INFO - ##### Running read-buildbot-config step. 23:01:28 INFO - ##### 23:01:28 INFO - Running pre-action listener: _resource_record_pre_action 23:01:28 INFO - Running main action method: read_buildbot_config 23:01:28 INFO - Using buildbot properties: 23:01:28 INFO - { 23:01:28 INFO - "project": "", 23:01:28 INFO - "product": "firefox", 23:01:28 INFO - "script_repo_revision": "production", 23:01:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:01:28 INFO - "repository": "", 23:01:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:01:28 INFO - "buildid": "20160713154642", 23:01:28 INFO - "pgo_build": "True", 23:01:28 INFO - "basedir": "/builds/slave/test", 23:01:28 INFO - "buildnumber": 96, 23:01:28 INFO - "slavename": "talos-linux64-ix-064", 23:01:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:01:28 INFO - "platform": "ubuntu64_hw", 23:01:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:01:28 INFO - "branch": "mozilla-beta", 23:01:28 INFO - "repo_path": "releases/mozilla-beta", 23:01:28 INFO - "revision": "84c59d136a9e54be69571b75a19e8a8ccff7b8a1", 23:01:28 INFO - "stage_platform": "linux64-pgo", 23:01:28 INFO - "builduid": "0219f93640ac4a39933847396c8d0f21", 23:01:28 INFO - "slavebuilddir": "test" 23:01:28 INFO - } 23:01:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:01:28 INFO - Running post-action listener: _resource_record_post_action 23:01:28 INFO - ##### 23:01:28 INFO - ##### Running download-and-extract step. 23:01:28 INFO - ##### 23:01:28 INFO - Running pre-action listener: _resource_record_pre_action 23:01:28 INFO - Running main action method: download_and_extract 23:01:28 INFO - mkdir: /builds/slave/test/build/tests 23:01:28 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')]} 23:01:28 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:28 INFO - Downloaded 1327 bytes. 23:01:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:01:28 INFO - Using the following test package requirements: 23:01:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:01:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:01:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:01:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'jsshell-linux-x86_64.zip'], 23:01:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:01:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:01:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:01:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:01:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:01:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:01:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:01:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:01:28 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')]} 23:01:28 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:29 INFO - Downloaded 24199658 bytes. 23:01:29 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'] 23:01:29 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 23:01:30 INFO - Return code: 0 23:01:30 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 23:01:30 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')]} 23:01:30 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:32 INFO - Downloaded 24199658 bytes. 23:01:32 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'] 23:01:32 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 23:01:33 INFO - Return code: 0 23:01: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')]} 23:01:33 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:34 INFO - Downloaded 10840145 bytes. 23:01:34 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'] 23:01:34 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 23:01:34 INFO - Return code: 0 23:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:34 INFO - https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfmiI2iaTtitBchFRO-o1w/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 23:01:36 INFO - Downloaded 56027951 bytes. 23:01:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:36 INFO - mkdir: /builds/slave/test/properties 23:01:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:01:36 INFO - Writing to file /builds/slave/test/properties/build_url 23:01:36 INFO - Contents: 23:01:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:01:36 INFO - Running post-action listener: _resource_record_post_action 23:01:36 INFO - Running post-action listener: set_extra_try_arguments 23:01:36 INFO - ##### 23:01:36 INFO - ##### Running populate-webroot step. 23:01:36 INFO - ##### 23:01:36 INFO - Running pre-action listener: _resource_record_pre_action 23:01:36 INFO - Running main action method: populate_webroot 23:01:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:01:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:01:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:01:36 INFO - '--tppagecycles', 23:01:36 INFO - '7'], 23:01:36 INFO - 'tests': ['tsvgm']}}, 23:01:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:01:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:01:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:01:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:01:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:01:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:01:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['damp', 'tps']}, 23:01:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'tests': ['damp', 'tps']}, 23:01:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['dromaeo_dom']}, 23:01:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:01:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['a11yr', 23:01:36 INFO - 'ts_paint', 23:01:36 INFO - 'tpaint', 23:01:36 INFO - 'sessionrestore', 23:01:36 INFO - 'sessionrestore_no_auto_restore', 23:01:36 INFO - 'tabpaint']}, 23:01:36 INFO - 'other-e10s': {'tests': ['a11yr', 23:01:36 INFO - 'ts_paint', 23:01:36 INFO - 'tpaint', 23:01:36 INFO - 'sessionrestore', 23:01:36 INFO - 'sessionrestore_no_auto_restore', 23:01:36 INFO - 'tabpaint']}, 23:01:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:01:36 INFO - 'ts_paint', 23:01:36 INFO - 'tpaint', 23:01:36 INFO - 'sessionrestore', 23:01:36 INFO - 'sessionrestore_no_auto_restore', 23:01:36 INFO - 'tabpaint']}, 23:01:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:01:36 INFO - 'ts_paint', 23:01:36 INFO - 'tpaint', 23:01:36 INFO - 'sessionrestore', 23:01:36 INFO - 'sessionrestore_no_auto_restore', 23:01:36 INFO - 'tabpaint']}, 23:01:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['a11yr', 23:01:36 INFO - 'ts_paint', 23:01:36 INFO - 'tpaint', 23:01:36 INFO - 'sessionrestore', 23:01:36 INFO - 'sessionrestore_no_auto_restore', 23:01:36 INFO - 'tabpaint']}, 23:01:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['a11yr', 23:01:36 INFO - 'ts_paint', 23:01:36 INFO - 'tpaint', 23:01:36 INFO - 'sessionrestore', 23:01:36 INFO - 'sessionrestore_no_auto_restore', 23:01:36 INFO - 'tabpaint']}, 23:01:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['tsvgx', 23:01:36 INFO - 'tsvgr_opacity', 23:01:36 INFO - 'tart', 23:01:36 INFO - 'tscrollx', 23:01:36 INFO - 'cart']}, 23:01:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:01:36 INFO - 'tsvgr_opacity', 23:01:36 INFO - 'tart', 23:01:36 INFO - 'tscrollx', 23:01:36 INFO - 'cart']}, 23:01:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'talos_options': ['--disable-e10s'], 23:01:36 INFO - 'tests': ['tp5o']}, 23:01:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'tests': ['tp5o']}, 23:01:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'talos_options': ['--disable-e10s', 23:01:36 INFO - '--xperf_path', 23:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:01:36 INFO - 'tests': ['tp5n']}, 23:01:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:36 INFO - 'talos_options': ['--xperf_path', 23:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:01:36 INFO - 'tests': ['tp5n']}}, 23:01:36 INFO - 'talos.zip': {'path': '', 23:01:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:01:36 INFO - Running post-action listener: _resource_record_post_action 23:01:36 INFO - ##### 23:01:36 INFO - ##### Running create-virtualenv step. 23:01:36 INFO - ##### 23:01:36 INFO - Running pre-action listener: _resource_record_pre_action 23:01:36 INFO - Running main action method: create_virtualenv 23:01:36 INFO - Creating virtualenv /builds/slave/test/build/venv 23:01:36 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 23:01:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:01:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:01:37 INFO - Using real prefix '/usr' 23:01:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:01:37 INFO - Installing distribute.............................................................................................................................................................................................done. 23:01:39 INFO - Installing pip.................done. 23:01:39 INFO - Return code: 0 23:01:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:01:39 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')]} 23:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:39 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')]} 23:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:39 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:39 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 23:01:39 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 23:01:39 INFO - Using env: {'DISPLAY': ':0', 23:01:39 INFO - 'HOME': '/home/cltbld', 23:01:39 INFO - 'LANG': 'en_US.UTF-8', 23:01:39 INFO - 'LANGUAGE': 'en_US:en', 23:01:39 INFO - 'LOGNAME': 'cltbld', 23:01:39 INFO - 'MAIL': '/var/mail/cltbld', 23:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:39 INFO - 'MOZ_NO_REMOTE': '1', 23:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:39 INFO - 'NO_EM_RESTART': '1', 23:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:39 INFO - 'PWD': '/builds/slave/test', 23:01:39 INFO - 'SHELL': '/bin/bash', 23:01:39 INFO - 'SHLVL': '1', 23:01:39 INFO - 'TERM': 'linux', 23:01:39 INFO - 'TMOUT': '86400', 23:01:39 INFO - 'USER': 'cltbld', 23:01:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:39 INFO - '_': '/tools/buildbot/bin/python'} 23:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:39 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 23:01:39 INFO - Cleaning up... 23:01:39 INFO - Return code: 0 23:01:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:01:39 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')]} 23:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:39 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')]} 23:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:39 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:39 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 23:01:39 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 23:01:39 INFO - Using env: {'DISPLAY': ':0', 23:01:39 INFO - 'HOME': '/home/cltbld', 23:01:39 INFO - 'LANG': 'en_US.UTF-8', 23:01:39 INFO - 'LANGUAGE': 'en_US:en', 23:01:39 INFO - 'LOGNAME': 'cltbld', 23:01:39 INFO - 'MAIL': '/var/mail/cltbld', 23:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:39 INFO - 'MOZ_NO_REMOTE': '1', 23:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:39 INFO - 'NO_EM_RESTART': '1', 23:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:39 INFO - 'PWD': '/builds/slave/test', 23:01:39 INFO - 'SHELL': '/bin/bash', 23:01:39 INFO - 'SHLVL': '1', 23:01:39 INFO - 'TERM': 'linux', 23:01:39 INFO - 'TMOUT': '86400', 23:01:39 INFO - 'USER': 'cltbld', 23:01:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:39 INFO - '_': '/tools/buildbot/bin/python'} 23:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:40 INFO - Downloading/unpacking psutil>=0.7.1 23:01:40 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 23:01:40 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 23:01:40 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 23:01:40 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 23:01:40 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 23:01:40 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 23:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:01:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:42 INFO - Installing collected packages: psutil 23:01:42 INFO - Running setup.py install for psutil 23:01:42 INFO - building 'psutil._psutil_linux' extension 23:01:42 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 23:01:42 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 23:01:42 INFO - building 'psutil._psutil_posix' extension 23:01:42 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 23:01:42 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 23:01:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:42 INFO - Successfully installed psutil 23:01:42 INFO - Cleaning up... 23:01:42 INFO - Return code: 0 23:01:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:42 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:42 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 23:01:42 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 23:01:42 INFO - Using env: {'DISPLAY': ':0', 23:01:42 INFO - 'HOME': '/home/cltbld', 23:01:42 INFO - 'LANG': 'en_US.UTF-8', 23:01:42 INFO - 'LANGUAGE': 'en_US:en', 23:01:42 INFO - 'LOGNAME': 'cltbld', 23:01:42 INFO - 'MAIL': '/var/mail/cltbld', 23:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:42 INFO - 'MOZ_NO_REMOTE': '1', 23:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:42 INFO - 'NO_EM_RESTART': '1', 23:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:42 INFO - 'PWD': '/builds/slave/test', 23:01:42 INFO - 'SHELL': '/bin/bash', 23:01:42 INFO - 'SHLVL': '1', 23:01:42 INFO - 'TERM': 'linux', 23:01:42 INFO - 'TMOUT': '86400', 23:01:42 INFO - 'USER': 'cltbld', 23:01:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:42 INFO - '_': '/tools/buildbot/bin/python'} 23:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:01:44 INFO - Installing collected packages: mozsystemmonitor 23:01:44 INFO - Running setup.py install for mozsystemmonitor 23:01:44 INFO - Successfully installed mozsystemmonitor 23:01:44 INFO - Cleaning up... 23:01:44 INFO - Return code: 0 23:01:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:44 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:44 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 23:01:44 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 23:01:44 INFO - Using env: {'DISPLAY': ':0', 23:01:44 INFO - 'HOME': '/home/cltbld', 23:01:44 INFO - 'LANG': 'en_US.UTF-8', 23:01:44 INFO - 'LANGUAGE': 'en_US:en', 23:01:44 INFO - 'LOGNAME': 'cltbld', 23:01:44 INFO - 'MAIL': '/var/mail/cltbld', 23:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:44 INFO - 'MOZ_NO_REMOTE': '1', 23:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:44 INFO - 'NO_EM_RESTART': '1', 23:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:44 INFO - 'PWD': '/builds/slave/test', 23:01:44 INFO - 'SHELL': '/bin/bash', 23:01:44 INFO - 'SHLVL': '1', 23:01:44 INFO - 'TERM': 'linux', 23:01:44 INFO - 'TMOUT': '86400', 23:01:44 INFO - 'USER': 'cltbld', 23:01:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:44 INFO - '_': '/tools/buildbot/bin/python'} 23:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:45 INFO - Downloading/unpacking blobuploader==1.2.4 23:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:47 INFO - Downloading blobuploader-1.2.4.tar.gz 23:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:01:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:01:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:47 INFO - Downloading docopt-0.6.1.tar.gz 23:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:01:47 INFO - Installing collected packages: blobuploader, requests, docopt 23:01:47 INFO - Running setup.py install for blobuploader 23:01:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:01:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:01:47 INFO - Running setup.py install for requests 23:01:48 INFO - Running setup.py install for docopt 23:01:48 INFO - Successfully installed blobuploader requests docopt 23:01:48 INFO - Cleaning up... 23:01:48 INFO - Return code: 0 23:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:48 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:48 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 23:01:48 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 23:01:48 INFO - Using env: {'DISPLAY': ':0', 23:01:48 INFO - 'HOME': '/home/cltbld', 23:01:48 INFO - 'LANG': 'en_US.UTF-8', 23:01:48 INFO - 'LANGUAGE': 'en_US:en', 23:01:48 INFO - 'LOGNAME': 'cltbld', 23:01:48 INFO - 'MAIL': '/var/mail/cltbld', 23:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:48 INFO - 'MOZ_NO_REMOTE': '1', 23:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:48 INFO - 'NO_EM_RESTART': '1', 23:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:48 INFO - 'PWD': '/builds/slave/test', 23:01:48 INFO - 'SHELL': '/bin/bash', 23:01:48 INFO - 'SHLVL': '1', 23:01:48 INFO - 'TERM': 'linux', 23:01:48 INFO - 'TMOUT': '86400', 23:01:48 INFO - 'USER': 'cltbld', 23:01:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:48 INFO - '_': '/tools/buildbot/bin/python'} 23:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:48 INFO - Running setup.py (path:/tmp/pip-LLJpjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:48 INFO - Running setup.py (path:/tmp/pip-q30_Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:48 INFO - Running setup.py (path:/tmp/pip-mhqyIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:48 INFO - Running setup.py (path:/tmp/pip-xflDVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:48 INFO - Running setup.py (path:/tmp/pip-XTMOiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:49 INFO - Running setup.py (path:/tmp/pip-7Ch_K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:49 INFO - Running setup.py (path:/tmp/pip-VFPRtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:49 INFO - Running setup.py (path:/tmp/pip-ejCPjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:49 INFO - Running setup.py (path:/tmp/pip-PDYQFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:49 INFO - Running setup.py (path:/tmp/pip-PE7MC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:49 INFO - Running setup.py (path:/tmp/pip-TmloCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:49 INFO - Running setup.py (path:/tmp/pip-C5Wo0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:49 INFO - Running setup.py (path:/tmp/pip-wwvF71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:49 INFO - Running setup.py (path:/tmp/pip-Ph9ggI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:49 INFO - Running setup.py (path:/tmp/pip-WdXcuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:49 INFO - Running setup.py (path:/tmp/pip-x9URR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:49 INFO - Running setup.py (path:/tmp/pip-KDYZDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:01:49 INFO - Running setup.py install for manifestparser 23:01:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Running setup.py install for mozcrash 23:01:50 INFO - Running setup.py install for mozdebug 23:01:50 INFO - Running setup.py install for mozdevice 23:01:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Running setup.py install for mozfile 23:01:50 INFO - Running setup.py install for mozhttpd 23:01:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Running setup.py install for mozinfo 23:01:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Running setup.py install for mozInstall 23:01:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Running setup.py install for mozleak 23:01:50 INFO - Running setup.py install for mozlog 23:01:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:01:50 INFO - Running setup.py install for moznetwork 23:01:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:01:51 INFO - Running setup.py install for mozprocess 23:01:51 INFO - Running setup.py install for mozprofile 23:01:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:01:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:01:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:01:51 INFO - Running setup.py install for mozrunner 23:01:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:01:51 INFO - Running setup.py install for mozscreenshot 23:01:51 INFO - Running setup.py install for moztest 23:01:51 INFO - Running setup.py install for mozversion 23:01:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:01:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:01:51 INFO - Cleaning up... 23:01:51 INFO - Return code: 0 23:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:51 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:51 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 23:01:51 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 23:01:51 INFO - Using env: {'DISPLAY': ':0', 23:01:51 INFO - 'HOME': '/home/cltbld', 23:01:51 INFO - 'LANG': 'en_US.UTF-8', 23:01:51 INFO - 'LANGUAGE': 'en_US:en', 23:01:51 INFO - 'LOGNAME': 'cltbld', 23:01:51 INFO - 'MAIL': '/var/mail/cltbld', 23:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:51 INFO - 'MOZ_NO_REMOTE': '1', 23:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:51 INFO - 'NO_EM_RESTART': '1', 23:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:51 INFO - 'PWD': '/builds/slave/test', 23:01:51 INFO - 'SHELL': '/bin/bash', 23:01:51 INFO - 'SHLVL': '1', 23:01:51 INFO - 'TERM': 'linux', 23:01:51 INFO - 'TMOUT': '86400', 23:01:51 INFO - 'USER': 'cltbld', 23:01:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:51 INFO - '_': '/tools/buildbot/bin/python'} 23:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:51 INFO - Running setup.py (path:/tmp/pip-Ubgb2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:51 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)) 23:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:51 INFO - Running setup.py (path:/tmp/pip-riBbvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:52 INFO - Running setup.py (path:/tmp/pip-hKipwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:52 INFO - Running setup.py (path:/tmp/pip-8AeLIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:52 INFO - Running setup.py (path:/tmp/pip-kY7h6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:52 INFO - Running setup.py (path:/tmp/pip-jUdW_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:52 INFO - Running setup.py (path:/tmp/pip-6M93_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:52 INFO - Running setup.py (path:/tmp/pip-gq9sP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:52 INFO - Running setup.py (path:/tmp/pip-O0LGF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:52 INFO - Running setup.py (path:/tmp/pip-7KzJDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:52 INFO - Running setup.py (path:/tmp/pip-ifAv4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:52 INFO - Running setup.py (path:/tmp/pip-gWrQzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:52 INFO - Running setup.py (path:/tmp/pip-sqXMF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:52 INFO - Running setup.py (path:/tmp/pip-pGjo6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:52 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)) 23:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:52 INFO - Running setup.py (path:/tmp/pip-e937gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:53 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)) 23:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:53 INFO - Running setup.py (path:/tmp/pip-RbvWhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:53 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)) 23:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:53 INFO - Running setup.py (path:/tmp/pip-QkHndg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:53 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)) 23:01:53 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)) 23:01:53 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)) 23:01:53 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)) 23:01:53 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)) 23:01:53 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)) 23:01:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:01:53 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 23:01:53 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 23:01:53 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 23:01:53 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 23:01:53 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 23:01:53 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 23:01:55 INFO - Downloading blessings-1.6.tar.gz 23:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:01:55 INFO - Installing collected packages: blessings 23:01:55 INFO - Running setup.py install for blessings 23:01:55 INFO - Successfully installed blessings 23:01:55 INFO - Cleaning up... 23:01:55 INFO - Return code: 0 23:01:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:55 INFO - Reading from file tmpfile_stdout 23:01:55 INFO - Current package versions: 23:01:55 INFO - argparse == 1.2.1 23:01:55 INFO - blessings == 1.6 23:01:55 INFO - blobuploader == 1.2.4 23:01:55 INFO - docopt == 0.6.1 23:01:55 INFO - manifestparser == 1.1 23:01:55 INFO - mozInstall == 1.12 23:01:55 INFO - mozcrash == 0.17 23:01:55 INFO - mozdebug == 0.1 23:01:55 INFO - mozdevice == 0.48 23:01:55 INFO - mozfile == 1.2 23:01:55 INFO - mozhttpd == 0.7 23:01:55 INFO - mozinfo == 0.9 23:01:55 INFO - mozleak == 0.1 23:01:55 INFO - mozlog == 3.1 23:01:55 INFO - moznetwork == 0.27 23:01:55 INFO - mozprocess == 0.22 23:01:55 INFO - mozprofile == 0.28 23:01:55 INFO - mozrunner == 6.11 23:01:55 INFO - mozscreenshot == 0.1 23:01:55 INFO - mozsystemmonitor == 0.0 23:01:55 INFO - moztest == 0.7 23:01:55 INFO - mozversion == 1.4 23:01:55 INFO - psutil == 3.1.1 23:01:55 INFO - requests == 1.2.3 23:01:55 INFO - wsgiref == 0.1.2 23:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:55 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:55 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 23:01:55 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 23:01:55 INFO - Using env: {'DISPLAY': ':0', 23:01:55 INFO - 'HOME': '/home/cltbld', 23:01:55 INFO - 'LANG': 'en_US.UTF-8', 23:01:55 INFO - 'LANGUAGE': 'en_US:en', 23:01:55 INFO - 'LOGNAME': 'cltbld', 23:01:55 INFO - 'MAIL': '/var/mail/cltbld', 23:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:55 INFO - 'MOZ_NO_REMOTE': '1', 23:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:55 INFO - 'NO_EM_RESTART': '1', 23:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:55 INFO - 'PWD': '/builds/slave/test', 23:01:55 INFO - 'SHELL': '/bin/bash', 23:01:55 INFO - 'SHLVL': '1', 23:01:55 INFO - 'TERM': 'linux', 23:01:55 INFO - 'TMOUT': '86400', 23:01:55 INFO - 'USER': 'cltbld', 23:01:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:55 INFO - '_': '/tools/buildbot/bin/python'} 23:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 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)) 23:01:55 INFO - Cleaning up... 23:01:55 INFO - Return code: 0 23:01:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:01:55 INFO - Using env: {'DISPLAY': ':0', 23:01:55 INFO - 'HOME': '/home/cltbld', 23:01:55 INFO - 'LANG': 'en_US.UTF-8', 23:01:55 INFO - 'LANGUAGE': 'en_US:en', 23:01:55 INFO - 'LOGNAME': 'cltbld', 23:01:55 INFO - 'MAIL': '/var/mail/cltbld', 23:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:55 INFO - 'MOZ_NO_REMOTE': '1', 23:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:55 INFO - 'NO_EM_RESTART': '1', 23:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:55 INFO - 'PWD': '/builds/slave/test', 23:01:55 INFO - 'SHELL': '/bin/bash', 23:01:55 INFO - 'SHLVL': '1', 23:01:55 INFO - 'TERM': 'linux', 23:01:55 INFO - 'TMOUT': '86400', 23:01:55 INFO - 'USER': 'cltbld', 23:01:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:55 INFO - '_': '/tools/buildbot/bin/python'} 23:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:55 INFO - Downloading/unpacking jsonschema 23:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:01:57 INFO - Downloading/unpacking functools32 (from jsonschema) 23:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 23:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:01:58 INFO - warning: no files found matching '*.txt' 23:01:58 INFO - no previously-included directories found matching 'build' 23:01:58 INFO - no previously-included directories found matching 'dist' 23:01:58 INFO - no previously-included directories found matching '.git*' 23:01:58 INFO - Installing collected packages: jsonschema, functools32 23:01:58 INFO - Running setup.py install for functools32 23:01:58 INFO - warning: no files found matching '*.txt' 23:01:58 INFO - no previously-included directories found matching 'build' 23:01:58 INFO - no previously-included directories found matching 'dist' 23:01:58 INFO - no previously-included directories found matching '.git*' 23:01:58 INFO - Successfully installed jsonschema functools32 23:01:58 INFO - Cleaning up... 23:01:58 INFO - Return code: 0 23:01:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:01:58 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')]} 23:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:58 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')]} 23:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:58 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 0x7fc150cc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', '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 23:01:58 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 23:01:58 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 23:01:58 INFO - Using env: {'DISPLAY': ':0', 23:01:58 INFO - 'HOME': '/home/cltbld', 23:01:58 INFO - 'LANG': 'en_US.UTF-8', 23:01:58 INFO - 'LANGUAGE': 'en_US:en', 23:01:58 INFO - 'LOGNAME': 'cltbld', 23:01:58 INFO - 'MAIL': '/var/mail/cltbld', 23:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:58 INFO - 'MOZ_NO_REMOTE': '1', 23:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:58 INFO - 'NO_EM_RESTART': '1', 23:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:58 INFO - 'PWD': '/builds/slave/test', 23:01:58 INFO - 'SHELL': '/bin/bash', 23:01:58 INFO - 'SHLVL': '1', 23:01:58 INFO - 'TERM': 'linux', 23:01:58 INFO - 'TMOUT': '86400', 23:01:58 INFO - 'USER': 'cltbld', 23:01:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:58 INFO - '_': '/tools/buildbot/bin/python'} 23:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:58 INFO - Downloading/unpacking flake8 23:01:58 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 23:01:58 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 23:01:58 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 23:01:58 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 23:01:58 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 23:01:58 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 23:02:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:02:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:02:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:01 INFO - no previously-included directories found matching 'docs/_build' 23:02:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:02:01 INFO - Running setup.py install for pep8 23:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:01 INFO - no previously-included directories found matching 'docs/_build' 23:02:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:02:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:02:01 INFO - Cleaning up... 23:02:01 INFO - Return code: 0 23:02:01 INFO - Running post-action listener: _resource_record_post_action 23:02:01 INFO - Running post-action listener: _start_resource_monitoring 23:02:01 INFO - Starting resource monitoring. 23:02:01 INFO - ##### 23:02:01 INFO - ##### Running install step. 23:02:01 INFO - ##### 23:02:01 INFO - Running pre-action listener: _resource_record_pre_action 23:02:01 INFO - Running main action method: install 23:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:02:01 INFO - Reading from file tmpfile_stdout 23:02:01 INFO - Detecting whether we're running mozinstall >=1.0... 23:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:02:01 INFO - Reading from file tmpfile_stdout 23:02:01 INFO - Output received: 23:02:01 INFO - Usage: mozinstall [options] installer 23:02:01 INFO - Options: 23:02:01 INFO - -h, --help show this help message and exit 23:02:01 INFO - -d DEST, --destination=DEST 23:02:01 INFO - Directory to install application into. [default: 23:02:01 INFO - "/builds/slave/test"] 23:02:01 INFO - --app=APP Application being installed. [default: firefox] 23:02:01 INFO - mkdir: /builds/slave/test/build/application 23:02:01 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'] 23:02:01 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 23:02:15 INFO - Reading from file tmpfile_stdout 23:02:15 INFO - Output received: 23:02:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:02:15 INFO - Running post-action listener: _resource_record_post_action 23:02:15 INFO - ##### 23:02:15 INFO - ##### Running run-tests step. 23:02:15 INFO - ##### 23:02:15 INFO - Running pre-action listener: _resource_record_pre_action 23:02:15 INFO - Running main action method: run_tests 23:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:02:15 INFO - Python 2.7.3 23:02:15 INFO - Return code: 0 23:02:15 INFO - grabbing minidump binary from tooltool 23:02:15 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')]} 23:02:15 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 0x2508410>, '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 0x2509310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:02:15 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 23:02:15 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 23:02:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:02:15 INFO - Return code: 0 23:02:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:02:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:02:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:02:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:02:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:02:16 INFO - Return code: 0 23:02:16 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/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 23:02:16 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/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 23:02:16 INFO - Using env: {'DISPLAY': ':0', 23:02:16 INFO - 'HOME': '/home/cltbld', 23:02:16 INFO - 'LANG': 'en_US.UTF-8', 23:02:16 INFO - 'LANGUAGE': 'en_US:en', 23:02:16 INFO - 'LOGNAME': 'cltbld', 23:02:16 INFO - 'MAIL': '/var/mail/cltbld', 23:02:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:02:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:16 INFO - 'MOZ_NO_REMOTE': '1', 23:02:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:16 INFO - 'NO_EM_RESTART': '1', 23:02:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:16 INFO - 'PWD': '/builds/slave/test', 23:02:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:02:16 INFO - 'SHELL': '/bin/bash', 23:02:16 INFO - 'SHLVL': '1', 23:02:16 INFO - 'TERM': 'linux', 23:02:16 INFO - 'TMOUT': '86400', 23:02:16 INFO - 'USER': 'cltbld', 23:02:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243', 23:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:16 INFO - '_': '/tools/buildbot/bin/python'} 23:02:16 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/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 23:02:16 INFO - mozversion application_buildid: 20160713154642 23:02:16 INFO - mozversion application_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 23:02:16 INFO - mozversion application_display_name: Firefox 23:02:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:02:16 INFO - mozversion application_name: Firefox 23:02:16 INFO - mozversion application_remotingname: firefox 23:02:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:02:16 INFO - mozversion application_vendor: Mozilla 23:02:16 INFO - mozversion application_version: 48.0 23:02:16 INFO - mozversion platform_buildid: 20160713154642 23:02:16 INFO - mozversion platform_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 23:02:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:02:16 INFO - mozversion platform_version: 48.0 23:02:16 INFO - using testdate: 1468476136 23:02:16 INFO - actual date: 1468476136 23:02:16 INFO - starting webserver on 'localhost:45056' 23:02:16 INFO - SUITE-START | Running 2 tests 23:02:16 INFO - TEST-START | dromaeo_css 23:02:16 INFO - operating with platform_type : linux_ 23:02:16 INFO - Initialising browser for dromaeo_css test... 23:02:16 INFO - TEST-INFO | started process 19901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUGLFH/profile http://localhost:45056/getInfo.html) 23:02:20 INFO - PROCESS | 19901 | 23:02:20 INFO - PROCESS | 19901 | (process:19977): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:02:20 INFO - PROCESS | 19901 | __metrics Screen width/height:1600/1200 23:02:20 INFO - PROCESS | 19901 | colorDepth:24 23:02:20 INFO - PROCESS | 19901 | Browser inner width/height: 1024/697 23:02:20 INFO - PROCESS | 19901 | __metrics 23:02:21 ERROR - PROCESS | 19901 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:02:22 INFO - TEST-INFO | 19901: exit 0 23:02:22 INFO - Browser initialized. 23:02:22 INFO - Running cycle 1/1 for dromaeo_css test... 23:02:22 INFO - TEST-INFO | started process 20027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUGLFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:24 INFO - PROCESS | 20027 | 23:02:24 INFO - PROCESS | 20027 | (process:20096): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:02:34 INFO - PROCESS | 20027 | RSS: Main: 150425600 23:02:34 INFO - PROCESS | 20027 | 23:03:23 INFO - PROCESS | 20027 | 1468476203949 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] 23:05:31 INFO - PROCESS | 20027 | Cycle 1(1): loaded http://localhost:45056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45056/tests/dromaeo/cssquery-ext.html) 23:05:32 INFO - PROCESS | 20027 | RSS: Main: 154157056 23:05:32 INFO - PROCESS | 20027 | 23:08:34 INFO - PROCESS | 20027 | Cycle 1(1): loaded http://localhost:45056/tests/dromaeo/cssquery-ext.html (next: http://localhost:45056/tests/dromaeo/cssquery-jquery.html) 23:08:35 INFO - PROCESS | 20027 | RSS: Main: 151699456 23:08:35 INFO - PROCESS | 20027 | 23:11:36 INFO - PROCESS | 20027 | Cycle 1(1): loaded http://localhost:45056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45056/tests/dromaeo/cssquery-mootools.html) 23:11:37 INFO - PROCESS | 20027 | RSS: Main: 151949312 23:11:37 INFO - PROCESS | 20027 | 23:14:39 INFO - PROCESS | 20027 | Cycle 1(1): loaded http://localhost:45056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45056/tests/dromaeo/cssquery-prototype.html) 23:14:39 INFO - PROCESS | 20027 | RSS: Main: 153452544 23:14:39 INFO - PROCESS | 20027 | 23:17:41 INFO - PROCESS | 20027 | Cycle 1(1): loaded http://localhost:45056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45056/tests/dromaeo/cssquery-yui.html) 23:17:42 INFO - PROCESS | 20027 | RSS: Main: 152031232 23:17:42 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | Cycle 1(1): loaded http://localhost:45056/tests/dromaeo/cssquery-yui.html (next: http://localhost:45056/tests/dromaeo/cssquery-dojo.html) 23:20:44 INFO - PROCESS | 20027 | RSS: Main: 155926528 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | __start_tp_report 23:20:44 INFO - PROCESS | 20027 | _x_x_mozilla_page_load 23:20:44 INFO - PROCESS | 20027 | _x_x_mozilla_page_load_details 23:20:44 INFO - PROCESS | 20027 | |i|pagename|runs| 23:20:44 INFO - PROCESS | 20027 | |0;dojo.html;3289.703926646602;3374.4938259261116;3387.5934887813464;3414.829258537074;3428.434308339124;5545.306836645419;5548.056830338842;5576.191452239423;5592.049351610226;5620.803271885485;5561.555075593953;5592.049351610226;5599.160125981105;5604.775808967636;5611.523020543259;4997.050560393523;5076.340075790161;5094.949050509503;5116.155834287338;5117.974410127963;5012.248162775576;5042.218456139304;5071.543561079502;5133.076046311662;5161.17421212606;5050.974745126269;5089.338386009832;5126.615503837208;5135.12702840518;5143.4599367066485;5061.645684802065;5080.263361812554;5082.805540697933;5085.288059671649;5109.9489005109845;4815.6388270879825;4988;5000.449950505442;5025.824096156617;5055.191169412913;5342.545883599899;5385.838424847261;5412.783488660449;5419.647722897999;5477.945220547823;5860.589758716891;5872.853178670524;5881.411858814085;5882.176495290662;5888.087346461305;5827.038538641119;5932.970335148297;5944.613600115978;5959;5962.97018514909;5658.971705141489;5695;5697.829065128053;5705.144228365737;5726.942730572724;6149.692515374213;6151.6924153793025;6153.077038444179;6162.876742465126;6174.351693072163;5790.334111577223;5895.4399332063385;5921.348651648315;5955.940440595626;5972.820815375546;5979.19280897082;5988.730507127189;6006;6011.939880601226;6024.457798798129;5960.880782384328;5967.910481342697;5975.970120149372;6010.849728756816;6017.638941663514;5857.736401861926;5982.880342393128;5993.340732519419;6053.334133245427;6104.786332478342;4526.592606665416;4564.132814765184;4573.908521829611;4580.839670611513;4601.148787474328;4072.205919845661;4093.1813637272667;4098.959010409858;4104.794760262034;4132.855350062733;5572.247746554163;5862.179294898718;5877.941220587825;5891.440313170242;5938.317093534212;5933.169356290123;6000.069989151689;6008.66952317618;6009.819705408845;6036.456718895321;5601.831945041656;5785.27684039495;5808.651480911159;5819.79630712923;5836.182934389189;5111.591072714174;5159.613029022763;5174.120399532088;5184.559312458483;5211.921821172686;6181.505479561624;6223.315435302113;6231.096491008779;6243.219597550306;6286.277078136073;5877.647341159544;5997.340292567901;5998.280206375263;6007.669578173242;6008.789692360747;6307.526935479766;6334.398232167937;6361.01404282337;6361.363863613602;6368.872622547616;5927.436893495111;5938.524918006463;5948.643081415129;5975.282966044103;5983.491403230774;5821.155932389695;5857.619254748428;5942.910856337245;6020.4280593343565;6025.87948241024;5748.195252664546;5754.021816291157;5766.94233057664;5770.451807078321;5803.071508558611;5703.8859222816145;5752.741126649227;5754.4533269339345;5756.856078597901;5759.337676167294;5540;5597.356304024926;5790.826275211751;5861.531077513703;5869.178315035983;5851.473367396955;5869.148973398748;5902.704864756659;5910.940890591039;5919.704014799329;5786;5787;5792.623479473821;5795.536357091507;5802.564807639528 23:20:44 INFO - PROCESS | 20027 | |1;ext.html;645.396554221803;658.5686375424095;660.5046215338496;672.2840175213397;677.9220389655189;31477.68522314776;32195;40479.79760101195;40677.18645627093;41215.175696486054;43169.35245971305;43682.563174368246;43692.781536092356;44047.33928991068;44112;8784.429012114224;8894.955525222396;8945.329100317469;8950.462972221687;8959.865602015974;8836.248918841906;8869.733907982738;8893.110688931087;8938.374313798036;8957.19385255327;8807.295416366675;9085.13691199335;9128;9203.539823008823;9235.722928312161;9102.135297146793;9127.132922372364;9130.77173070672;9135.40619859707;9160.129787670161;9056.909430905673;9164.633414663405;9176;9190.402623829497;9207.033261507513;43965.560344396465;44722.77638611819;44770.55229447729;44772;44872;3570.535830342065;3697.9630203698157;3712.3132220539287;3823.923521529554;4365.847195348148;33722.31388430569;34236;34376.484352734726;34469.13827154316;34492.6550734492;4596.132194844927;4596.770161491912;4660.603848672833;4669.6731228814;4707.340972263886;332191.99999999756;332644;334366;336164;336311;67152.32847671559;67377;67554.32445675578;67906;68056.6597167021;70766.292337077;71039.2896071043;76802.2319776795;77480.22519774843;77982.61008695034;19510.512237194183;19970.400887973385;20051.197952082046;20065.097070631855;20119.698204526943;15109.168995705342;15147.469838555598;15193.6201594961;15210.163441010629;15248.23758812055;21230.2569410073;21380.358589242347;21422.78577214208;21423.46441338979;21436.24973125933;7281.2718728126765;7372.963135184397;7574.583397913168;7680.884786728204;7801.219878012267;1091.2197778588188;1150.4190383856267;1161.5876363890866;1207.3238986167773;1243.8134279858093;31996.245837722567;33217;33266.66733332635;33319.833400833326;34091.318173636886;1235.4008305971597;1238.102375777554;1283.140296001681;1293.7541867045231;1294.1264646363668;17183.570410739583;17186.656266874594;17550.29798808059;17700.796172800612;17756.3785267515;480306;570936;580935;591213;591317;60116.398836011955;60935;61123;61263.38736612666;61476.077858832155;1445.985540144585;1494.8056752622308;1514.3185566495122;1516.8862335324675;1544.6138465383654;31015;31635.52546711847;32020.35959280848;32022.67977320197;32517;56870;57466;57717.4228257712;57871.71064144652;57925.13112303235;441235;441806;443665;445469;446537;32302.515462268555;32640.34719305648;32667.509987350684;32677.34645307128;32699.34601308008;52244.216336754216;53393;53425;54364.45635543594;54577;43486.359154157944;43719;44383.33424998563;48545.5145448541;49267.753661231465;41788.582114179684;42102.36846447367;42274.36588451237;42948.1410371797;43514.564854351054;41369.37945930753;41605.58394416138;42419;42632;42986.785066074466;35678;36152.63847361493;36444.81777591095;36751;37381.439278410304;28601.102500599583;29055.709442906147;29090.418191636472;29244.7075529242;29291.560626591043 23:20:44 INFO - PROCESS | 20027 | |2;jquery.html;420.11146425310477;423.73940026883474;426.4349736599007;434.8173767017853;443.2509059689125;18707.251709931603;19382.80617193826;19521.219151233952;19763.1106600203;20591;18305.35931242407;18696.439106826816;19346.12942417591;19586.804131958677;19588;5340.839774806762;5462.562994960394;5469.507744303012;5494.862628434281;5503.724813759316;5386.434424385442;5399.1091469907415;5424.83725488236;5660.405657405975;5907.350191478934;5875.88248235035;5878.294604647427;5879.794207202727;5881.5294776417995;5901.822945311647;5482.616216864821;5498.340199176125;5704.34400043994;5868.119782032708;5972.343042265347;5360.705161216131;5363.570914326844;5369.19462080691;5374.892502149935;5375.865603359908;14587.927060364631;17248.39630612935;23613.937372818265;24272.39319017021;24980;2371.632396978471;2419.3346829621996;2504.5241404133158;2571.331453822001;2941.4411261860178;10965.451727413598;11003.944980275128;11019.338839669645;11173.050290725298;14376.92811535946;2032.319173077006;2054.578811343671;2059.989700051505;2106.568153528523;2110.7889211078923;81521;83292.16707832905;85444.57277713635;86768.99999999937;87751.56124219338;11338.60314888975;11612.825807612893;11634.883651163549;11638.185327027028;11930.821037684442;16824.74762878533;16882.662346752997;16902.492925212264;16944;16959.321627134777;7698.461107722405;8757.430767000125;8920.8661870072;8968.551572421353;9100.317476189311;8728.650853965897;8796.07641197665;8830.55847207637;8950.552472376356;8973.50645714479;4931.284963680247;4978.6763860348965;4993.325901003391;5075.213341932006;5077.517635824591;2050.4771283322657;2068.307117115753;2077.9272725454534;2089.258313298757;2090.571432856261;1022.9106002107732;1048.124815778818;1052.7736536644659;1086.8206745886998;1124.005255349022;18647.04415066101;18872.716909246374;18888;19078.80921190798;19620.8037919619;1085.137315833914;1100.9174311926477;1101.7686285879895;1109.3842917181041;1112.554978008803;10730.678079657622;10887.23789334739;10903.509342079626;10924.617638382619;11068.5572577096;447798;453457;454920;487943;509957;87751.56124219338;91421;93559;93875;94760;1008.626808081;1127.3067063755732;1181.2440038375446;1181.787278289916;1188.9346085965183;17124.657506850042;17282.74075888888;17646.647067058842;17951.281948721906;18481.445556633324;31271.687283126877;33621.66378336185;39666.80166599149;40385.39421908615;41393.1721365577;57061.42938570561;61465.078023830574;61586;61586.69206653938;61873;9065.365424420228;9127.954360228156;9150.359474836698;9255.120763527455;9275.72172834816;10093.798124037332;13239.867601323864;13336.933315333361;13604.795928060888;14056.929715351358;7660.96576962103;10672.359658420519;11553.24903881245;12162.878371216528;12188.634340969431;11823.231489953125;11854.585089521825;11982;12099.697507562381;12362.072844536517;11932.164748467523;12281.69295767613;12326.50693972231;12442.564510242099;12471.563495277622;8903.510306933182;8974.685885993958;9030.729078127666;9081.273498120267;9124.635014599608;9721.611135554782;11442.885571144516;12301.200421972542;12303.200291980993;12322.75354492923 23:20:44 INFO - PROCESS | 20027 | |3;mootools.html;1563.3199558192186;1595.5771720494067;1793.9910300448496;1907.5707965707727;1930.7876133625298;7609.467337286392;8351;8370.414071015031;8568.057513673499;8601.354898382631;8601.483910965331;8668.696595619154;8691.695790647329;8710.564471776417;8734.65061397545;2381.92854214373;2400;2400.843945143569;2401.267613377919;2403.0147639467823;2373.371056669984;2377.2036367816804;2436.5248776488593;2447.1434997750735;2448.816338774599;2393.545226406986;2423.9030438782515;2428.9514209715794;2433.598456254716;2447.021191523396;2373.715154181509;2396.760323967589;2410.3853517353136;2415.8671273079885;2424.490856920049;2368.846025008369;2373.7863592276603;2374.6794182785275;2377.548265829487;2381.821363397752;8677.956610216908;8723.996740374874;8729.432586881832;8740.912590874137;8742.781430464225;5289.074411977888;5362.597805164589;5414.91877621836;5458.426865179139;5466.398696143421;3427.3145370925913;3442.7590068695204;3463.1515278756615;3505.7545971781988;3523.735719821024;1211.9091068169923;1215.1190386969465;1216.2702378572874;1227.3801730126318;1259.641002314336;12160.966317862993;12183.147179697426;12229.755404891941;12231.204971676812;12258.938705306506;4596.4254468191475;4614.054118905617;4637.982477622178;4671.95328046722;4677.766111694402;10449.582016719398;10485;10489.790204195873;10497.212709046851;10512.21158413122;5360.490753378423;5369.24830523727;5375.16684913839;5385.246065550826;5411.350637923474;4309;4850.878728031827;4909.656324057281;4922.4093108826455;4951.8266860659705;4234.957650423518;4320.481542214954;4332.93843008465;4334.826606935687;4344.326629372453;1348.8516263211038;1363.236587510997;1367.9794803077962;1370.8971827113007;1390.478570536049;984.9015098490094;988.3180605382263;990.3265779270165;994.0407506756015;1002.1531805624236;5518.862028449241;5618.522425593788;5647;5692.658440493501;5701.2018317435595;480.9711417314902;489.1073790332657;489.48992358574196;494.60431654676836;522.7516929458477;3817.8854634361014;3819.357676199261;3849.2109117630816;3889.5138107736534;3933.1150491139265;10301.845472317771;10370.844437333295;10619.88491208412;10702.411367374714;10709.571617135383;10522.684319470429;10531.94734026325;10592.947035264928;10603.734906627396;10647.201459890539;8141.063777665644;8180.304674102649;8187.877181842277;8240.093589705128;8389.580520973926;5516.172574113915;5541.667499950016;5622.128570071645;5696.857578560569;5713.857153571028;9313;9393.201577865959;9522.333436659368;9581;9619.51902404891;9218;9595.328327017041;9596.23230141601;9598.66404675833;9604.95197524036;7069.752558660422;7234.457415693739;7246.565206087652;7434.033575635132;7531;7947.165547617417;7955.363570914197;7966.721164759206;7997.680092796223;8038.39712021589;7086.681099350439;7260.963695181702;7322.707091716272;7382.3724983377015;7468.954346391401;7191.712331506681;7247.13034435871;7253.673584688596;7280.96359518199;7344.48588598793;6617.7683781067435;6793.116894803644;6807.795766127024;6811.557248778813;6844.589324640538;4590.42619672541;4751.976240118777;4780.737059461763;4822.831200907952;4835.443923948791;4978.1288274552535;4992.650514463952;5009.77456014473;5020.748962551931;5067.341245638044 23:20:44 INFO - PROCESS | 20027 | |4;prototype.html;339.53992340378784;344.25984134111656;346.53045123857163;353.90621485306417;355.51649756331403;6373.61758294502;6453.8709225815455;6542.313057129004;6552.213734351884;6561.639109848957;6489.870202595946;6490.221173459192;6497.382748638884;6499.967500162505;6506.869862602745;4680.836170734025;4785.880352991168;4791.688540244891;4793.233082706767;4800.3279540864305;4762.095201911626;4799.5680388765;4818.951810481885;4845;4845.781939812717;4805;4807.855764327076;4809.495003024685;4810.927836082462;4812.518748125194;4811.374521312207;4814.446338671062;4816.759162041884;4818.421789385261;4820.6143508519235;4165.708400411972;4167.333226683746;4172.144710334374;4175.770332631704;4180.832766689329;6003.339632640406;6235.501159907197;6246.375362463763;6250.593711408744;6255.437010669016;5649.0114230009995;5671.376148623648;5676.233708449347;5678.6024978251535;5688.97155514224;6939.4448444124855;6943.305669433067;6948.33990770876;6955.791326260221;6959.512834101615;4657.836975705868;4662.090892276007;4664.183767840615;4669.6731228814;4685.5314468553215;7166.641667916583;7221.602811845346;7232.312930271669;7239.20368759436;7242;4667.883302917387;4745.3593764842;4753.5959443447;4767.76161191939;4769.833055843029;4796.064767370399;4817.8313759018265;4826.638002149853;4833.951660483421;4845.878853028703;5621.325440947113;5637.633553818989;5637.633553819071;5646.887062258732;5648.124540696116;6912.101426814583;6916.066331045345;6929.722811087601;6930.48021398387;6952.791416257521;1686.342326492669;1703.9659206815795;1706.7866516685415;1708.5045336852174;1708.7864016997876;1051.6476980211714;1085.46812062089;1086.5165001574383;1091.5906535049357;1095.381109673048;6796.422304104108;6827.180738311435;6827.590344579341;6830.419414349836;6834.350736680008;7155.356017958408;7160.427165826722;7191.676374563157;7200.1359836818865;7211.350978411968;6645.368689974444;6844.384005439534;6858.177018757781;6863.862722745517;6868.896966545506;3870.651641352292;3915.6280153385383;3918.5689574146822;3922.156736301709;3934.488516492838;7562.281583249583;7613.314801667766;7616.695332186761;7616.961915190389;7633.427492938052;7288.635568221674;7417.925820741832;7428.071491063617;7430.368418684472;7440.55356678601;7636.31273185416;7636.427267954926;7641.503302285334;7650.540967541965;7657.23427657241;7227.963860180876;7242.782716518513;7248.963755181401;7250.673719682733;7257.455690823315;7120.786376408716;7147.499675022698;7149.678264478007;7153.535020223669;7156.928430715626;7483.251674832473;7595.708729516106;7615.428842836699;7615.923840761743;7651;4755.5006724294835;4762.190427627381;4791.425028996543;4795.904081918272;4798.712077275374;7207.6756545956605;7210.603416811916;7215.170255420694;7218.3503484686635;7219.241979592067;6952.895706564304;6996.580205187705;7005.159380874327;7007.439404847498;7008.824779380557;6825.419839313714;6971.5468494547695;6982.930170698228;7006.194287656985;7007.894881576883;6838.14523184602;6854;6866.690998904961;6875.690593923186;6876.518643694893;6984.650767461708;7024.1571011478945;7027.051348067946;7027.121609798775;7050.330218629222;6862.656867156722;6865.897011544731;6868.862622747417;6870.20992585859;6881.724731010703 23:20:44 INFO - PROCESS | 20027 | |5;yui.html;846.8814365988761;849.3205435651478;851.4167795060384;861.1603686405755;895.5477483870644;14788.852111478882;15155.772663410058;15161.469348572802;16617.169141542934;16752.413665521708;14996.400143994228;15058;15079.62300942477;15210.315535800888;15234.54296371108;874.3092956564323;887.1837909123622;889.5863423508067;910.913463220993;927.4018258223442;916.7753900294438;917.7063339731288;920.9861852072224;922.916937475627;923.0953665407905;931.5342328835583;942.4722155592856;942.8632848237002;946.1437399153776;949.9335046546745;939.2908354192575;942.4062840410566;944.0182210501139;944.5560586524323;945.3288165402572;683.641088428574;685.8833998220315;687.9346462086144;692.6398272898115;693.2824526614979;15401.229938503142;15429.151396673178;15474.226288685633;15497.457588984444;15560.37758489659;13786.034977551575;13797.51708690191;13812.37844297009;13879.097858639156;13888.583342499742;10830.67507974762;10934;11174.608888688857;11279.718007049889;11359.318440893572;3855.61443855615;3895.590962948906;3904.6681032112306;3923.195744872294;4021.4369988201674;57077;57099.42900571024;57411.71294143503;59006;59146;10141;10141.29010969225;10294.691159265234;10467.42429166388;10619.30974486656;20276.18895244174;20310.390688279374;20380.694289585666;20393.286234981704;20466.18135274602;8457.746267611858;8565.828683426296;8619.784505387415;8663.35024873137;8748.78128046804;4849.199882019428;4850.345203397566;4891.6575839691595;4906.31311616374;4939.654224204343;3519.9472007919903;3595.2449985502813;3596.892093237207;3602.963970360263;3612.0247533166425;620.534599050712;640.218932901859;647.0456077285966;651.3063587279532;659.0147729144863;649.376598465469;654.6203202142746;676.6278546799339;683.0812557110678;683.805115542078;8887.422317549339;9193.264538836876;9240.260779137652;9277.721668349961;9349.953250233706;740;746.5708106613438;749.7600767754375;752.8720117580025;767.6430459836203;4277.486701595828;4418.138462999685;4460.30865215892;4461.375407442961;4528.796204170821;65209.347906521274;68171.31828681749;68727.65636171788;68816.31183688199;68834.65582672154;57248.42751572514;57505.712471438215;57607.423925761046;57912.42087579155;58470;50014.24978625396;50726;50754.49245507571;50934.74532627313;52218.69453263699;9353.158215760343;9562.760930976781;9633.518324083909;9779.657711980046;9870.851937220803;37344.81327593345;37588.06029849166;38238.6176138235;38399.232015360096;39969.2006159881;46657.533424666675;46965.76517117392;48344.7582762098;48635.75682121567;51549.48450515447;12430.689232769253;12449.688757780765;12700.494901914268;12777.808332874829;12830;14019.369128389451;14380.28098595045;14398.640033999234;14430.278486075864;14436.494722684656;12514.624561263177;13001.544945926848;13131.60605181846;13271.137376070525;13442.193468391928;12610.117291789853;12867.420966056363;13191.40638671243;13315.66710832237;13614.795778063535;12774.74450510966;12857.357132143168;13150.882175015231;13240.337983100613;13249.205047697169;10685.358878467317;10689.679309620724;10702;10918.50866710984;11234;10957.232993690364;11003.834942476029;11056.447177641247;11325.32048077118;11477 23:20:44 INFO - PROCESS | 20027 | __end_tp_report 23:20:44 INFO - PROCESS | 20027 | __start_cc_report 23:20:44 INFO - PROCESS | 20027 | _x_x_mozilla_cycle_collect,315 23:20:44 INFO - PROCESS | 20027 | __end_cc_report 23:20:44 INFO - PROCESS | 20027 | __startTimestamp1468477244961__endTimestamp 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | ------- Summary: start ------- 23:20:44 INFO - PROCESS | 20027 | Number of tests: 6 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | [#0] dojo.html Cycles:165 Average:5565.25 Median:5790.83 stddev:624.38 (10.8%) stddev-sans-first:600.23 23:20:44 INFO - PROCESS | 20027 | Values: 3289.7 3374.5 3387.6 3414.8 3428.4 5545.3 5548.1 5576.2 5592.0 5620.8 5561.6 5592.0 5599.2 5604.8 5611.5 4997.1 5076.3 5094.9 5116.2 5118.0 5012.2 5042.2 5071.5 5133.1 5161.2 5051.0 5089.3 5126.6 5135.1 5143.5 5061.6 5080.3 5082.8 5085.3 5109.9 4815.6 4988.0 5000.4 5025.8 5055.2 5342.5 5385.8 5412.8 5419.6 5477.9 5860.6 5872.9 5881.4 5882.2 5888.1 5827.0 5933.0 5944.6 5959.0 5963.0 5659.0 5695.0 5697.8 5705.1 5726.9 6149.7 6151.7 6153.1 6162.9 6174.4 5790.3 5895.4 5921.3 5955.9 5972.8 5979.2 5988.7 6006.0 6011.9 6024.5 5960.9 5967.9 5976.0 6010.8 6017.6 5857.7 5982.9 5993.3 6053.3 6104.8 4526.6 4564.1 4573.9 4580.8 4601.1 4072.2 4093.2 4099.0 4104.8 4132.9 5572.2 5862.2 5877.9 5891.4 5938.3 5933.2 6000.1 6008.7 6009.8 6036.5 5601.8 5785.3 5808.7 5819.8 5836.2 5111.6 5159.6 5174.1 5184.6 5211.9 6181.5 6223.3 6231.1 6243.2 6286.3 5877.6 5997.3 5998.3 6007.7 6008.8 6307.5 6334.4 6361.0 6361.4 6368.9 5927.4 5938.5 5948.6 5975.3 5983.5 5821.2 5857.6 5942.9 6020.4 6025.9 5748.2 5754.0 5766.9 5770.5 5803.1 5703.9 5752.7 5754.5 5756.9 5759.3 5540.0 5597.4 5790.8 5861.5 5869.2 5851.5 5869.1 5902.7 5910.9 5919.7 5786.0 5787.0 5792.6 5795.5 5802.6 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | [#1] ext.html Cycles:180 Average:62471.84 Median:23940.21 stddev:121257.94 (506.5%) stddev-sans-first:121509.25 23:20:44 INFO - PROCESS | 20027 | Values: 645.4 658.6 660.5 672.3 677.9 31477.7 32195.0 40479.8 40677.2 41215.2 43169.4 43682.6 43692.8 44047.3 44112.0 8784.4 8895.0 8945.3 8950.5 8959.9 8836.2 8869.7 8893.1 8938.4 8957.2 8807.3 9085.1 9128.0 9203.5 9235.7 9102.1 9127.1 9130.8 9135.4 9160.1 9056.9 9164.6 9176.0 9190.4 9207.0 43965.6 44722.8 44770.6 44772.0 44872.0 3570.5 3698.0 3712.3 3823.9 4365.8 33722.3 34236.0 34376.5 34469.1 34492.7 4596.1 4596.8 4660.6 4669.7 4707.3 332192.0 332644.0 334366.0 336164.0 336311.0 67152.3 67377.0 67554.3 67906.0 68056.7 70766.3 71039.3 76802.2 77480.2 77982.6 19510.5 19970.4 20051.2 20065.1 20119.7 15109.2 15147.5 15193.6 15210.2 15248.2 21230.3 21380.4 21422.8 21423.5 21436.2 7281.3 7373.0 7574.6 7680.9 7801.2 1091.2 1150.4 1161.6 1207.3 1243.8 31996.2 33217.0 33266.7 33319.8 34091.3 1235.4 1238.1 1283.1 1293.8 1294.1 17183.6 17186.7 17550.3 17700.8 17756.4 480306.0 570936.0 580935.0 591213.0 591317.0 60116.4 60935.0 61123.0 61263.4 61476.1 1446.0 1494.8 1514.3 1516.9 1544.6 31015.0 31635.5 32020.4 32022.7 32517.0 56870.0 57466.0 57717.4 57871.7 57925.1 441235.0 441806.0 443665.0 445469.0 446537.0 32302.5 32640.3 32667.5 32677.3 32699.3 52244.2 53393.0 53425.0 54364.5 54577.0 43486.4 43719.0 44383.3 48545.5 49267.8 41788.6 42102.4 42274.4 42948.1 43514.6 41369.4 41605.6 42419.0 42632.0 42986.8 35678.0 36152.6 36444.8 36751.0 37381.4 28601.1 29055.7 29090.4 29244.7 29291.6 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | [#2] jquery.html Cycles:180 Average:28676.18 Median:12992.78 stddev:77906.15 (599.6%) stddev-sans-first:78095.81 23:20:44 INFO - PROCESS | 20027 | Values: 420.1 423.7 426.4 434.8 443.3 18707.3 19382.8 19521.2 19763.1 20591.0 18305.4 18696.4 19346.1 19586.8 19588.0 5340.8 5462.6 5469.5 5494.9 5503.7 5386.4 5399.1 5424.8 5660.4 5907.4 5875.9 5878.3 5879.8 5881.5 5901.8 5482.6 5498.3 5704.3 5868.1 5972.3 5360.7 5363.6 5369.2 5374.9 5375.9 14587.9 17248.4 23613.9 24272.4 24980.0 2371.6 2419.3 2504.5 2571.3 2941.4 10965.5 11003.9 11019.3 11173.1 14376.9 2032.3 2054.6 2060.0 2106.6 2110.8 81521.0 83292.2 85444.6 86769.0 87751.6 11338.6 11612.8 11634.9 11638.2 11930.8 16824.7 16882.7 16902.5 16944.0 16959.3 7698.5 8757.4 8920.9 8968.6 9100.3 8728.7 8796.1 8830.6 8950.6 8973.5 4931.3 4978.7 4993.3 5075.2 5077.5 2050.5 2068.3 2077.9 2089.3 2090.6 1022.9 1048.1 1052.8 1086.8 1124.0 18647.0 18872.7 18888.0 19078.8 19620.8 1085.1 1100.9 1101.8 1109.4 1112.6 10730.7 10887.2 10903.5 10924.6 11068.6 447798.0 453457.0 454920.0 487943.0 509957.0 87751.6 91421.0 93559.0 93875.0 94760.0 1008.6 1127.3 1181.2 1181.8 1188.9 17124.7 17282.7 17646.6 17951.3 18481.4 31271.7 33621.7 39666.8 40385.4 41393.2 57061.4 61465.1 61586.0 61586.7 61873.0 9065.4 9128.0 9150.4 9255.1 9275.7 10093.8 13239.9 13336.9 13604.8 14056.9 7661.0 10672.4 11553.2 12162.9 12188.6 11823.2 11854.6 11982.0 12099.7 12362.1 11932.2 12281.7 12326.5 12442.6 12471.6 8903.5 8974.7 9030.7 9081.3 9124.6 9721.6 11442.9 12301.2 12303.2 12322.8 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | [#3] mootools.html Cycles:180 Average:5670.16 Median:2699.57 stddev:3165.24 (117.2%) stddev-sans-first:3159.07 23:20:44 INFO - PROCESS | 20027 | Values: 1563.3 1595.6 1794.0 1907.6 1930.8 7609.5 8351.0 8370.4 8568.1 8601.4 8601.5 8668.7 8691.7 8710.6 8734.7 2381.9 2400.0 2400.8 2401.3 2403.0 2373.4 2377.2 2436.5 2447.1 2448.8 2393.5 2423.9 2429.0 2433.6 2447.0 2373.7 2396.8 2410.4 2415.9 2424.5 2368.8 2373.8 2374.7 2377.5 2381.8 8678.0 8724.0 8729.4 8740.9 8742.8 5289.1 5362.6 5414.9 5458.4 5466.4 3427.3 3442.8 3463.2 3505.8 3523.7 1211.9 1215.1 1216.3 1227.4 1259.6 12161.0 12183.1 12229.8 12231.2 12258.9 4596.4 4614.1 4638.0 4672.0 4677.8 10449.6 10485.0 10489.8 10497.2 10512.2 5360.5 5369.2 5375.2 5385.2 5411.4 4309.0 4850.9 4909.7 4922.4 4951.8 4235.0 4320.5 4332.9 4334.8 4344.3 1348.9 1363.2 1368.0 1370.9 1390.5 984.9 988.3 990.3 994.0 1002.2 5518.9 5618.5 5647.0 5692.7 5701.2 481.0 489.1 489.5 494.6 522.8 3817.9 3819.4 3849.2 3889.5 3933.1 10301.8 10370.8 10619.9 10702.4 10709.6 10522.7 10531.9 10592.9 10603.7 10647.2 8141.1 8180.3 8187.9 8240.1 8389.6 5516.2 5541.7 5622.1 5696.9 5713.9 9313.0 9393.2 9522.3 9581.0 9619.5 9218.0 9595.3 9596.2 9598.7 9605.0 7069.8 7234.5 7246.6 7434.0 7531.0 7947.2 7955.4 7966.7 7997.7 8038.4 7086.7 7261.0 7322.7 7382.4 7469.0 7191.7 7247.1 7253.7 7281.0 7344.5 6617.8 6793.1 6807.8 6811.6 6844.6 4590.4 4752.0 4780.7 4822.8 4835.4 4978.1 4992.7 5009.8 5020.7 5067.3 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | [#4] prototype.html Cycles:180 Average:5789.58 Median:6720.90 stddev:1815.98 (27.0%) stddev-sans-first:1774.40 23:20:44 INFO - PROCESS | 20027 | Values: 339.5 344.3 346.5 353.9 355.5 6373.6 6453.9 6542.3 6552.2 6561.6 6489.9 6490.2 6497.4 6500.0 6506.9 4680.8 4785.9 4791.7 4793.2 4800.3 4762.1 4799.6 4819.0 4845.0 4845.8 4805.0 4807.9 4809.5 4810.9 4812.5 4811.4 4814.4 4816.8 4818.4 4820.6 4165.7 4167.3 4172.1 4175.8 4180.8 6003.3 6235.5 6246.4 6250.6 6255.4 5649.0 5671.4 5676.2 5678.6 5689.0 6939.4 6943.3 6948.3 6955.8 6959.5 4657.8 4662.1 4664.2 4669.7 4685.5 7166.6 7221.6 7232.3 7239.2 7242.0 4667.9 4745.4 4753.6 4767.8 4769.8 4796.1 4817.8 4826.6 4834.0 4845.9 5621.3 5637.6 5637.6 5646.9 5648.1 6912.1 6916.1 6929.7 6930.5 6952.8 1686.3 1704.0 1706.8 1708.5 1708.8 1051.6 1085.5 1086.5 1091.6 1095.4 6796.4 6827.2 6827.6 6830.4 6834.4 7155.4 7160.4 7191.7 7200.1 7211.4 6645.4 6844.4 6858.2 6863.9 6868.9 3870.7 3915.6 3918.6 3922.2 3934.5 7562.3 7613.3 7616.7 7617.0 7633.4 7288.6 7417.9 7428.1 7430.4 7440.6 7636.3 7636.4 7641.5 7650.5 7657.2 7228.0 7242.8 7249.0 7250.7 7257.5 7120.8 7147.5 7149.7 7153.5 7156.9 7483.3 7595.7 7615.4 7615.9 7651.0 4755.5 4762.2 4791.4 4795.9 4798.7 7207.7 7210.6 7215.2 7218.4 7219.2 6952.9 6996.6 7005.2 7007.4 7008.8 6825.4 6971.5 6982.9 7006.2 7007.9 6838.1 6854.0 6866.7 6875.7 6876.5 6984.7 7024.2 7027.1 7027.1 7050.3 6862.7 6865.9 6868.9 6870.2 6881.7 23:20:44 INFO - PROCESS | 20027 | 23:20:44 INFO - PROCESS | 20027 | [#5] yui.html Cycles:180 Average:15640.42 Median:46811.65 stddev:18247.38 (39.0%) stddev-sans-first:18264.75 23:20:44 INFO - PROCESS | 20027 | Values: 846.9 849.3 851.4 861.2 895.5 14788.9 15155.8 15161.5 16617.2 16752.4 14996.4 15058.0 15079.6 15210.3 15234.5 874.3 887.2 889.6 910.9 927.4 916.8 917.7 921.0 922.9 923.1 931.5 942.5 942.9 946.1 949.9 939.3 942.4 944.0 944.6 945.3 683.6 685.9 687.9 692.6 693.3 15401.2 15429.2 15474.2 15497.5 15560.4 13786.0 13797.5 13812.4 13879.1 13888.6 10830.7 10934.0 11174.6 11279.7 11359.3 3855.6 3895.6 3904.7 3923.2 4021.4 57077.0 57099.4 57411.7 59006.0 59146.0 10141.0 10141.3 10294.7 10467.4 10619.3 20276.2 20310.4 20380.7 20393.3 20466.2 8457.7 8565.8 8619.8 8663.4 8748.8 4849.2 4850.3 4891.7 4906.3 4939.7 3519.9 3595.2 3596.9 3603.0 3612.0 620.5 640.2 647.0 651.3 659.0 649.4 654.6 676.6 683.1 683.8 8887.4 9193.3 9240.3 9277.7 9350.0 740.0 746.6 749.8 752.9 767.6 4277.5 4418.1 4460.3 4461.4 4528.8 65209.3 68171.3 68727.7 68816.3 68834.7 57248.4 57505.7 57607.4 57912.4 58470.0 50014.2 50726.0 50754.5 50934.7 52218.7 9353.2 9562.8 9633.5 9779.7 9870.9 37344.8 37588.1 38238.6 38399.2 39969.2 46657.5 46965.8 48344.8 48635.8 51549.5 12430.7 12449.7 12700.5 12777.8 12830.0 14019.4 14380.3 14398.6 14430.3 14436.5 12514.6 13001.5 13131.6 13271.1 13442.2 12610.1 12867.4 13191.4 13315.7 13614.8 12774.7 12857.4 13150.9 13240.3 13249.2 10685.4 10689.7 10702.0 10918.5 11234.0 10957.2 11003.8 11056.4 11325.3 11477.0 23:20:44 INFO - PROCESS | 20027 | -------- Summary: end -------- 23:20:44 INFO - PROCESS | 20027 | 23:20:45 INFO - TEST-INFO | 20027: exit 0 23:20:45 INFO - TEST-OK | dromaeo_css | took 1109455ms 23:20:45 INFO - TEST-START | kraken 23:20:45 INFO - operating with platform_type : linux_ 23:20:45 INFO - Initialising browser for kraken test... 23:20:45 INFO - TEST-INFO | started process 20275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaxqpV8/profile http://localhost:45056/getInfo.html) 23:20:49 INFO - PROCESS | 20275 | 23:20:49 INFO - PROCESS | 20275 | (process:20355): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:20:50 INFO - PROCESS | 20275 | __metrics Screen width/height:1600/1200 23:20:50 INFO - PROCESS | 20275 | colorDepth:24 23:20:50 INFO - PROCESS | 20275 | Browser inner width/height: 1024/697 23:20:50 INFO - PROCESS | 20275 | __metrics 23:20:51 ERROR - PROCESS | 20275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:20:52 INFO - TEST-INFO | 20275: exit 0 23:20:52 INFO - Browser initialized. 23:20:52 INFO - Running cycle 1/1 for kraken test... 23:20:52 INFO - TEST-INFO | started process 20405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaxqpV8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:53 INFO - PROCESS | 20405 | 23:20:53 INFO - PROCESS | 20405 | (process:20474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:21:03 INFO - PROCESS | 20405 | RSS: Main: 150716416 23:21:03 INFO - PROCESS | 20405 | 23:21:06 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45056/tests/kraken/driver.html?testName=audio-beat-detection) 23:21:07 INFO - PROCESS | 20405 | RSS: Main: 156020736 23:21:07 INFO - PROCESS | 20405 | 23:21:09 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45056/tests/kraken/driver.html?testName=audio-dft) 23:21:10 INFO - PROCESS | 20405 | RSS: Main: 156348416 23:21:10 INFO - PROCESS | 20405 | 23:21:13 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45056/tests/kraken/driver.html?testName=audio-fft) 23:21:13 INFO - PROCESS | 20405 | RSS: Main: 156446720 23:21:13 INFO - PROCESS | 20405 | 23:21:15 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45056/tests/kraken/driver.html?testName=audio-oscillator) 23:21:16 INFO - PROCESS | 20405 | RSS: Main: 156053504 23:21:16 INFO - PROCESS | 20405 | 23:21:18 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:21:19 INFO - PROCESS | 20405 | RSS: Main: 156114944 23:21:19 INFO - PROCESS | 20405 | 23:21:22 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45056/tests/kraken/driver.html?testName=imaging-darkroom) 23:21:23 INFO - PROCESS | 20405 | RSS: Main: 156561408 23:21:23 INFO - PROCESS | 20405 | 23:21:26 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45056/tests/kraken/driver.html?testName=imaging-desaturate) 23:21:26 INFO - PROCESS | 20405 | RSS: Main: 156418048 23:21:26 INFO - PROCESS | 20405 | 23:21:29 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45056/tests/kraken/driver.html?testName=json-parse-financial) 23:21:30 INFO - PROCESS | 20405 | RSS: Main: 156069888 23:21:30 INFO - PROCESS | 20405 | 23:21:31 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:21:32 INFO - PROCESS | 20405 | RSS: Main: 155832320 23:21:32 INFO - PROCESS | 20405 | 23:21:34 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:21:34 INFO - PROCESS | 20405 | RSS: Main: 156254208 23:21:34 INFO - PROCESS | 20405 | 23:21:36 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:21:37 INFO - PROCESS | 20405 | RSS: Main: 156704768 23:21:37 INFO - PROCESS | 20405 | 23:21:39 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:21:40 INFO - PROCESS | 20405 | RSS: Main: 157020160 23:21:40 INFO - PROCESS | 20405 | 23:21:43 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:21:43 INFO - PROCESS | 20405 | RSS: Main: 156823552 23:21:43 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | Cycle 1(1): loaded http://localhost:45056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45056/tests/kraken/driver.html?testName=ai-astar) 23:21:45 INFO - PROCESS | 20405 | RSS: Main: 158486528 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | __start_tp_report 23:21:45 INFO - PROCESS | 20405 | _x_x_mozilla_page_load 23:21:45 INFO - PROCESS | 20405 | _x_x_mozilla_page_load_details 23:21:45 INFO - PROCESS | 20405 | |i|pagename|runs| 23:21:45 INFO - PROCESS | 20405 | |0;ai-astar;111;110;106;111;113;114;100;111;112;111 23:21:45 INFO - PROCESS | 20405 | |1;audio-beat-detection;154;133;152;172;135;155;149;133;179;135 23:21:45 INFO - PROCESS | 20405 | |2;audio-dft;162;162;163;164;166;162;162;167;161;161 23:21:45 INFO - PROCESS | 20405 | |3;audio-fft;76;77;77;169;73;77;76;79;161;73 23:21:45 INFO - PROCESS | 20405 | |4;audio-oscillator;94;92;147;92;92;93;154;92;92;150 23:21:45 INFO - PROCESS | 20405 | |5;imaging-gaussian-blur;118;117;117;118;117;118;117;117;118;117 23:21:45 INFO - PROCESS | 20405 | |6;imaging-darkroom;147;146;146;147;147;146;148;147;146;148 23:21:45 INFO - PROCESS | 20405 | |7;imaging-desaturate;95;96;94;96;96;95;96;95;96;95 23:21:45 INFO - PROCESS | 20405 | |8;json-parse-financial;57;57;63;59;57;58;57;74;57;54 23:21:45 INFO - PROCESS | 20405 | |9;json-stringify-tinderbox;60;61;60;61;60;62;60;61;62;60 23:21:45 INFO - PROCESS | 20405 | |10;stanford-crypto-aes;73;72;72;83;75;73;74;73;73;80 23:21:45 INFO - PROCESS | 20405 | |11;stanford-crypto-ccm;124;114;115;118;115;116;111;114;129;133 23:21:45 INFO - PROCESS | 20405 | |12;stanford-crypto-pbkdf2;167;161;164;162;161;167;166;167;165;159 23:21:45 INFO - PROCESS | 20405 | |13;stanford-crypto-sha256-iterative;69;68;71;69;67;66;71;71;68;66 23:21:45 INFO - PROCESS | 20405 | __end_tp_report 23:21:45 INFO - PROCESS | 20405 | __start_cc_report 23:21:45 INFO - PROCESS | 20405 | _x_x_mozilla_cycle_collect,810 23:21:45 INFO - PROCESS | 20405 | __end_cc_report 23:21:45 INFO - PROCESS | 20405 | __startTimestamp1468477305855__endTimestamp 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | ------- Summary: start ------- 23:21:45 INFO - PROCESS | 20405 | Number of tests: 14 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:4.07 (3.7%) stddev-sans-first:4.29 23:21:45 INFO - PROCESS | 20405 | Values: 111.0 110.0 106.0 111.0 113.0 114.0 100.0 111.0 112.0 111.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:153.00 stddev:16.32 (10.7%) stddev-sans-first:17.24 23:21:45 INFO - PROCESS | 20405 | Values: 154.0 133.0 152.0 172.0 135.0 155.0 149.0 133.0 179.0 135.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.05 (1.3%) stddev-sans-first:2.15 23:21:45 INFO - PROCESS | 20405 | Values: 162.0 162.0 163.0 164.0 166.0 162.0 162.0 167.0 161.0 161.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.50 stddev:37.62 (49.2%) stddev-sans-first:39.34 23:21:45 INFO - PROCESS | 20405 | Values: 76.0 77.0 77.0 169.0 73.0 77.0 76.0 79.0 161.0 73.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.03 (30.5%) stddev-sans-first:29.14 23:21:45 INFO - PROCESS | 20405 | Values: 94.0 92.0 147.0 92.0 92.0 93.0 154.0 92.0 92.0 150.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:21:45 INFO - PROCESS | 20405 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:21:45 INFO - PROCESS | 20405 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 148.0 147.0 146.0 148.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 23:21:45 INFO - PROCESS | 20405 | Values: 95.0 96.0 94.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.50 stddev:5.64 (9.8%) stddev-sans-first:5.92 23:21:45 INFO - PROCESS | 20405 | Values: 57.0 57.0 63.0 59.0 57.0 58.0 57.0 74.0 57.0 54.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 23:21:45 INFO - PROCESS | 20405 | Values: 60.0 61.0 60.0 61.0 60.0 62.0 60.0 61.0 62.0 60.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:73.50 stddev:3.71 (5.0%) stddev-sans-first:3.87 23:21:45 INFO - PROCESS | 20405 | Values: 73.0 72.0 72.0 83.0 75.0 73.0 74.0 73.0 73.0 80.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:117.00 stddev:7.28 (6.2%) stddev-sans-first:7.48 23:21:45 INFO - PROCESS | 20405 | Values: 124.0 114.0 115.0 118.0 115.0 116.0 111.0 114.0 129.0 133.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:165.50 stddev:2.96 (1.8%) stddev-sans-first:2.92 23:21:45 INFO - PROCESS | 20405 | Values: 167.0 161.0 164.0 162.0 161.0 167.0 166.0 167.0 165.0 159.0 23:21:45 INFO - PROCESS | 20405 | 23:21:45 INFO - PROCESS | 20405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.96 (2.8%) stddev-sans-first:2.07 23:21:45 INFO - PROCESS | 20405 | Values: 69.0 68.0 71.0 69.0 67.0 66.0 71.0 71.0 68.0 66.0 23:21:45 INFO - PROCESS | 20405 | -------- Summary: end -------- 23:21:45 INFO - PROCESS | 20405 | 23:21:46 INFO - TEST-INFO | 20405: exit 0 23:21:46 INFO - TEST-OK | kraken | took 61136ms 23:21:46 INFO - SUITE-END | took 1170s 23:21:47 INFO - Completed test suite (00:19:30) 23:21:47 INFO - javascript benchmark 23:21:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.703926646602, 3374.4938259261116, 3387.5934887813464, 3414.829258537074, 3428.434308339124, 5545.306836645419, 5548.056830338842, 5576.191452239423, 5592.049351610226, 5620.803271885485, 5561.555075593953, 5592.049351610226, 5599.160125981105, 5604.775808967636, 5611.523020543259, 4997.050560393523, 5076.340075790161, 5094.949050509503, 5116.155834287338, 5117.974410127963, 5012.248162775576, 5042.218456139304, 5071.543561079502, 5133.076046311662, 5161.17421212606, 5050.974745126269, 5089.338386009832, 5126.615503837208, 5135.12702840518, 5143.4599367066485, 5061.645684802065, 5080.263361812554, 5082.805540697933, 5085.288059671649, 5109.9489005109845, 4815.6388270879825, 4988.0, 5000.449950505442, 5025.824096156617, 5055.191169412913, 5342.545883599899, 5385.838424847261, 5412.783488660449, 5419.647722897999, 5477.945220547823, 5860.589758716891, 5872.853178670524, 5881.411858814085, 5882.176495290662, 5888.087346461305, 5827.038538641119, 5932.970335148297, 5944.613600115978, 5959.0, 5962.97018514909, 5658.971705141489, 5695.0, 5697.829065128053, 5705.144228365737, 5726.942730572724, 6149.692515374213, 6151.6924153793025, 6153.077038444179, 6162.876742465126, 6174.351693072163, 5790.334111577223, 5895.4399332063385, 5921.348651648315, 5955.940440595626, 5972.820815375546, 5979.19280897082, 5988.730507127189, 6006.0, 6011.939880601226, 6024.457798798129, 5960.880782384328, 5967.910481342697, 5975.970120149372, 6010.849728756816, 6017.638941663514, 5857.736401861926, 5982.880342393128, 5993.340732519419, 6053.334133245427, 6104.786332478342, 4526.592606665416, 4564.132814765184, 4573.908521829611, 4580.839670611513, 4601.148787474328, 4072.205919845661, 4093.1813637272667, 4098.959010409858, 4104.794760262034, 4132.855350062733, 5572.247746554163, 5862.179294898718, 5877.941220587825, 5891.440313170242, 5938.317093534212, 5933.169356290123, 6000.069989151689, 6008.66952317618, 6009.819705408845, 6036.456718895321, 5601.831945041656, 5785.27684039495, 5808.651480911159, 5819.79630712923, 5836.182934389189, 5111.591072714174, 5159.613029022763, 5174.120399532088, 5184.559312458483, 5211.921821172686, 6181.505479561624, 6223.315435302113, 6231.096491008779, 6243.219597550306, 6286.277078136073, 5877.647341159544, 5997.340292567901, 5998.280206375263, 6007.669578173242, 6008.789692360747, 6307.526935479766, 6334.398232167937, 6361.01404282337, 6361.363863613602, 6368.872622547616, 5927.436893495111, 5938.524918006463, 5948.643081415129, 5975.282966044103, 5983.491403230774, 5821.155932389695, 5857.619254748428, 5942.910856337245, 6020.4280593343565, 6025.87948241024, 5748.195252664546, 5754.021816291157, 5766.94233057664, 5770.451807078321, 5803.071508558611, 5703.8859222816145, 5752.741126649227, 5754.4533269339345, 5756.856078597901, 5759.337676167294, 5540.0, 5597.356304024926, 5790.826275211751, 5861.531077513703, 5869.178315035983, 5851.473367396955, 5869.148973398748, 5902.704864756659, 5910.940890591039, 5919.704014799329, 5786.0, 5787.0, 5792.623479473821, 5795.536357091507, 5802.564807639528], "value": 5524.578546219647, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.396554221803, 658.5686375424095, 660.5046215338496, 672.2840175213397, 677.9220389655189, 31477.68522314776, 32195.0, 40479.79760101195, 40677.18645627093, 41215.175696486054, 43169.35245971305, 43682.563174368246, 43692.781536092356, 44047.33928991068, 44112.0, 8784.429012114224, 8894.955525222396, 8945.329100317469, 8950.462972221687, 8959.865602015974, 8836.248918841906, 8869.733907982738, 8893.110688931087, 8938.374313798036, 8957.19385255327, 8807.295416366675, 9085.13691199335, 9128.0, 9203.539823008823, 9235.722928312161, 9102.135297146793, 9127.132922372364, 9130.77173070672, 9135.40619859707, 9160.129787670161, 9056.909430905673, 9164.633414663405, 9176.0, 9190.402623829497, 9207.033261507513, 43965.560344396465, 44722.77638611819, 44770.55229447729, 44772.0, 44872.0, 3570.535830342065, 3697.9630203698157, 3712.3132220539287, 3823.923521529554, 4365.847195348148, 33722.31388430569, 34236.0, 34376.484352734726, 34469.13827154316, 34492.6550734492, 4596.132194844927, 4596.770161491912, 4660.603848672833, 4669.6731228814, 4707.340972263886, 332191.99999999756, 332644.0, 334366.0, 336164.0, 336311.0, 67152.32847671559, 67377.0, 67554.32445675578, 67906.0, 68056.6597167021, 70766.292337077, 71039.2896071043, 76802.2319776795, 77480.22519774843, 77982.61008695034, 19510.512237194183, 19970.400887973385, 20051.197952082046, 20065.097070631855, 20119.698204526943, 15109.168995705342, 15147.469838555598, 15193.6201594961, 15210.163441010629, 15248.23758812055, 21230.2569410073, 21380.358589242347, 21422.78577214208, 21423.46441338979, 21436.24973125933, 7281.2718728126765, 7372.963135184397, 7574.583397913168, 7680.884786728204, 7801.219878012267, 1091.2197778588188, 1150.4190383856267, 1161.5876363890866, 1207.3238986167773, 1243.8134279858093, 31996.245837722567, 33217.0, 33266.66733332635, 33319.833400833326, 34091.318173636886, 1235.4008305971597, 1238.102375777554, 1283.140296001681, 1293.7541867045231, 1294.1264646363668, 17183.570410739583, 17186.656266874594, 17550.29798808059, 17700.796172800612, 17756.3785267515, 480306.0, 570936.0, 580935.0, 591213.0, 591317.0, 60116.398836011955, 60935.0, 61123.0, 61263.38736612666, 61476.077858832155, 1445.985540144585, 1494.8056752622308, 1514.3185566495122, 1516.8862335324675, 1544.6138465383654, 31015.0, 31635.52546711847, 32020.35959280848, 32022.67977320197, 32517.0, 56870.0, 57466.0, 57717.4228257712, 57871.71064144652, 57925.13112303235, 441235.0, 441806.0, 443665.0, 445469.0, 446537.0, 32302.515462268555, 32640.34719305648, 32667.509987350684, 32677.34645307128, 32699.34601308008, 52244.216336754216, 53393.0, 53425.0, 54364.45635543594, 54577.0, 43486.359154157944, 43719.0, 44383.33424998563, 48545.5145448541, 49267.753661231465, 41788.582114179684, 42102.36846447367, 42274.36588451237, 42948.1410371797, 43514.564854351054, 41369.37945930753, 41605.58394416138, 42419.0, 42632.0, 42986.785066074466, 35678.0, 36152.63847361493, 36444.81777591095, 36751.0, 37381.439278410304, 28601.102500599583, 29055.709442906147, 29090.418191636472, 29244.7075529242, 29291.560626591043], "value": 21418.232240211546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.11146425310477, 423.73940026883474, 426.4349736599007, 434.8173767017853, 443.2509059689125, 18707.251709931603, 19382.80617193826, 19521.219151233952, 19763.1106600203, 20591.0, 18305.35931242407, 18696.439106826816, 19346.12942417591, 19586.804131958677, 19588.0, 5340.839774806762, 5462.562994960394, 5469.507744303012, 5494.862628434281, 5503.724813759316, 5386.434424385442, 5399.1091469907415, 5424.83725488236, 5660.405657405975, 5907.350191478934, 5875.88248235035, 5878.294604647427, 5879.794207202727, 5881.5294776417995, 5901.822945311647, 5482.616216864821, 5498.340199176125, 5704.34400043994, 5868.119782032708, 5972.343042265347, 5360.705161216131, 5363.570914326844, 5369.19462080691, 5374.892502149935, 5375.865603359908, 14587.927060364631, 17248.39630612935, 23613.937372818265, 24272.39319017021, 24980.0, 2371.632396978471, 2419.3346829621996, 2504.5241404133158, 2571.331453822001, 2941.4411261860178, 10965.451727413598, 11003.944980275128, 11019.338839669645, 11173.050290725298, 14376.92811535946, 2032.319173077006, 2054.578811343671, 2059.989700051505, 2106.568153528523, 2110.7889211078923, 81521.0, 83292.16707832905, 85444.57277713635, 86768.99999999937, 87751.56124219338, 11338.60314888975, 11612.825807612893, 11634.883651163549, 11638.185327027028, 11930.821037684442, 16824.74762878533, 16882.662346752997, 16902.492925212264, 16944.0, 16959.321627134777, 7698.461107722405, 8757.430767000125, 8920.8661870072, 8968.551572421353, 9100.317476189311, 8728.650853965897, 8796.07641197665, 8830.55847207637, 8950.552472376356, 8973.50645714479, 4931.284963680247, 4978.6763860348965, 4993.325901003391, 5075.213341932006, 5077.517635824591, 2050.4771283322657, 2068.307117115753, 2077.9272725454534, 2089.258313298757, 2090.571432856261, 1022.9106002107732, 1048.124815778818, 1052.7736536644659, 1086.8206745886998, 1124.005255349022, 18647.04415066101, 18872.716909246374, 18888.0, 19078.80921190798, 19620.8037919619, 1085.137315833914, 1100.9174311926477, 1101.7686285879895, 1109.3842917181041, 1112.554978008803, 10730.678079657622, 10887.23789334739, 10903.509342079626, 10924.617638382619, 11068.5572577096, 447798.0, 453457.0, 454920.0, 487943.0, 509957.0, 87751.56124219338, 91421.0, 93559.0, 93875.0, 94760.0, 1008.626808081, 1127.3067063755732, 1181.2440038375446, 1181.787278289916, 1188.9346085965183, 17124.657506850042, 17282.74075888888, 17646.647067058842, 17951.281948721906, 18481.445556633324, 31271.687283126877, 33621.66378336185, 39666.80166599149, 40385.39421908615, 41393.1721365577, 57061.42938570561, 61465.078023830574, 61586.0, 61586.69206653938, 61873.0, 9065.365424420228, 9127.954360228156, 9150.359474836698, 9255.120763527455, 9275.72172834816, 10093.798124037332, 13239.867601323864, 13336.933315333361, 13604.795928060888, 14056.929715351358, 7660.96576962103, 10672.359658420519, 11553.24903881245, 12162.878371216528, 12188.634340969431, 11823.231489953125, 11854.585089521825, 11982.0, 12099.697507562381, 12362.072844536517, 11932.164748467523, 12281.69295767613, 12326.50693972231, 12442.564510242099, 12471.563495277622, 8903.510306933182, 8974.685885993958, 9030.729078127666, 9081.273498120267, 9124.635014599608, 9721.611135554782, 11442.885571144516, 12301.200421972542, 12303.200291980993, 12322.75354492923], "value": 9481.45561631747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.3199558192186, 1595.5771720494067, 1793.9910300448496, 1907.5707965707727, 1930.7876133625298, 7609.467337286392, 8351.0, 8370.414071015031, 8568.057513673499, 8601.354898382631, 8601.483910965331, 8668.696595619154, 8691.695790647329, 8710.564471776417, 8734.65061397545, 2381.92854214373, 2400.0, 2400.843945143569, 2401.267613377919, 2403.0147639467823, 2373.371056669984, 2377.2036367816804, 2436.5248776488593, 2447.1434997750735, 2448.816338774599, 2393.545226406986, 2423.9030438782515, 2428.9514209715794, 2433.598456254716, 2447.021191523396, 2373.715154181509, 2396.760323967589, 2410.3853517353136, 2415.8671273079885, 2424.490856920049, 2368.846025008369, 2373.7863592276603, 2374.6794182785275, 2377.548265829487, 2381.821363397752, 8677.956610216908, 8723.996740374874, 8729.432586881832, 8740.912590874137, 8742.781430464225, 5289.074411977888, 5362.597805164589, 5414.91877621836, 5458.426865179139, 5466.398696143421, 3427.3145370925913, 3442.7590068695204, 3463.1515278756615, 3505.7545971781988, 3523.735719821024, 1211.9091068169923, 1215.1190386969465, 1216.2702378572874, 1227.3801730126318, 1259.641002314336, 12160.966317862993, 12183.147179697426, 12229.755404891941, 12231.204971676812, 12258.938705306506, 4596.4254468191475, 4614.054118905617, 4637.982477622178, 4671.95328046722, 4677.766111694402, 10449.582016719398, 10485.0, 10489.790204195873, 10497.212709046851, 10512.21158413122, 5360.490753378423, 5369.24830523727, 5375.16684913839, 5385.246065550826, 5411.350637923474, 4309.0, 4850.878728031827, 4909.656324057281, 4922.4093108826455, 4951.8266860659705, 4234.957650423518, 4320.481542214954, 4332.93843008465, 4334.826606935687, 4344.326629372453, 1348.8516263211038, 1363.236587510997, 1367.9794803077962, 1370.8971827113007, 1390.478570536049, 984.9015098490094, 988.3180605382263, 990.3265779270165, 994.0407506756015, 1002.1531805624236, 5518.862028449241, 5618.522425593788, 5647.0, 5692.658440493501, 5701.2018317435595, 480.9711417314902, 489.1073790332657, 489.48992358574196, 494.60431654676836, 522.7516929458477, 3817.8854634361014, 3819.357676199261, 3849.2109117630816, 3889.5138107736534, 3933.1150491139265, 10301.845472317771, 10370.844437333295, 10619.88491208412, 10702.411367374714, 10709.571617135383, 10522.684319470429, 10531.94734026325, 10592.947035264928, 10603.734906627396, 10647.201459890539, 8141.063777665644, 8180.304674102649, 8187.877181842277, 8240.093589705128, 8389.580520973926, 5516.172574113915, 5541.667499950016, 5622.128570071645, 5696.857578560569, 5713.857153571028, 9313.0, 9393.201577865959, 9522.333436659368, 9581.0, 9619.51902404891, 9218.0, 9595.328327017041, 9596.23230141601, 9598.66404675833, 9604.95197524036, 7069.752558660422, 7234.457415693739, 7246.565206087652, 7434.033575635132, 7531.0, 7947.165547617417, 7955.363570914197, 7966.721164759206, 7997.680092796223, 8038.39712021589, 7086.681099350439, 7260.963695181702, 7322.707091716272, 7382.3724983377015, 7468.954346391401, 7191.712331506681, 7247.13034435871, 7253.673584688596, 7280.96359518199, 7344.48588598793, 6617.7683781067435, 6793.116894803644, 6807.795766127024, 6811.557248778813, 6844.589324640538, 4590.42619672541, 4751.976240118777, 4780.737059461763, 4822.831200907952, 4835.443923948791, 4978.1288274552535, 4992.650514463952, 5009.77456014473, 5020.748962551931, 5067.341245638044], "value": 4542.4883494073265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.53992340378784, 344.25984134111656, 346.53045123857163, 353.90621485306417, 355.51649756331403, 6373.61758294502, 6453.8709225815455, 6542.313057129004, 6552.213734351884, 6561.639109848957, 6489.870202595946, 6490.221173459192, 6497.382748638884, 6499.967500162505, 6506.869862602745, 4680.836170734025, 4785.880352991168, 4791.688540244891, 4793.233082706767, 4800.3279540864305, 4762.095201911626, 4799.5680388765, 4818.951810481885, 4845.0, 4845.781939812717, 4805.0, 4807.855764327076, 4809.495003024685, 4810.927836082462, 4812.518748125194, 4811.374521312207, 4814.446338671062, 4816.759162041884, 4818.421789385261, 4820.6143508519235, 4165.708400411972, 4167.333226683746, 4172.144710334374, 4175.770332631704, 4180.832766689329, 6003.339632640406, 6235.501159907197, 6246.375362463763, 6250.593711408744, 6255.437010669016, 5649.0114230009995, 5671.376148623648, 5676.233708449347, 5678.6024978251535, 5688.97155514224, 6939.4448444124855, 6943.305669433067, 6948.33990770876, 6955.791326260221, 6959.512834101615, 4657.836975705868, 4662.090892276007, 4664.183767840615, 4669.6731228814, 4685.5314468553215, 7166.641667916583, 7221.602811845346, 7232.312930271669, 7239.20368759436, 7242.0, 4667.883302917387, 4745.3593764842, 4753.5959443447, 4767.76161191939, 4769.833055843029, 4796.064767370399, 4817.8313759018265, 4826.638002149853, 4833.951660483421, 4845.878853028703, 5621.325440947113, 5637.633553818989, 5637.633553819071, 5646.887062258732, 5648.124540696116, 6912.101426814583, 6916.066331045345, 6929.722811087601, 6930.48021398387, 6952.791416257521, 1686.342326492669, 1703.9659206815795, 1706.7866516685415, 1708.5045336852174, 1708.7864016997876, 1051.6476980211714, 1085.46812062089, 1086.5165001574383, 1091.5906535049357, 1095.381109673048, 6796.422304104108, 6827.180738311435, 6827.590344579341, 6830.419414349836, 6834.350736680008, 7155.356017958408, 7160.427165826722, 7191.676374563157, 7200.1359836818865, 7211.350978411968, 6645.368689974444, 6844.384005439534, 6858.177018757781, 6863.862722745517, 6868.896966545506, 3870.651641352292, 3915.6280153385383, 3918.5689574146822, 3922.156736301709, 3934.488516492838, 7562.281583249583, 7613.314801667766, 7616.695332186761, 7616.961915190389, 7633.427492938052, 7288.635568221674, 7417.925820741832, 7428.071491063617, 7430.368418684472, 7440.55356678601, 7636.31273185416, 7636.427267954926, 7641.503302285334, 7650.540967541965, 7657.23427657241, 7227.963860180876, 7242.782716518513, 7248.963755181401, 7250.673719682733, 7257.455690823315, 7120.786376408716, 7147.499675022698, 7149.678264478007, 7153.535020223669, 7156.928430715626, 7483.251674832473, 7595.708729516106, 7615.428842836699, 7615.923840761743, 7651.0, 4755.5006724294835, 4762.190427627381, 4791.425028996543, 4795.904081918272, 4798.712077275374, 7207.6756545956605, 7210.603416811916, 7215.170255420694, 7218.3503484686635, 7219.241979592067, 6952.895706564304, 6996.580205187705, 7005.159380874327, 7007.439404847498, 7008.824779380557, 6825.419839313714, 6971.5468494547695, 6982.930170698228, 7006.194287656985, 7007.894881576883, 6838.14523184602, 6854.0, 6866.690998904961, 6875.690593923186, 6876.518643694893, 6984.650767461708, 7024.1571011478945, 7027.051348067946, 7027.121609798775, 7050.330218629222, 6862.656867156722, 6865.897011544731, 6868.862622747417, 6870.20992585859, 6881.724731010703], "value": 5186.757333844452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.8814365988761, 849.3205435651478, 851.4167795060384, 861.1603686405755, 895.5477483870644, 14788.852111478882, 15155.772663410058, 15161.469348572802, 16617.169141542934, 16752.413665521708, 14996.400143994228, 15058.0, 15079.62300942477, 15210.315535800888, 15234.54296371108, 874.3092956564323, 887.1837909123622, 889.5863423508067, 910.913463220993, 927.4018258223442, 916.7753900294438, 917.7063339731288, 920.9861852072224, 922.916937475627, 923.0953665407905, 931.5342328835583, 942.4722155592856, 942.8632848237002, 946.1437399153776, 949.9335046546745, 939.2908354192575, 942.4062840410566, 944.0182210501139, 944.5560586524323, 945.3288165402572, 683.641088428574, 685.8833998220315, 687.9346462086144, 692.6398272898115, 693.2824526614979, 15401.229938503142, 15429.151396673178, 15474.226288685633, 15497.457588984444, 15560.37758489659, 13786.034977551575, 13797.51708690191, 13812.37844297009, 13879.097858639156, 13888.583342499742, 10830.67507974762, 10934.0, 11174.608888688857, 11279.718007049889, 11359.318440893572, 3855.61443855615, 3895.590962948906, 3904.6681032112306, 3923.195744872294, 4021.4369988201674, 57077.0, 57099.42900571024, 57411.71294143503, 59006.0, 59146.0, 10141.0, 10141.29010969225, 10294.691159265234, 10467.42429166388, 10619.30974486656, 20276.18895244174, 20310.390688279374, 20380.694289585666, 20393.286234981704, 20466.18135274602, 8457.746267611858, 8565.828683426296, 8619.784505387415, 8663.35024873137, 8748.78128046804, 4849.199882019428, 4850.345203397566, 4891.6575839691595, 4906.31311616374, 4939.654224204343, 3519.9472007919903, 3595.2449985502813, 3596.892093237207, 3602.963970360263, 3612.0247533166425, 620.534599050712, 640.218932901859, 647.0456077285966, 651.3063587279532, 659.0147729144863, 649.376598465469, 654.6203202142746, 676.6278546799339, 683.0812557110678, 683.805115542078, 8887.422317549339, 9193.264538836876, 9240.260779137652, 9277.721668349961, 9349.953250233706, 740.0, 746.5708106613438, 749.7600767754375, 752.8720117580025, 767.6430459836203, 4277.486701595828, 4418.138462999685, 4460.30865215892, 4461.375407442961, 4528.796204170821, 65209.347906521274, 68171.31828681749, 68727.65636171788, 68816.31183688199, 68834.65582672154, 57248.42751572514, 57505.712471438215, 57607.423925761046, 57912.42087579155, 58470.0, 50014.24978625396, 50726.0, 50754.49245507571, 50934.74532627313, 52218.69453263699, 9353.158215760343, 9562.760930976781, 9633.518324083909, 9779.657711980046, 9870.851937220803, 37344.81327593345, 37588.06029849166, 38238.6176138235, 38399.232015360096, 39969.2006159881, 46657.533424666675, 46965.76517117392, 48344.7582762098, 48635.75682121567, 51549.48450515447, 12430.689232769253, 12449.688757780765, 12700.494901914268, 12777.808332874829, 12830.0, 14019.369128389451, 14380.28098595045, 14398.640033999234, 14430.278486075864, 14436.494722684656, 12514.624561263177, 13001.544945926848, 13131.60605181846, 13271.137376070525, 13442.193468391928, 12610.117291789853, 12867.420966056363, 13191.40638671243, 13315.66710832237, 13614.795778063535, 12774.74450510966, 12857.357132143168, 13150.882175015231, 13240.337983100613, 13249.205047697169, 10685.358878467317, 10689.679309620724, 10702.0, 10918.50866710984, 11234.0, 10957.232993690364, 11003.834942476029, 11056.447177641247, 11325.32048077118, 11477.0], "value": 7087.016246041752, "unit": "score"}], "name": "dromaeo_css", "value": 7564.414169965413, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 106.0, 111.0, 113.0, 114.0, 100.0, 111.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 152.0, 172.0, 135.0, 155.0, 149.0, 133.0, 179.0, 135.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 166.0, 162.0, 162.0, 167.0, 161.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 169.0, 73.0, 77.0, 76.0, 79.0, 161.0, 73.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 147.0, 92.0, 92.0, 93.0, 154.0, 92.0, 92.0, 150.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 63.0, 59.0, 57.0, 58.0, 57.0, 74.0, 57.0, 54.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 62.0, 60.0, 61.0, 62.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 83.0, 75.0, 73.0, 74.0, 73.0, 73.0, 80.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 114.0, 115.0, 118.0, 115.0, 116.0, 111.0, 114.0, 129.0, 133.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 164.0, 162.0, 161.0, 167.0, 166.0, 167.0, 165.0, 159.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 69.0, 67.0, 66.0, 71.0, 71.0, 68.0, 66.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1532.0, "alertThreshold": 2.0}]} 23:21:47 INFO - Return code: 0 23:21:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:21:47 ERROR - # TBPL SUCCESS # 23:21:47 INFO - Running post-action listener: _resource_record_post_action 23:21:47 INFO - Running post-run listener: _resource_record_post_run 23:21:48 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 32768; Write bytes: 467501056; Read time: 32; Write time: 463968 23:21:48 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 249794560; Read time: 0; Write time: 323376 23:21:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 217706496; Read time: 16; Write time: 140592 23:21:48 INFO - Running post-run listener: _upload_blobber_files 23:21:48 INFO - Blob upload gear active. 23:21:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:21:48 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 23:21:48 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'] 23:21:48 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 23:21:48 INFO - (blobuploader) - INFO - Open directory for files ... 23:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:49 INFO - (blobuploader) - INFO - Done attempting. 23:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:50 INFO - (blobuploader) - INFO - Done attempting. 23:21:50 INFO - (blobuploader) - INFO - Iteration through files over. 23:21:50 INFO - Return code: 0 23:21:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:21:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:21:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/beb56838671b7a71520b09ba9b460ac62b69c63f025606318041afaaff8acd1b365a0ab1f7d434a264c066fba861195e5e093ddb5568206b69bd8036a74f97f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8009fd99a237ec526b8ddb941f104f4c59566a35dc55ec635aaf33ab1cdb6891e2e61ee5962c71c37f7f54e45eec255f365108ca08dc4864398d98bf097319a1"} 23:21:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:21:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:21:50 INFO - Contents: 23:21:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/beb56838671b7a71520b09ba9b460ac62b69c63f025606318041afaaff8acd1b365a0ab1f7d434a264c066fba861195e5e093ddb5568206b69bd8036a74f97f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8009fd99a237ec526b8ddb941f104f4c59566a35dc55ec635aaf33ab1cdb6891e2e61ee5962c71c37f7f54e45eec255f365108ca08dc4864398d98bf097319a1"} 23:21:50 INFO - Running post-run listener: copy_logs_to_upload_dir 23:21:50 INFO - Copying logs to upload dir... 23:21:50 INFO - mkdir: /builds/slave/test/build/upload/logs 23:21:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.223843 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-13 23:21:50.395285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:50.398971) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243 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/beb56838671b7a71520b09ba9b460ac62b69c63f025606318041afaaff8acd1b365a0ab1f7d434a264c066fba861195e5e093ddb5568206b69bd8036a74f97f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8009fd99a237ec526b8ddb941f104f4c59566a35dc55ec635aaf33ab1cdb6891e2e61ee5962c71c37f7f54e45eec255f365108ca08dc4864398d98bf097319a1"} build_url:https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/BfmiI2iaTtitBchFRO-o1w/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/beb56838671b7a71520b09ba9b460ac62b69c63f025606318041afaaff8acd1b365a0ab1f7d434a264c066fba861195e5e093ddb5568206b69bd8036a74f97f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8009fd99a237ec526b8ddb941f104f4c59566a35dc55ec635aaf33ab1cdb6891e2e61ee5962c71c37f7f54e45eec255f365108ca08dc4864398d98bf097319a1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:50.424097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:50.424424) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1468476085.412343-2043379243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:21:50.510425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:21:50.510748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:21:50.511063) ========= ========= Total master_lag: 0.15 =========