builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1462579294.55 results: success (0) buildid: 20160506154204 builduid: b022e2339e6d42b7958b3573917d67eb revision: 47bc46e92a73043583aeb19341805fcacf185f93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.547749) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.548212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.548506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.568134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.568433) ========= 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=3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 17:01:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-06 17:01:35 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.700250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.700580) ========= 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=3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.750367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:34.750756) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47bc46e92a73043583aeb19341805fcacf185f93 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 47bc46e92a73043583aeb19341805fcacf185f93 --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=3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 17:01:35,599 truncating revision to first 12 chars 2016-05-06 17:01:35,599 Setting DEBUG logging. 2016-05-06 17:01:35,599 attempt 1/10 2016-05-06 17:01:35,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47bc46e92a73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 17:01:35,843 unpacking tar archive at: mozilla-central-47bc46e92a73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:35.289875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:35.290241) ========= script_repo_revision: 47bc46e92a73043583aeb19341805fcacf185f93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:35.290713) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:35.290981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 17:01:35.300965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-06 17:01:35.301401) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:01:36 INFO - MultiFileLogger online at 20160506 17:01:36 in /builds/slave/test 17:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:36 INFO - {'append_to_log': False, 17:01:36 INFO - 'base_work_dir': '/builds/slave/test', 17:01:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:36 INFO - 'branch': 'Firefox-Non-PGO', 17:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:36 INFO - 'config_files': ('talos/linux_config.py',), 17:01:36 INFO - 'default_actions': ('clobber', 17:01:36 INFO - 'read-buildbot-config', 17:01:36 INFO - 'download-and-extract', 17:01:36 INFO - 'populate-webroot', 17:01:36 INFO - 'create-virtualenv', 17:01:36 INFO - 'install', 17:01:36 INFO - 'run-tests'), 17:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:36 INFO - 'download_minidump_stackwalk': True, 17:01:36 INFO - 'download_symbols': 'ondemand', 17:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:36 INFO - 'installer_path': 'installer.exe', 17:01:36 INFO - 'log_level': 'info', 17:01:36 INFO - 'log_name': 'talos', 17:01:36 INFO - 'log_to_console': True, 17:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:01:36 INFO - 'opt_config_files': (), 17:01:36 INFO - 'pip_index': False, 17:01:36 INFO - 'sps_profile': False, 17:01:36 INFO - 'sps_profile_interval': 0, 17:01:36 INFO - 'suite': 'dromaeojs-e10s', 17:01:36 INFO - 'system_bits': '32', 17:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:36 INFO - 'title': 'talos-linux64-ix-059', 17:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:36 INFO - 'use_talos_json': True, 17:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:36 INFO - 'work_dir': 'build'} 17:01:36 INFO - ##### 17:01:36 INFO - ##### Running clobber step. 17:01:36 INFO - ##### 17:01:36 INFO - Running pre-action listener: _resource_record_pre_action 17:01:36 INFO - Running main action method: clobber 17:01:36 INFO - rmtree: /builds/slave/test/build 17:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:01:36 INFO - Running post-action listener: _resource_record_post_action 17:01:36 INFO - ##### 17:01:36 INFO - ##### Finished clobber step (success) 17:01:36 INFO - ##### 17:01:36 INFO - ##### 17:01:36 INFO - ##### Running read-buildbot-config step. 17:01:36 INFO - ##### 17:01:36 INFO - Running pre-action listener: _resource_record_pre_action 17:01:36 INFO - Running main action method: read_buildbot_config 17:01:36 INFO - Using buildbot properties: 17:01:36 INFO - { 17:01:36 INFO - "project": "", 17:01:36 INFO - "product": "firefox", 17:01:36 INFO - "script_repo_revision": "production", 17:01:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:01:36 INFO - "repository": "", 17:01:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:01:36 INFO - "buildid": "20160506154204", 17:01:36 INFO - "pgo_build": "False", 17:01:36 INFO - "basedir": "/builds/slave/test", 17:01:36 INFO - "buildnumber": 48, 17:01:36 INFO - "slavename": "talos-linux64-ix-059", 17:01:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:01:36 INFO - "platform": "ubuntu64_hw", 17:01:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:01:36 INFO - "branch": "mozilla-central", 17:01:36 INFO - "repo_path": "mozilla-central", 17:01:36 INFO - "revision": "47bc46e92a73043583aeb19341805fcacf185f93", 17:01:36 INFO - "stage_platform": "linux64", 17:01:36 INFO - "builduid": "b022e2339e6d42b7958b3573917d67eb", 17:01:36 INFO - "slavebuilddir": "test" 17:01:36 INFO - } 17:01:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:01:36 INFO - Running post-action listener: _resource_record_post_action 17:01:36 INFO - ##### 17:01:36 INFO - ##### Finished read-buildbot-config step (success) 17:01:36 INFO - ##### 17:01:36 INFO - ##### 17:01:36 INFO - ##### Running download-and-extract step. 17:01:36 INFO - ##### 17:01:36 INFO - Running pre-action listener: _resource_record_pre_action 17:01:36 INFO - Running main action method: download_and_extract 17:01:36 INFO - mkdir: /builds/slave/test/build/tests 17:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:36 INFO - https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:01:38 INFO - Downloaded 1361 bytes. 17:01:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:38 INFO - Using the following test package requirements: 17:01:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:01:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:01:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'jsshell-linux-x86_64.zip'], 17:01:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:01:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:01:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:01:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:01:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:01:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:38 INFO - https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:01:39 INFO - Downloaded 22321042 bytes. 17:01:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:01:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:01:41 INFO - Return code: 0 17:01:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:41 INFO - https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:01:42 INFO - Downloaded 22321042 bytes. 17:01:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:01:44 INFO - Return code: 0 17: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')]} 17:01:44 INFO - https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:01:46 INFO - Downloaded 10840152 bytes. 17:01:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:01:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:01:46 INFO - Return code: 0 17:01:46 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')]} 17:01:46 INFO - https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:01:49 INFO - Downloaded 54838578 bytes. 17:01:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:49 INFO - mkdir: /builds/slave/test/properties 17:01:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:01:49 INFO - Writing to file /builds/slave/test/properties/build_url 17:01:49 INFO - Contents: 17:01:49 INFO - build_url:https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:49 INFO - Running post-action listener: _resource_record_post_action 17:01:49 INFO - Running post-action listener: set_extra_try_arguments 17:01:49 INFO - ##### 17:01:49 INFO - ##### Finished download-and-extract step (success) 17:01:49 INFO - ##### 17:01:49 INFO - ##### 17:01:49 INFO - ##### Running populate-webroot step. 17:01:49 INFO - ##### 17:01:49 INFO - Running pre-action listener: _resource_record_pre_action 17:01:49 INFO - Running main action method: populate_webroot 17:01:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:01:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:01:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:01:49 INFO - '--tppagecycles', 17:01:49 INFO - '7'], 17:01:49 INFO - 'tests': ['tsvgm']}}, 17:01:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:01:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:01:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:01:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:01:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:01:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:01:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['damp', 'tps']}, 17:01:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'tests': ['damp', 'tps']}, 17:01:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['dromaeo_dom']}, 17:01:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:01:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['a11yr', 17:01:49 INFO - 'ts_paint', 17:01:49 INFO - 'tpaint', 17:01:49 INFO - 'sessionrestore', 17:01:49 INFO - 'sessionrestore_no_auto_restore', 17:01:49 INFO - 'tabpaint']}, 17:01:49 INFO - 'other-e10s': {'tests': ['a11yr', 17:01:49 INFO - 'ts_paint', 17:01:49 INFO - 'tpaint', 17:01:49 INFO - 'sessionrestore', 17:01:49 INFO - 'sessionrestore_no_auto_restore', 17:01:49 INFO - 'tabpaint']}, 17:01:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:01:49 INFO - 'ts_paint', 17:01:49 INFO - 'tpaint', 17:01:49 INFO - 'sessionrestore', 17:01:49 INFO - 'sessionrestore_no_auto_restore', 17:01:49 INFO - 'tabpaint']}, 17:01:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:01:49 INFO - 'ts_paint', 17:01:49 INFO - 'tpaint', 17:01:49 INFO - 'sessionrestore', 17:01:49 INFO - 'sessionrestore_no_auto_restore', 17:01:49 INFO - 'tabpaint']}, 17:01:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['a11yr', 17:01:49 INFO - 'ts_paint', 17:01:49 INFO - 'tpaint', 17:01:49 INFO - 'sessionrestore', 17:01:49 INFO - 'sessionrestore_no_auto_restore', 17:01:49 INFO - 'tabpaint']}, 17:01:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['a11yr', 17:01:49 INFO - 'ts_paint', 17:01:49 INFO - 'tpaint', 17:01:49 INFO - 'sessionrestore', 17:01:49 INFO - 'sessionrestore_no_auto_restore', 17:01:49 INFO - 'tabpaint']}, 17:01:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['tsvgx', 17:01:49 INFO - 'tsvgr_opacity', 17:01:49 INFO - 'tart', 17:01:49 INFO - 'tscrollx', 17:01:49 INFO - 'cart']}, 17:01:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:01:49 INFO - 'tsvgr_opacity', 17:01:49 INFO - 'tart', 17:01:49 INFO - 'tscrollx', 17:01:49 INFO - 'cart']}, 17:01:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'talos_options': ['--disable-e10s'], 17:01:49 INFO - 'tests': ['tp5o']}, 17:01:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'tests': ['tp5o']}, 17:01:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'talos_options': ['--disable-e10s', 17:01:49 INFO - '--xperf_path', 17:01:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:01:49 INFO - 'tests': ['tp5n']}, 17:01:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:49 INFO - 'talos_options': ['--xperf_path', 17:01:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:01:49 INFO - 'tests': ['tp5n']}}, 17:01:49 INFO - 'talos.zip': {'path': '', 17:01:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:01:49 INFO - Running post-action listener: _resource_record_post_action 17:01:49 INFO - ##### 17:01:49 INFO - ##### Finished populate-webroot step (success) 17:01:49 INFO - ##### 17:01:49 INFO - ##### 17:01:49 INFO - ##### Running create-virtualenv step. 17:01:49 INFO - ##### 17:01:49 INFO - Running pre-action listener: _resource_record_pre_action 17:01:49 INFO - Running main action method: create_virtualenv 17:01:49 INFO - Creating virtualenv /builds/slave/test/build/venv 17:01:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:01:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:01:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:01:49 INFO - Using real prefix '/usr' 17:01:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:01:50 INFO - Installing distribute.............................................................................................................................................................................................done. 17:01:52 INFO - Installing pip.................done. 17:01:52 INFO - Return code: 0 17:01:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:01:52 INFO - Using env: {'DISPLAY': ':0', 17:01:52 INFO - 'HOME': '/home/cltbld', 17:01:52 INFO - 'LANG': 'en_US.UTF-8', 17:01:52 INFO - 'LANGUAGE': 'en_US:en', 17:01:52 INFO - 'LOGNAME': 'cltbld', 17:01:52 INFO - 'MAIL': '/var/mail/cltbld', 17:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:52 INFO - 'MOZ_NO_REMOTE': '1', 17:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:52 INFO - 'NO_EM_RESTART': '1', 17:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:52 INFO - 'PWD': '/builds/slave/test', 17:01:52 INFO - 'SHELL': '/bin/bash', 17:01:52 INFO - 'SHLVL': '1', 17:01:52 INFO - 'TERM': 'linux', 17:01:52 INFO - 'TMOUT': '86400', 17:01:52 INFO - 'USER': 'cltbld', 17:01:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:52 INFO - '_': '/tools/buildbot/bin/python'} 17:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:01:52 INFO - Cleaning up... 17:01:52 INFO - Return code: 0 17:01:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:01:52 INFO - Using env: {'DISPLAY': ':0', 17:01:52 INFO - 'HOME': '/home/cltbld', 17:01:52 INFO - 'LANG': 'en_US.UTF-8', 17:01:52 INFO - 'LANGUAGE': 'en_US:en', 17:01:52 INFO - 'LOGNAME': 'cltbld', 17:01:52 INFO - 'MAIL': '/var/mail/cltbld', 17:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:52 INFO - 'MOZ_NO_REMOTE': '1', 17:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:52 INFO - 'NO_EM_RESTART': '1', 17:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:52 INFO - 'PWD': '/builds/slave/test', 17:01:52 INFO - 'SHELL': '/bin/bash', 17:01:52 INFO - 'SHLVL': '1', 17:01:52 INFO - 'TERM': 'linux', 17:01:52 INFO - 'TMOUT': '86400', 17:01:52 INFO - 'USER': 'cltbld', 17:01:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:52 INFO - '_': '/tools/buildbot/bin/python'} 17:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:52 INFO - Downloading/unpacking psutil>=0.7.1 17:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:54 INFO - Installing collected packages: psutil 17:01:54 INFO - Running setup.py install for psutil 17:01:54 INFO - building 'psutil._psutil_linux' extension 17:01:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:01:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:01:55 INFO - building 'psutil._psutil_posix' extension 17:01:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:01:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:55 INFO - Successfully installed psutil 17:01:55 INFO - Cleaning up... 17:01:55 INFO - Return code: 0 17:01:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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', '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 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17: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 mozsystemmonitor==0.0.0 17:01:55 INFO - Using env: {'DISPLAY': ':0', 17:01:55 INFO - 'HOME': '/home/cltbld', 17:01:55 INFO - 'LANG': 'en_US.UTF-8', 17:01:55 INFO - 'LANGUAGE': 'en_US:en', 17:01:55 INFO - 'LOGNAME': 'cltbld', 17:01:55 INFO - 'MAIL': '/var/mail/cltbld', 17:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:55 INFO - 'MOZ_NO_REMOTE': '1', 17:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:55 INFO - 'NO_EM_RESTART': '1', 17:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:55 INFO - 'PWD': '/builds/slave/test', 17:01:55 INFO - 'SHELL': '/bin/bash', 17:01:55 INFO - 'SHLVL': '1', 17:01:55 INFO - 'TERM': 'linux', 17:01:55 INFO - 'TMOUT': '86400', 17:01:55 INFO - 'USER': 'cltbld', 17:01:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:55 INFO - '_': '/tools/buildbot/bin/python'} 17:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17: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 17: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 17: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 17: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 17: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 17: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 17:01:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:01:57 INFO - Installing collected packages: mozsystemmonitor 17:01:57 INFO - Running setup.py install for mozsystemmonitor 17:01:57 INFO - Successfully installed mozsystemmonitor 17:01:57 INFO - Cleaning up... 17:01:57 INFO - Return code: 0 17:01:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:01:57 INFO - Using env: {'DISPLAY': ':0', 17:01:57 INFO - 'HOME': '/home/cltbld', 17:01:57 INFO - 'LANG': 'en_US.UTF-8', 17:01:57 INFO - 'LANGUAGE': 'en_US:en', 17:01:57 INFO - 'LOGNAME': 'cltbld', 17:01:57 INFO - 'MAIL': '/var/mail/cltbld', 17:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:57 INFO - 'MOZ_NO_REMOTE': '1', 17:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:57 INFO - 'NO_EM_RESTART': '1', 17:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:57 INFO - 'PWD': '/builds/slave/test', 17:01:57 INFO - 'SHELL': '/bin/bash', 17:01:57 INFO - 'SHLVL': '1', 17:01:57 INFO - 'TERM': 'linux', 17:01:57 INFO - 'TMOUT': '86400', 17:01:57 INFO - 'USER': 'cltbld', 17:01:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:57 INFO - '_': '/tools/buildbot/bin/python'} 17:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:57 INFO - Downloading/unpacking blobuploader==1.2.4 17: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 17: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 17: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 17: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 17: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 17: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 17:01:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:01:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17: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 17: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 17: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 17: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 17: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 17: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 17:02:00 INFO - Downloading docopt-0.6.1.tar.gz 17:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:00 INFO - Running setup.py install for blobuploader 17:02:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:00 INFO - Running setup.py install for requests 17:02:01 INFO - Running setup.py install for docopt 17:02:01 INFO - Successfully installed blobuploader requests docopt 17:02:01 INFO - Cleaning up... 17:02:01 INFO - Return code: 0 17:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:02:01 INFO - Using env: {'DISPLAY': ':0', 17:02:01 INFO - 'HOME': '/home/cltbld', 17:02:01 INFO - 'LANG': 'en_US.UTF-8', 17:02:01 INFO - 'LANGUAGE': 'en_US:en', 17:02:01 INFO - 'LOGNAME': 'cltbld', 17:02:01 INFO - 'MAIL': '/var/mail/cltbld', 17:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:01 INFO - 'MOZ_NO_REMOTE': '1', 17:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:01 INFO - 'NO_EM_RESTART': '1', 17:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:01 INFO - 'PWD': '/builds/slave/test', 17:02:01 INFO - 'SHELL': '/bin/bash', 17:02:01 INFO - 'SHLVL': '1', 17:02:01 INFO - 'TERM': 'linux', 17:02:01 INFO - 'TMOUT': '86400', 17:02:01 INFO - 'USER': 'cltbld', 17:02:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:01 INFO - '_': '/tools/buildbot/bin/python'} 17:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:01 INFO - Running setup.py (path:/tmp/pip-FYpyLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:01 INFO - Running setup.py (path:/tmp/pip-i1GGpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:01 INFO - Running setup.py (path:/tmp/pip-mvUthN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:01 INFO - Running setup.py (path:/tmp/pip-Fm00by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:01 INFO - Running setup.py (path:/tmp/pip-9WXXH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:01 INFO - Running setup.py (path:/tmp/pip-No7b7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:01 INFO - Running setup.py (path:/tmp/pip-fc8Fkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:01 INFO - Running setup.py (path:/tmp/pip-1THiTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:01 INFO - Running setup.py (path:/tmp/pip-jBUhKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:02 INFO - Running setup.py (path:/tmp/pip-2BkDDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:02 INFO - Running setup.py (path:/tmp/pip-eBOiWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:02 INFO - Running setup.py (path:/tmp/pip-D4GhCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:02 INFO - Running setup.py (path:/tmp/pip-AOOETP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:02 INFO - Running setup.py (path:/tmp/pip-hTnVzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:02 INFO - Running setup.py (path:/tmp/pip-t3U5pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:02 INFO - Running setup.py (path:/tmp/pip-K62uIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:02 INFO - Running setup.py (path:/tmp/pip-pKet73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:02 INFO - Running setup.py install for manifestparser 17:02:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:02 INFO - Running setup.py install for mozcrash 17:02:02 INFO - Running setup.py install for mozdebug 17:02:02 INFO - Running setup.py install for mozdevice 17:02:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:02:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for mozfile 17:02:03 INFO - Running setup.py install for mozhttpd 17:02:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for mozinfo 17:02:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for mozInstall 17:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for mozleak 17:02:03 INFO - Running setup.py install for mozlog 17:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for moznetwork 17:02:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for mozprocess 17:02:03 INFO - Running setup.py install for mozprofile 17:02:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:03 INFO - Running setup.py install for mozrunner 17:02:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:04 INFO - Running setup.py install for mozscreenshot 17:02:04 INFO - Running setup.py install for moztest 17:02:04 INFO - Running setup.py install for mozversion 17:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:04 INFO - Cleaning up... 17:02:04 INFO - Return code: 0 17:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:02:04 INFO - Using env: {'DISPLAY': ':0', 17:02:04 INFO - 'HOME': '/home/cltbld', 17:02:04 INFO - 'LANG': 'en_US.UTF-8', 17:02:04 INFO - 'LANGUAGE': 'en_US:en', 17:02:04 INFO - 'LOGNAME': 'cltbld', 17:02:04 INFO - 'MAIL': '/var/mail/cltbld', 17:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:04 INFO - 'MOZ_NO_REMOTE': '1', 17:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:04 INFO - 'NO_EM_RESTART': '1', 17:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:04 INFO - 'PWD': '/builds/slave/test', 17:02:04 INFO - 'SHELL': '/bin/bash', 17:02:04 INFO - 'SHLVL': '1', 17:02:04 INFO - 'TERM': 'linux', 17:02:04 INFO - 'TMOUT': '86400', 17:02:04 INFO - 'USER': 'cltbld', 17:02:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:04 INFO - '_': '/tools/buildbot/bin/python'} 17:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:04 INFO - Running setup.py (path:/tmp/pip-7m5T20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:04 INFO - Running setup.py (path:/tmp/pip-T6FO2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:04 INFO - Running setup.py (path:/tmp/pip-z3BxLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:04 INFO - Running setup.py (path:/tmp/pip-kx2FHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:04 INFO - Running setup.py (path:/tmp/pip-aG5ipJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:04 INFO - Running setup.py (path:/tmp/pip-KWISkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:05 INFO - Running setup.py (path:/tmp/pip-zGGcY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:05 INFO - Running setup.py (path:/tmp/pip-oIAaTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:05 INFO - Running setup.py (path:/tmp/pip-Uc7aS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:05 INFO - Running setup.py (path:/tmp/pip-qT2BxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:05 INFO - Running setup.py (path:/tmp/pip-ljgBvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:05 INFO - Running setup.py (path:/tmp/pip-MmNkEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:05 INFO - Running setup.py (path:/tmp/pip-Jt7en5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:05 INFO - Running setup.py (path:/tmp/pip-DEEpNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:05 INFO - Running setup.py (path:/tmp/pip-hw5Tab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:05 INFO - Running setup.py (path:/tmp/pip-FqeHy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:05 INFO - Running setup.py (path:/tmp/pip-BCMRLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:02:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:07 INFO - Downloading blessings-1.6.tar.gz 17:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:07 INFO - Installing collected packages: blessings 17:02:07 INFO - Running setup.py install for blessings 17:02:07 INFO - Successfully installed blessings 17:02:07 INFO - Cleaning up... 17:02:07 INFO - Return code: 0 17:02:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:08 INFO - Reading from file tmpfile_stdout 17:02:08 INFO - Current package versions: 17:02:08 INFO - argparse == 1.2.1 17:02:08 INFO - blessings == 1.6 17:02:08 INFO - blobuploader == 1.2.4 17:02:08 INFO - docopt == 0.6.1 17:02:08 INFO - manifestparser == 1.1 17:02:08 INFO - mozInstall == 1.12 17:02:08 INFO - mozcrash == 0.17 17:02:08 INFO - mozdebug == 0.1 17:02:08 INFO - mozdevice == 0.48 17:02:08 INFO - mozfile == 1.2 17:02:08 INFO - mozhttpd == 0.7 17:02:08 INFO - mozinfo == 0.9 17:02:08 INFO - mozleak == 0.1 17:02:08 INFO - mozlog == 3.1 17:02:08 INFO - moznetwork == 0.27 17:02:08 INFO - mozprocess == 0.22 17:02:08 INFO - mozprofile == 0.28 17:02:08 INFO - mozrunner == 6.11 17:02:08 INFO - mozscreenshot == 0.1 17:02:08 INFO - mozsystemmonitor == 0.0 17:02:08 INFO - moztest == 0.7 17:02:08 INFO - mozversion == 1.4 17:02:08 INFO - psutil == 3.1.1 17:02:08 INFO - requests == 1.2.3 17:02:08 INFO - wsgiref == 0.1.2 17:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:02:08 INFO - Using env: {'DISPLAY': ':0', 17:02:08 INFO - 'HOME': '/home/cltbld', 17:02:08 INFO - 'LANG': 'en_US.UTF-8', 17:02:08 INFO - 'LANGUAGE': 'en_US:en', 17:02:08 INFO - 'LOGNAME': 'cltbld', 17:02:08 INFO - 'MAIL': '/var/mail/cltbld', 17:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:08 INFO - 'MOZ_NO_REMOTE': '1', 17:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:08 INFO - 'NO_EM_RESTART': '1', 17:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:08 INFO - 'PWD': '/builds/slave/test', 17:02:08 INFO - 'SHELL': '/bin/bash', 17:02:08 INFO - 'SHLVL': '1', 17:02:08 INFO - 'TERM': 'linux', 17:02:08 INFO - 'TMOUT': '86400', 17:02:08 INFO - 'USER': 'cltbld', 17:02:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:08 INFO - '_': '/tools/buildbot/bin/python'} 17:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:02:08 INFO - Cleaning up... 17:02:08 INFO - Return code: 0 17:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:02:08 INFO - Using env: {'DISPLAY': ':0', 17:02:08 INFO - 'HOME': '/home/cltbld', 17:02:08 INFO - 'LANG': 'en_US.UTF-8', 17:02:08 INFO - 'LANGUAGE': 'en_US:en', 17:02:08 INFO - 'LOGNAME': 'cltbld', 17:02:08 INFO - 'MAIL': '/var/mail/cltbld', 17:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:08 INFO - 'MOZ_NO_REMOTE': '1', 17:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:08 INFO - 'NO_EM_RESTART': '1', 17:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:08 INFO - 'PWD': '/builds/slave/test', 17:02:08 INFO - 'SHELL': '/bin/bash', 17:02:08 INFO - 'SHLVL': '1', 17:02:08 INFO - 'TERM': 'linux', 17:02:08 INFO - 'TMOUT': '86400', 17:02:08 INFO - 'USER': 'cltbld', 17:02:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:08 INFO - '_': '/tools/buildbot/bin/python'} 17:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:08 INFO - Downloading/unpacking jsonschema 17:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:02:10 INFO - Downloading/unpacking functools32 (from jsonschema) 17:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:02:10 INFO - warning: no files found matching '*.txt' 17:02:10 INFO - no previously-included directories found matching 'build' 17:02:10 INFO - no previously-included directories found matching 'dist' 17:02:10 INFO - no previously-included directories found matching '.git*' 17:02:10 INFO - Installing collected packages: jsonschema, functools32 17:02:10 INFO - Running setup.py install for functools32 17:02:10 INFO - warning: no files found matching '*.txt' 17:02:10 INFO - no previously-included directories found matching 'build' 17:02:10 INFO - no previously-included directories found matching 'dist' 17:02:10 INFO - no previously-included directories found matching '.git*' 17:02:10 INFO - Successfully installed jsonschema functools32 17:02:10 INFO - Cleaning up... 17:02:10 INFO - Return code: 0 17:02:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05147e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2351770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', '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 17:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:02:10 INFO - Using env: {'DISPLAY': ':0', 17:02:10 INFO - 'HOME': '/home/cltbld', 17:02:10 INFO - 'LANG': 'en_US.UTF-8', 17:02:10 INFO - 'LANGUAGE': 'en_US:en', 17:02:10 INFO - 'LOGNAME': 'cltbld', 17:02:10 INFO - 'MAIL': '/var/mail/cltbld', 17:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:10 INFO - 'MOZ_NO_REMOTE': '1', 17:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:10 INFO - 'NO_EM_RESTART': '1', 17:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:10 INFO - 'PWD': '/builds/slave/test', 17:02:10 INFO - 'SHELL': '/bin/bash', 17:02:10 INFO - 'SHLVL': '1', 17:02:10 INFO - 'TERM': 'linux', 17:02:10 INFO - 'TMOUT': '86400', 17:02:10 INFO - 'USER': 'cltbld', 17:02:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:10 INFO - '_': '/tools/buildbot/bin/python'} 17:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:11 INFO - Downloading/unpacking flake8 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:02:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:02:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 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 17:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:02:13 INFO - no previously-included directories found matching 'docs/_build' 17:02:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:02:13 INFO - Running setup.py install for pep8 17:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:02:13 INFO - no previously-included directories found matching 'docs/_build' 17:02:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:02:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:02:13 INFO - Cleaning up... 17:02:13 INFO - Return code: 0 17:02:13 INFO - Running post-action listener: _resource_record_post_action 17:02:13 INFO - Running post-action listener: _start_resource_monitoring 17:02:14 INFO - Starting resource monitoring. 17:02:14 INFO - ##### 17:02:14 INFO - ##### Finished create-virtualenv step (success) 17:02:14 INFO - ##### 17:02:14 INFO - ##### 17:02:14 INFO - ##### Running install step. 17:02:14 INFO - ##### 17:02:14 INFO - Running pre-action listener: _resource_record_pre_action 17:02:14 INFO - Running main action method: install 17:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:14 INFO - Reading from file tmpfile_stdout 17:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:02:14 INFO - Reading from file tmpfile_stdout 17:02:14 INFO - Output received: 17:02:14 INFO - Usage: mozinstall [options] installer 17:02:14 INFO - Options: 17:02:14 INFO - -h, --help show this help message and exit 17:02:14 INFO - -d DEST, --destination=DEST 17:02:14 INFO - Directory to install application into. [default: 17:02:14 INFO - "/builds/slave/test"] 17:02:14 INFO - --app=APP Application being installed. [default: firefox] 17:02:14 INFO - mkdir: /builds/slave/test/build/application 17:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:02:30 INFO - Reading from file tmpfile_stdout 17:02:30 INFO - Output received: 17:02:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:02:30 INFO - Running post-action listener: _resource_record_post_action 17:02:30 INFO - ##### 17:02:30 INFO - ##### Finished install step (success) 17:02:30 INFO - ##### 17:02:30 INFO - ##### 17:02:30 INFO - ##### Running run-tests step. 17:02:30 INFO - ##### 17:02:30 INFO - Running pre-action listener: _resource_record_pre_action 17:02:30 INFO - Running main action method: run_tests 17:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:02:30 INFO - Python 2.7.3 17:02:30 INFO - Return code: 0 17:02:30 INFO - grabbing minidump binary from tooltool 17:02: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')]} 17:02:30 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 0x23e09c0>, '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 0x23e18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:02:30 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 17:02:30 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 17:02:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:02:30 INFO - Return code: 0 17:02:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:02:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:02:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:02:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:02:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:02:31 INFO - Return code: 0 17:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 17:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 17:02:31 INFO - Using env: {'DISPLAY': ':0', 17:02:31 INFO - 'HOME': '/home/cltbld', 17:02:31 INFO - 'LANG': 'en_US.UTF-8', 17:02:31 INFO - 'LANGUAGE': 'en_US:en', 17:02:31 INFO - 'LOGNAME': 'cltbld', 17:02:31 INFO - 'MAIL': '/var/mail/cltbld', 17:02:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:02:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:31 INFO - 'MOZ_NO_REMOTE': '1', 17:02:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:31 INFO - 'NO_EM_RESTART': '1', 17:02:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:31 INFO - 'PWD': '/builds/slave/test', 17:02:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:02:31 INFO - 'SHELL': '/bin/bash', 17:02:31 INFO - 'SHLVL': '1', 17:02:31 INFO - 'TERM': 'linux', 17:02:31 INFO - 'TMOUT': '86400', 17:02:31 INFO - 'USER': 'cltbld', 17:02:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366', 17:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:31 INFO - '_': '/tools/buildbot/bin/python'} 17:02:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 17:02:31 INFO - mozversion application_buildid: 20160506154204 17:02:31 INFO - mozversion application_changeset: 47bc46e92a73043583aeb19341805fcacf185f93 17:02:31 INFO - mozversion application_display_name: Nightly 17:02:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:02:31 INFO - mozversion application_name: Firefox 17:02:31 INFO - mozversion application_remotingname: firefox 17:02:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:02:31 INFO - mozversion application_vendor: Mozilla 17:02:31 INFO - mozversion application_version: 49.0a1 17:02:31 INFO - mozversion platform_buildid: 20160506154204 17:02:31 INFO - mozversion platform_changeset: 47bc46e92a73043583aeb19341805fcacf185f93 17:02:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:02:31 INFO - mozversion platform_version: 49.0a1 17:02:31 INFO - using testdate: 1462579351 17:02:31 INFO - actual date: 1462579351 17:02:31 INFO - starting webserver on 'localhost:55548' 17:02:31 INFO - SUITE-START | Running 2 tests 17:02:31 INFO - TEST-START | dromaeo_css 17:02:31 INFO - operating with platform_type : linux_ 17:02:31 INFO - Initialising browser for dromaeo_css test... 17:02:31 INFO - TEST-INFO | started process 4839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbImnV6/profile http://localhost:55548/getInfo.html) 17:02:34 INFO - PROCESS | 4839 | 17:02:34 INFO - PROCESS | 4839 | (process:4908): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:02:35 INFO - PROCESS | 4839 | __metrics Screen width/height:1600/1200 17:02:35 INFO - PROCESS | 4839 | colorDepth:24 17:02:35 INFO - PROCESS | 4839 | Browser inner width/height: 1024/697 17:02:35 INFO - PROCESS | 4839 | __metrics 17:02:36 ERROR - PROCESS | 4839 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:02:37 INFO - TEST-INFO | 4839: exit 0 17:02:37 INFO - Browser initialized. 17:02:37 INFO - Running cycle 1/1 for dromaeo_css test... 17:02:37 INFO - TEST-INFO | started process 4959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbImnV6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:39 INFO - PROCESS | 4959 | 17:02:39 INFO - PROCESS | 4959 | (process:5019): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:02:49 INFO - PROCESS | 4959 | RSS: Main: 164642816 17:02:49 INFO - PROCESS | 4959 | 17:03:38 INFO - PROCESS | 4959 | 1462579418690 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] 17:05:50 INFO - PROCESS | 4959 | Cycle 1(1): loaded http://localhost:55548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55548/tests/dromaeo/cssquery-ext.html) 17:05:51 INFO - PROCESS | 4959 | RSS: Main: 166248448 17:05:51 INFO - PROCESS | 4959 | 17:08:53 INFO - PROCESS | 4959 | Cycle 1(1): loaded http://localhost:55548/tests/dromaeo/cssquery-ext.html (next: http://localhost:55548/tests/dromaeo/cssquery-jquery.html) 17:08:54 INFO - PROCESS | 4959 | RSS: Main: 167952384 17:08:54 INFO - PROCESS | 4959 | 17:11:56 INFO - PROCESS | 4959 | Cycle 1(1): loaded http://localhost:55548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55548/tests/dromaeo/cssquery-mootools.html) 17:11:56 INFO - PROCESS | 4959 | RSS: Main: 168570880 17:11:56 INFO - PROCESS | 4959 | 17:14:58 INFO - PROCESS | 4959 | Cycle 1(1): loaded http://localhost:55548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55548/tests/dromaeo/cssquery-prototype.html) 17:14:59 INFO - PROCESS | 4959 | RSS: Main: 166232064 17:14:59 INFO - PROCESS | 4959 | 17:18:02 INFO - PROCESS | 4959 | Cycle 1(1): loaded http://localhost:55548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55548/tests/dromaeo/cssquery-yui.html) 17:18:02 INFO - PROCESS | 4959 | RSS: Main: 167657472 17:18:02 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | Cycle 1(1): loaded http://localhost:55548/tests/dromaeo/cssquery-yui.html (next: http://localhost:55548/tests/dromaeo/cssquery-dojo.html) 17:21:05 INFO - PROCESS | 4959 | RSS: Main: 169189376 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | __start_tp_report 17:21:05 INFO - PROCESS | 4959 | _x_x_mozilla_page_load 17:21:05 INFO - PROCESS | 4959 | _x_x_mozilla_page_load_details 17:21:05 INFO - PROCESS | 4959 | |i|pagename|runs| 17:21:05 INFO - PROCESS | 4959 | |0;dojo.html;2615.1500762252267;2661.760441560259;2675.7725593324567;2680.4103097318593;2687.0998215597774;4687.554682305184;4698.412698412699;4731.33761273422;4808.350872632193;4851.417829860422;4603.3785438965815;4739.4075740532435;4741.5495527924795;4761.47623761386;4840.201366774478;4332.740035597859;4336.111097225069;4387.517373088974;4473.351364052211;4496.348029535716;4378.992831648723;4493.752843593617;4495.011097558532;4522.819087236507;4528.886777830564;4241.4698162729655;4263.509696384925;4355.891102722426;4420.8673739787855;4435.645148388137;4286.164197981395;4288.31386978082;4294.3343781713575;4310.633596144332;4333.9133217335475;4291.506476755182;4311.28863737483;4315.654747620214;4318.503372112216;4347.043650396908;4572.817087316504;4599.218132917412;4651.883702907455;4668.019715859639;4669.533046695304;5027.371578552681;5056.115179843513;5056.469070747592;5063.240513922904;5132.204508301219;5055.191169412913;5086.974565127188;5088.898222035576;5098.770555325019;5116.411612664554;4657.4876763555985;4713.7643117844655;4714.481407045222;4715.882102947454;4724.126036683225;5121.129408000649;5134.666246693953;5149.7940082397035;5150.4849515048945;5157.716325602053;4811.037792441526;4862.95137048632;4937.604991600663;4943.9258411123865;4988;4983.5763960063805;4995.775190116454;5024.874378140576;5038.974805126024;5075.771590278372;4778.904421911542;4951.232558953368;4966.726830024383;4994.850154495371;5025.648204625714;4809.44691360491;4868.805247790119;4984.077945580007;4985.601151907838;5036.7733451994745;4218.430511880857;4224.091820258659;4225.852095176654;4227;4244.893877653083;3696.1683621185557;3759.962400376016;3760.2855457463543;3787.337215987191;3804.0489877530617;4435.512093669694;4453.220686379936;4487.932681009787;4488.236999710057;4506.278995360726;4879.4388645305535;5036.823711170165;5084.9745751271;5180.637355385087;5219.347581552306;4426.535213802569;4437.023854751949;4443.244648409778;4451.198784218872;4476.552344765562;4522.479914809839;4539.5460453955;4547.295169248771;4566.794494247767;4591.334256532784;4676.438827340741;4734.692245004064;4757.524247575215;4776.426828780569;4784.521547845187;5014.07239660664;5047.4700156484505;5063.392392912874;5099.056674515226;5104.310918026019;4646.024334889711;4740.762961851962;4788.257820037899;4801.447833499053;4840.128776820206;4920.089783390084;4942.357493525818;4962.255661650781;4983.27742477346;4990.750462476789;4990.6506544541535;5056.74716264178;5082.415522214993;5083.2883396323805;5131.79472821083;4730.2431610942085;4889.584385327287;4922.680025798311;4929.112759703288;4976.8755781105765;4838.588719958843;4873.853784386474;4891.584215341736;4962.379702537183;5024.572911302434;4836.830710925101;4859.271109333628;4863.878403039811;4881.658283920092;4900.828471003498;4782.52174782519;4971.477994810492;4973.254011898244;4993.950060499348;4995.300657907968;4840.080384726891;4846.079244943449;4861.1006963711825;4879.975600121977;4882.511748825089 17:21:05 INFO - PROCESS | 4959 | |1;ext.html;540.4163503416311;599.7511032921337;601.1853937914126;611.1260896917406;625.7278084033443;35938.281234375296;39476;39612.207755844865;39739.60260397395;39784;39782.80108599453;40203.39694904579;40310;40328.19343613126;40393.19213615726;7833.37333013359;7956.562389068599;7960.7213747518845;7974.3221826144845;7975.561344126071;7762.30139287464;7773.611319434006;7817.960910195469;7822.413319001098;7844.254795794419;7850.568218747995;7870.134285228621;7896.763097107068;7901;7902.2097790220805;7862.371010319161;7892.250236227549;7897.328727058207;7898.170692077335;7921.524708517479;7929.326007289387;7949.761507154737;7985.800354991114;7985.880211796828;7989.081255655616;31074;37758.81120594407;37894.43158352627;38153.618463815284;38180;2900.7244311790346;3264.1023718477372;3299.983500082484;3721;3777.414500752388;28279.717202827913;30435.17344013746;30842.228944276347;30845.845770771004;30999.845000775076;3529.7176225901867;3541.9645803541894;3567.4827150063356;3636.654517820803;3653.178034942117;257130;263413;263462;263576;264294;60061.69969150214;60767.08849367263;60823.391766082656;60840.69579652073;60988;36907;37271.440928386095;37426;39295;65898;15470.922645386701;15596.298166582532;15611.3755449783;15659.843401566066;15668.68662626741;11745.647630571097;11863.88136118645;11876.465559049864;11877.88122118785;11880.108991825475;20564.691529627067;20761.792382075986;20781.792182077985;20809.479763006046;20931.581368372852;7711.334642541294;7717.215326497608;7889.566073865878;7988.281054705104;8102.541542522403;867.1588559097665;992.2855544008303;996.5067291690659;1001.5843424978552;1015.1675625986768;27777.722222777513;28619.14142575726;28864.71135288662;29388;29466.11601651954;1040.8334666453331;1080.470569420978;1097.6487523992405;1101.7576133250673;1113.8050841102774;15314.693706125816;15657.373705051898;15720.842791572166;15767.684646307009;15921.681566368608;386099;388223;389954;390705;390705;49756.50243497591;50668;50697.49302507001;51111;51248.23127653088;1276.8084787281796;1305.3081866610712;1310.541310541322;1310.6657802260363;1316.8551459339465;27560.17319480419;28023.159305220877;28282.85858570694;28616.14151575456;28964;44743.776281118386;44895.55104448914;45147.548524514335;45339.77330113328;45428.54571454243;306494;310894;312212;313484;314204;26637.733622663527;26743.732562674126;26919.05783297575;27001.459970800868;27019.594706079817;43179.68203179657;43350.78324608483;43535.34696979611;44378;44497;36800.63199368079;37229.81385093057;37397.43903841499;37851.432228516045;38026.239475210896;36145.45781813222;37675.62324376831;37696.811515942245;37772;38453.230935380576;31520.842395787873;36041.819790900874;36691.63308366882;36709;37027.44458833174;32405.675943240265;34302.48546271858;34448;34468.138296542784;34620.13449663779;25496.362590935376;25902.43660364205;26433.73566264313;26451.338716532242;26539.867300663373 17:21:05 INFO - PROCESS | 4959 | |2;jquery.html;376.26440309195516;376.7212262925435;384.9557300910394;398.9960100398995;400.0039900647389;15747.763783543242;17462.563435914108;17601.47195584133;17980.730289045674;18188.18153183105;17057.57356066099;17437.73843392347;17735.55661108473;17855.19651615677;17874.553136171602;5167.173252279646;5334.786608535654;5370.3287089113865;5388.137897936331;5397.62216644835;3627.3289441453417;5848.561357898154;6150.753969841201;6168.599041062316;6214.5649804513705;5991.580589358747;6114.113453549233;6203.038529028008;6231.968840155793;6240.344763799803;6052.425019623129;6149.0468977308365;6153.569250152491;6157.3534778848025;6170.796694644546;5368.248445217672;5419.810306639288;6051.788187413419;6482.67586620667;6517.837054073639;21055.5788884223;22311.888440557857;23059.88470057639;23696.881515592486;23957;2045.4068320187127;2056.362527616444;2172.8261739060836;2179.727534058243;2486.3784053986506;13438.798418023738;14148.221847798366;14630;14737.189454579993;15168.924155379264;1920.5198700324918;1954.5113721569608;1964.5285131568464;1968.7342208801915;1986.523234423728;82520.17479825184;83398.58300708518;83489.16510834875;84716;85286;15654.37382504687;16872.57818554546;17076.57308567271;17257.223424945907;17313.65372692539;29825.254368640522;29904.40191196164;30040.849795751317;30214.84892575567;30302.545461818092;8883.511406872683;9198.862017069749;9228.215601673934;9298.103774099693;9437.76405589852;7549.886751698729;7623.199564045806;7700;7717.459777815611;7934.047914250327;8444.944381952257;8455.365847561457;8688.652453901774;8829.779255518535;8879.24526415249;1464.8315443723895;1550.3488534815406;1584.429605342076;1595.5213435969163;1608.228050535726;877.4428238068872;1007.5264625625944;1011.1758916483043;1013.9695809125737;1046.199657262195;16872.746908796376;16944.91527542379;16980.49058528246;17100;17413;872.2455076358904;883.7127933421664;886.9778255543534;906.7370462565782;909.6497848328441;9309.674161404319;9401.153896149379;9414.717558473258;9612.615495380247;9692.9030709692;307116;311493;313844;435269;444053;78771;81711.59144204241;81787.5910620443;85732;86874;956.7225504603726;977.0424983516052;985.1527686189871;1008.3899240959261;1012.2054187462807;14862.702745944804;15163.620909477351;15178.31697573634;15234.847651523787;15600.765988510408;34134.487982680774;34406.65593344034;34670;34691.30617387689;35664.078056551385;47910.76044619754;50328.245076324616;50339.496605033484;50418.24372634487;50431;5439.912017596575;6627.3372662733345;7651;7688.730894418893;7763.61181940912;9764.755881103029;10733.677989660322;10890.128789696964;11123.610673626385;11314.15143864197;10114.004968037438;10293.845592316271;10439.843402348819;10494.632687856194;10504.632337868137;10126.594936202764;10158;10356.792864142826;10360.689179324632;10410.323328983895;10184.745381365525;10413.583456661649;10435.956404359504;10531.578736850746;10815;7743.303102720783;7752;7796.181400952818;7851.4111441643245;7933.920660793318;7816.218378162138;9201.86197207029;10147.137493313152;10336.544463921107;10351.327163734333 17:21:05 INFO - PROCESS | 4959 | |3;mootools.html;1501.2418728542084;1537.9077255364678;1704.3267909175877;1804.3143605429934;1858.3774435564094;6755.9662201688925;7310.780676579698;7452.441066919982;8004.039515258162;8006.719764808233;7358.558486490814;7469.4024478041765;7681;7687.654055567499;7718.922810771891;2244.3154837774514;2291.9541609167804;2302.5625131225097;2303.0327262549686;2305.101010605865;2236.9217077402295;2243.8204943604474;2262.7737226277404;2264.830137739668;2280.4070941555233;2182.15986845065;2191.4192738924116;2191.6712493126;2199.483121466454;2238.350878245307;2209.160519002785;2209.6575030870163;2220.6335954567476;2226.1318085946414;2233.095596283508;2209.624363858148;2220.200727738013;2225.1989283857797;2228.665700144975;2229.67669687896;7594.772156835304;7608.163102058769;7636.3890888728765;7636.50362726421;7680.270374314487;4500.189965806154;4624.791884365178;4634.281686338623;4647.326137710047;4662.044280922437;2834.3906060197155;2999;3041.406925649499;3057.052313782712;3063.7395821355212;968.3366893677783;985.2167526816198;985.5959056786683;989.342087511811;1009.5406590001531;10261.230407719377;10471.947640261826;10498.265121441425;10526.842097368546;10598.364098154136;4126.628603425706;4222.978885105616;4241.936370954438;4290.849820256276;4295.871123866289;9111.17999380059;9118.40730352525;9145.451272923647;9168.81662366749;9171.58727857248;4529.977350113229;4570.451545814457;4592.97703511487;4596.839110631112;4599.839005634787;3663.2673465307043;3913.62820532049;4022.6379625833815;4107.67138628909;4203.222403855236;3657.8719744808805;3706.592274849764;3806;3816.8282427290837;3826.5025546678753;1224.6938265433641;1231.5381731850557;1238.5479300055415;1241.3979220078254;1246.8254444377794;843.4812590256947;860.9569521523899;888.5690440136658;899.6896070855545;916.4592890194817;5374.381946076173;5383.569314454834;5447.754851031713;5493.2034854945805;5500.50495455411;934.5233930695258;938.9857762514009;944.6127087893931;977.8826540815147;984.9409035457895;3340.9665903341142;3748.5689145748042;3942.113024569449;3957.248122856648;4056.350983842571;9185;9805.558749856273;9816.067473589997;9921.50392480373;9928.900710992943;9700.611975521042;9719.222462203006;9752.804943901225;9806.558704858298;9816.803663926681;7030.402415794612;7317.414606831547;7394.223606521346;7402.29678180572;7407.185209627044;5455;5532.695701736443;5567.721613919207;5693.174489699053;5699.059655156852;8644.956775216084;8688.869666954874;8833.160849719523;8992.50541220213;9117.680881169128;8613.440126391764;8881.777955551162;9085.727428177166;9215.262778977532;9226.538673066185;5946.048632218824;6624.370684784938;6836.28219036994;6881.724731010904;7004.684789184397;7664.271894170045;7676.309132178131;7676.846463070596;7724.918511408295;7735.187805280365;6718.462522998246;6923.238443771081;6994.755183568551;7073.469489788389;7127.643617818984;6698.057563306586;6774.898376524257;6778.288279730557;6798;6908.689108990007;6109.816705498843;6330.778422755181;6333.524985626004;6377.17096777416;6378.107065010995;4501.189785838449;4624.630029597692;4660;4706;4770.856874293777;4701.318308845267;4771.761411929459;4779.545943135397;4862.635302352267;4906.8773280668265 17:21:05 INFO - PROCESS | 4959 | |4;prototype.html;312.6560783138548;314.7403392201434;316.0439669998255;320.626470162261;320.9181658677037;4853.70877747335;4900.456356247784;4948.352631342233;4956.6121485983895;4957.62817788666;4909.189983652693;4914.4348399934015;4915.311856340115;4919.606431485481;4959.181735013718;3637.418013117902;3755.7370984031127;3848.1149335652817;3869.496965394495;3887;3855.3445914194513;3855.8457661693496;3856.267309211241;3868.70984676149;3872.2642697887313;3843.9231215375817;3844.2503711776217;3854.63380978808;3859.517560304962;3878.5151856017997;3578.5526809148855;3775.4336849472525;3826.890201841463;3839.4240863870505;3852.901922951973;3308.553345298378;3320.020593924798;3330.733541316689;3331.6168640606156;3352.044667269841;4602.240630295997;4615.376924115235;4628.426335046101;4666.696664716783;4678.0410015946645;4297.419848320468;4332.371806088131;4344.717593356453;4360.4331436913;4376.803043863034;4981.7794640312995;5042.369703787027;5047.4447810740785;5064.645474816764;5083.74581270935;3605.675489205984;3629.89110326688;3636.254567813592;3662.212624285791;3692.2430901665093;5369.731513424314;5409.486098820645;5439.456054394568;5466.671999679992;5487.533559647435;3620.6741393274206;3656.0859785053735;3667.669909708139;3676.6028909014403;3743.9438408423894;3740.756850804689;3744.494493243432;3747.569029561581;3753.4557489163917;3796.9430458543143;4265.210935976854;4270.572942705705;4283.336082907154;4293.635041021485;4312.310030395184;4843.321934929113;5087.414947281036;5109.693418394908;5158;5212.367754284138;1283.4866053578644;1288.2528133682442;1293.2886912198442;1294.2169987157822;1297.4939773488347;818.7420962396826;851.9446235994641;872.8341615093112;885.7387070814125;893.2942975049768;4443.555644435531;4562.657800664963;4577.764003718978;4578.610818080434;4580.908381832344;5224.708433686753;5248.8425347239645;5294.364676238876;5317.7341132943975;5357.973210133924;4491.887702807456;4552.476465206478;4577.679562430598;4579.511658710866;4614.2617181250835;2710.3224193951514;2750.986245068762;2758.441480563475;2759.5170845102025;2763.3367991681853;4837.758112094381;4870.053617561395;4876.756162191876;4877.292792545061;4878.9022469943975;5171.689698618095;5278.2346559749385;5329.840104796862;5362.731863406814;5373.737171764632;4805.255185446262;4820.734859582757;4847.418309802846;4852.878678033077;4935.703857768545;5127.1540195867265;5146.356705411824;5152.76812543444;5161.019406312788;5187.559057480005;4852.636052296021;5055.360140698691;5088.643794934319;5090.643654944119;5253.527182553588;5029.471905450021;5031.000354717935;5041.218611115283;5044.293798868088;5053.292539044463;3699.7975657910747;3710.6474884885893;3737;3741.7754934704003;3745.3258413485833;5132.2814805926455;5300.840974770763;5321.5476684482255;5330.413654498079;5335.919961200662;5028.899422011466;5132.230165475208;5151.845444636667;5167.560757335668;5235.764390602356;5117.5394214520875;5152.948470515247;5166.070107380708;5168.3539557555305;5202.427732949448;4995.925061124159;5007.298978143136;5101.7194054327365;5109.6678715883345;5130.846074617767;4913.557779799835;5074.594032477319;5113.463086376026;5189.948100519097;5200.713960732196;5017;5077.289179514944;5079.974600126976;5088.389393272683;5113.207452844815 17:21:05 INFO - PROCESS | 4959 | |5;yui.html;747.4132805747489;752.0223709178067;778.4006315137344;799.3125911715925;837.5477242289164;14202;14578.854211457909;14690.412383504647;14713;14741.262936853169;14523.346449409775;14573.34419951102;14587.614176653227;14596.489122880701;14616.4884229052;677.9661016949133;840.8192238668685;868.695956415256;878.9516576588285;889.4618755652834;853.7268074216254;855.6106971328062;859.7807559072459;862.7411776467035;865.1996902864856;901.6483571407124;902.9683961061364;905.5155491811882;906.6282824042144;909.2453263791037;876.9561521923943;887.3877024852895;889.4129874282975;893.7452825944607;896.050186801992;658.7793089315085;660.4221306356937;664.5979182594509;665.6971078159474;665.8302132956065;12151.939240303831;12213.084018698633;12254.509819607294;12274.570390036306;12302.569410070693;12201.93899030508;12469.812952805714;12496.437660305308;12620.621381358575;12640.431180596803;9979.80040399188;10022.498875056219;10185.643502477378;10295.3822770634;10461.476926153739;3253.316803471274;3288.62180849203;3299.3236386540943;3306.553615261933;3326.7307120927103;43039.35440968357;43401.56598434007;43694;43925.78037109794;44066.779666101465;9429.339946203838;9645.758856028655;9712.320137590443;9739.853902191473;9916.057974492413;17094.40169594058;17128.486145415656;17268.481945541655;17436.564085897953;17461.65076698459;6516.380943810331;6580.605163690194;6648.5678430901835;6670.699818508178;6712.597244165366;3709.3137769512728;3732.664060234592;3735.6451137141926;3802.372608519563;3817.541894972621;2824.50571150052;2880.971190288112;2909.3017675757665;2989;2990.1926479850317;563.2677519225073;564.6160610784706;574.4198359656776;574.6408494690818;577.3245302995506;584.7339460545442;634.3878157577959;646.0986923242051;648.0469138256597;650.2164891305965;8121.959390203129;8466.872996905051;8583.914160858312;8672.826543469222;8673.6530538779;551.7489542258263;558.9441055894459;592.1768741449389;617.746723843231;643.4171937034946;3762.8682996095004;3878.3600705883778;3901.551321597996;3914.530256369197;3989.4414781930554;55775.44224557783;56441;56694.716526417105;56750.71624641933;57026;31502.84248578788;50764.49235507671;51529.742351288005;51691.22463163055;53193.73403132959;19104.8089519103;40798;47328.290075648896;47784.5221547787;47926.520734792204;7496.625168741432;7574.030752004629;7643.503172293783;7708.8458230836195;7943.324817390587;30244.54633180548;30827.383452330378;31001.534976974912;31055.534166987964;31785.523217152222;40655.59344406518;41776;41812.372814408416;41995.58004419917;42520;9756.365836220622;9962.302638815214;10278.588856445958;10521.947390263;10546.947265263625;10508.011057935451;10701.518431670438;10856.34861908288;10875.945620271848;10877.075448586958;10068.748281293027;10098;10170.745731356776;10207.234457415576;10236.539355729159;10477.287623890177;10532.473376331305;10619.840702389625;10722.678319650424;10830.783384332426;10014.799704006025;10491.94754026225;11475;11496.310221386744;11772.117091218364;8826.338024648048;9114.40756350835;9132.908670913206;9148.405353651991;9154.130357616015;9787.265955053257;10135.239857010607;10251.794964100825;10255.794884102426;10258.692239232834 17:21:05 INFO - PROCESS | 4959 | __end_tp_report 17:21:05 INFO - PROCESS | 4959 | __start_cc_report 17:21:05 INFO - PROCESS | 4959 | _x_x_mozilla_cycle_collect,387 17:21:05 INFO - PROCESS | 4959 | __end_cc_report 17:21:05 INFO - PROCESS | 4959 | __startTimestamp1462580465752__endTimestamp 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | ------- Summary: start ------- 17:21:05 INFO - PROCESS | 4959 | Number of tests: 6 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | [#0] dojo.html Cycles:165 Average:4669.33 Median:4788.26 stddev:476.74 (10.0%) stddev-sans-first:450.14 17:21:05 INFO - PROCESS | 4959 | Values: 2615.2 2661.8 2675.8 2680.4 2687.1 4687.6 4698.4 4731.3 4808.4 4851.4 4603.4 4739.4 4741.5 4761.5 4840.2 4332.7 4336.1 4387.5 4473.4 4496.3 4379.0 4493.8 4495.0 4522.8 4528.9 4241.5 4263.5 4355.9 4420.9 4435.6 4286.2 4288.3 4294.3 4310.6 4333.9 4291.5 4311.3 4315.7 4318.5 4347.0 4572.8 4599.2 4651.9 4668.0 4669.5 5027.4 5056.1 5056.5 5063.2 5132.2 5055.2 5087.0 5088.9 5098.8 5116.4 4657.5 4713.8 4714.5 4715.9 4724.1 5121.1 5134.7 5149.8 5150.5 5157.7 4811.0 4863.0 4937.6 4943.9 4988.0 4983.6 4995.8 5024.9 5039.0 5075.8 4778.9 4951.2 4966.7 4994.9 5025.6 4809.4 4868.8 4984.1 4985.6 5036.8 4218.4 4224.1 4225.9 4227.0 4244.9 3696.2 3760.0 3760.3 3787.3 3804.0 4435.5 4453.2 4487.9 4488.2 4506.3 4879.4 5036.8 5085.0 5180.6 5219.3 4426.5 4437.0 4443.2 4451.2 4476.6 4522.5 4539.5 4547.3 4566.8 4591.3 4676.4 4734.7 4757.5 4776.4 4784.5 5014.1 5047.5 5063.4 5099.1 5104.3 4646.0 4740.8 4788.3 4801.4 4840.1 4920.1 4942.4 4962.3 4983.3 4990.8 4990.7 5056.7 5082.4 5083.3 5131.8 4730.2 4889.6 4922.7 4929.1 4976.9 4838.6 4873.9 4891.6 4962.4 5024.6 4836.8 4859.3 4863.9 4881.7 4900.8 4782.5 4971.5 4973.3 4994.0 4995.3 4840.1 4846.1 4861.1 4880.0 4882.5 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | [#1] ext.html Cycles:180 Average:48045.39 Median:20475.41 stddev:85474.67 (417.5%) stddev-sans-first:85640.03 17:21:05 INFO - PROCESS | 4959 | Values: 540.4 599.8 601.2 611.1 625.7 35938.3 39476.0 39612.2 39739.6 39784.0 39782.8 40203.4 40310.0 40328.2 40393.2 7833.4 7956.6 7960.7 7974.3 7975.6 7762.3 7773.6 7818.0 7822.4 7844.3 7850.6 7870.1 7896.8 7901.0 7902.2 7862.4 7892.3 7897.3 7898.2 7921.5 7929.3 7949.8 7985.8 7985.9 7989.1 31074.0 37758.8 37894.4 38153.6 38180.0 2900.7 3264.1 3300.0 3721.0 3777.4 28279.7 30435.2 30842.2 30845.8 30999.8 3529.7 3542.0 3567.5 3636.7 3653.2 257130.0 263413.0 263462.0 263576.0 264294.0 60061.7 60767.1 60823.4 60840.7 60988.0 36907.0 37271.4 37426.0 39295.0 65898.0 15470.9 15596.3 15611.4 15659.8 15668.7 11745.6 11863.9 11876.5 11877.9 11880.1 20564.7 20761.8 20781.8 20809.5 20931.6 7711.3 7717.2 7889.6 7988.3 8102.5 867.2 992.3 996.5 1001.6 1015.2 27777.7 28619.1 28864.7 29388.0 29466.1 1040.8 1080.5 1097.6 1101.8 1113.8 15314.7 15657.4 15720.8 15767.7 15921.7 386099.0 388223.0 389954.0 390705.0 390705.0 49756.5 50668.0 50697.5 51111.0 51248.2 1276.8 1305.3 1310.5 1310.7 1316.9 27560.2 28023.2 28282.9 28616.1 28964.0 44743.8 44895.6 45147.5 45339.8 45428.5 306494.0 310894.0 312212.0 313484.0 314204.0 26637.7 26743.7 26919.1 27001.5 27019.6 43179.7 43350.8 43535.3 44378.0 44497.0 36800.6 37229.8 37397.4 37851.4 38026.2 36145.5 37675.6 37696.8 37772.0 38453.2 31520.8 36041.8 36691.6 36709.0 37027.4 32405.7 34302.5 34448.0 34468.1 34620.1 25496.4 25902.4 26433.7 26451.3 26539.9 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | [#2] jquery.html Cycles:180 Average:25131.59 Median:19645.70 stddev:61266.26 (311.9%) stddev-sans-first:61409.94 17:21:05 INFO - PROCESS | 4959 | Values: 376.3 376.7 385.0 399.0 400.0 15747.8 17462.6 17601.5 17980.7 18188.2 17057.6 17437.7 17735.6 17855.2 17874.6 5167.2 5334.8 5370.3 5388.1 5397.6 3627.3 5848.6 6150.8 6168.6 6214.6 5991.6 6114.1 6203.0 6232.0 6240.3 6052.4 6149.0 6153.6 6157.4 6170.8 5368.2 5419.8 6051.8 6482.7 6517.8 21055.6 22311.9 23059.9 23696.9 23957.0 2045.4 2056.4 2172.8 2179.7 2486.4 13438.8 14148.2 14630.0 14737.2 15168.9 1920.5 1954.5 1964.5 1968.7 1986.5 82520.2 83398.6 83489.2 84716.0 85286.0 15654.4 16872.6 17076.6 17257.2 17313.7 29825.3 29904.4 30040.8 30214.8 30302.5 8883.5 9198.9 9228.2 9298.1 9437.8 7549.9 7623.2 7700.0 7717.5 7934.0 8444.9 8455.4 8688.7 8829.8 8879.2 1464.8 1550.3 1584.4 1595.5 1608.2 877.4 1007.5 1011.2 1014.0 1046.2 16872.7 16944.9 16980.5 17100.0 17413.0 872.2 883.7 887.0 906.7 909.6 9309.7 9401.2 9414.7 9612.6 9692.9 307116.0 311493.0 313844.0 435269.0 444053.0 78771.0 81711.6 81787.6 85732.0 86874.0 956.7 977.0 985.2 1008.4 1012.2 14862.7 15163.6 15178.3 15234.8 15600.8 34134.5 34406.7 34670.0 34691.3 35664.1 47910.8 50328.2 50339.5 50418.2 50431.0 5439.9 6627.3 7651.0 7688.7 7763.6 9764.8 10733.7 10890.1 11123.6 11314.2 10114.0 10293.8 10439.8 10494.6 10504.6 10126.6 10158.0 10356.8 10360.7 10410.3 10184.7 10413.6 10436.0 10531.6 10815.0 7743.3 7752.0 7796.2 7851.4 7933.9 7816.2 9201.9 10147.1 10336.5 10351.3 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | [#3] mootools.html Cycles:180 Average:5189.31 Median:5496.85 stddev:2840.67 (51.7%) stddev-sans-first:2835.12 17:21:05 INFO - PROCESS | 4959 | Values: 1501.2 1537.9 1704.3 1804.3 1858.4 6756.0 7310.8 7452.4 8004.0 8006.7 7358.6 7469.4 7681.0 7687.7 7718.9 2244.3 2292.0 2302.6 2303.0 2305.1 2236.9 2243.8 2262.8 2264.8 2280.4 2182.2 2191.4 2191.7 2199.5 2238.4 2209.2 2209.7 2220.6 2226.1 2233.1 2209.6 2220.2 2225.2 2228.7 2229.7 7594.8 7608.2 7636.4 7636.5 7680.3 4500.2 4624.8 4634.3 4647.3 4662.0 2834.4 2999.0 3041.4 3057.1 3063.7 968.3 985.2 985.6 989.3 1009.5 10261.2 10471.9 10498.3 10526.8 10598.4 4126.6 4223.0 4241.9 4290.8 4295.9 9111.2 9118.4 9145.5 9168.8 9171.6 4530.0 4570.5 4593.0 4596.8 4599.8 3663.3 3913.6 4022.6 4107.7 4203.2 3657.9 3706.6 3806.0 3816.8 3826.5 1224.7 1231.5 1238.5 1241.4 1246.8 843.5 861.0 888.6 899.7 916.5 5374.4 5383.6 5447.8 5493.2 5500.5 934.5 939.0 944.6 977.9 984.9 3341.0 3748.6 3942.1 3957.2 4056.4 9185.0 9805.6 9816.1 9921.5 9928.9 9700.6 9719.2 9752.8 9806.6 9816.8 7030.4 7317.4 7394.2 7402.3 7407.2 5455.0 5532.7 5567.7 5693.2 5699.1 8645.0 8688.9 8833.2 8992.5 9117.7 8613.4 8881.8 9085.7 9215.3 9226.5 5946.0 6624.4 6836.3 6881.7 7004.7 7664.3 7676.3 7676.8 7724.9 7735.2 6718.5 6923.2 6994.8 7073.5 7127.6 6698.1 6774.9 6778.3 6798.0 6908.7 6109.8 6330.8 6333.5 6377.2 6378.1 4501.2 4624.6 4660.0 4706.0 4770.9 4701.3 4771.8 4779.5 4862.6 4906.9 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | [#4] prototype.html Cycles:180 Average:4245.44 Median:4852.76 stddev:1235.39 (25.5%) stddev-sans-first:1203.07 17:21:05 INFO - PROCESS | 4959 | Values: 312.7 314.7 316.0 320.6 320.9 4853.7 4900.5 4948.4 4956.6 4957.6 4909.2 4914.4 4915.3 4919.6 4959.2 3637.4 3755.7 3848.1 3869.5 3887.0 3855.3 3855.8 3856.3 3868.7 3872.3 3843.9 3844.3 3854.6 3859.5 3878.5 3578.6 3775.4 3826.9 3839.4 3852.9 3308.6 3320.0 3330.7 3331.6 3352.0 4602.2 4615.4 4628.4 4666.7 4678.0 4297.4 4332.4 4344.7 4360.4 4376.8 4981.8 5042.4 5047.4 5064.6 5083.7 3605.7 3629.9 3636.3 3662.2 3692.2 5369.7 5409.5 5439.5 5466.7 5487.5 3620.7 3656.1 3667.7 3676.6 3743.9 3740.8 3744.5 3747.6 3753.5 3796.9 4265.2 4270.6 4283.3 4293.6 4312.3 4843.3 5087.4 5109.7 5158.0 5212.4 1283.5 1288.3 1293.3 1294.2 1297.5 818.7 851.9 872.8 885.7 893.3 4443.6 4562.7 4577.8 4578.6 4580.9 5224.7 5248.8 5294.4 5317.7 5358.0 4491.9 4552.5 4577.7 4579.5 4614.3 2710.3 2751.0 2758.4 2759.5 2763.3 4837.8 4870.1 4876.8 4877.3 4878.9 5171.7 5278.2 5329.8 5362.7 5373.7 4805.3 4820.7 4847.4 4852.9 4935.7 5127.2 5146.4 5152.8 5161.0 5187.6 4852.6 5055.4 5088.6 5090.6 5253.5 5029.5 5031.0 5041.2 5044.3 5053.3 3699.8 3710.6 3737.0 3741.8 3745.3 5132.3 5300.8 5321.5 5330.4 5335.9 5028.9 5132.2 5151.8 5167.6 5235.8 5117.5 5152.9 5166.1 5168.4 5202.4 4995.9 5007.3 5101.7 5109.7 5130.8 4913.6 5074.6 5113.5 5189.9 5200.7 5017.0 5077.3 5080.0 5088.4 5113.2 17:21:05 INFO - PROCESS | 4959 | 17:21:05 INFO - PROCESS | 4959 | [#5] yui.html Cycles:180 Average:12991.48 Median:43547.78 stddev:14989.42 (34.4%) stddev-sans-first:15003.26 17:21:05 INFO - PROCESS | 4959 | Values: 747.4 752.0 778.4 799.3 837.5 14202.0 14578.9 14690.4 14713.0 14741.3 14523.3 14573.3 14587.6 14596.5 14616.5 678.0 840.8 868.7 879.0 889.5 853.7 855.6 859.8 862.7 865.2 901.6 903.0 905.5 906.6 909.2 877.0 887.4 889.4 893.7 896.1 658.8 660.4 664.6 665.7 665.8 12151.9 12213.1 12254.5 12274.6 12302.6 12201.9 12469.8 12496.4 12620.6 12640.4 9979.8 10022.5 10185.6 10295.4 10461.5 3253.3 3288.6 3299.3 3306.6 3326.7 43039.4 43401.6 43694.0 43925.8 44066.8 9429.3 9645.8 9712.3 9739.9 9916.1 17094.4 17128.5 17268.5 17436.6 17461.7 6516.4 6580.6 6648.6 6670.7 6712.6 3709.3 3732.7 3735.6 3802.4 3817.5 2824.5 2881.0 2909.3 2989.0 2990.2 563.3 564.6 574.4 574.6 577.3 584.7 634.4 646.1 648.0 650.2 8122.0 8466.9 8583.9 8672.8 8673.7 551.7 558.9 592.2 617.7 643.4 3762.9 3878.4 3901.6 3914.5 3989.4 55775.4 56441.0 56694.7 56750.7 57026.0 31502.8 50764.5 51529.7 51691.2 53193.7 19104.8 40798.0 47328.3 47784.5 47926.5 7496.6 7574.0 7643.5 7708.8 7943.3 30244.5 30827.4 31001.5 31055.5 31785.5 40655.6 41776.0 41812.4 41995.6 42520.0 9756.4 9962.3 10278.6 10521.9 10546.9 10508.0 10701.5 10856.3 10875.9 10877.1 10068.7 10098.0 10170.7 10207.2 10236.5 10477.3 10532.5 10619.8 10722.7 10830.8 10014.8 10491.9 11475.0 11496.3 11772.1 8826.3 9114.4 9132.9 9148.4 9154.1 9787.3 10135.2 10251.8 10255.8 10258.7 17:21:05 INFO - PROCESS | 4959 | -------- Summary: end -------- 17:21:05 INFO - PROCESS | 4959 | 17:21:06 INFO - TEST-INFO | 4959: exit 0 17:21:06 INFO - TEST-OK | dromaeo_css | took 1115213ms 17:21:06 INFO - TEST-START | kraken 17:21:06 INFO - operating with platform_type : linux_ 17:21:06 INFO - Initialising browser for kraken test... 17:21:06 INFO - TEST-INFO | started process 5197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwVRLhr/profile http://localhost:55548/getInfo.html) 17:21:10 INFO - PROCESS | 5197 | 17:21:10 INFO - PROCESS | 5197 | (process:5265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:21:10 INFO - PROCESS | 5197 | __metrics Screen width/height:1600/1200 17:21:10 INFO - PROCESS | 5197 | colorDepth:24 17:21:10 INFO - PROCESS | 5197 | Browser inner width/height: 1024/697 17:21:10 INFO - PROCESS | 5197 | __metrics 17:21:11 ERROR - PROCESS | 5197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:21:12 INFO - TEST-INFO | 5197: exit 0 17:21:12 INFO - Browser initialized. 17:21:12 INFO - Running cycle 1/1 for kraken test... 17:21:12 INFO - TEST-INFO | started process 5316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwVRLhr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:14 INFO - PROCESS | 5316 | 17:21:14 INFO - PROCESS | 5316 | (process:5377): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:21:24 INFO - PROCESS | 5316 | RSS: Main: 164859904 17:21:24 INFO - PROCESS | 5316 | 17:21:26 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55548/tests/kraken/driver.html?testName=audio-beat-detection) 17:21:27 INFO - PROCESS | 5316 | RSS: Main: 168804352 17:21:27 INFO - PROCESS | 5316 | 17:21:30 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55548/tests/kraken/driver.html?testName=audio-dft) 17:21:31 INFO - PROCESS | 5316 | RSS: Main: 168853504 17:21:31 INFO - PROCESS | 5316 | 17:21:34 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55548/tests/kraken/driver.html?testName=audio-fft) 17:21:34 INFO - PROCESS | 5316 | RSS: Main: 163803136 17:21:34 INFO - PROCESS | 5316 | 17:21:37 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55548/tests/kraken/driver.html?testName=audio-oscillator) 17:21:37 INFO - PROCESS | 5316 | RSS: Main: 164147200 17:21:37 INFO - PROCESS | 5316 | 17:21:40 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:21:40 INFO - PROCESS | 5316 | RSS: Main: 164978688 17:21:40 INFO - PROCESS | 5316 | 17:21:43 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55548/tests/kraken/driver.html?testName=imaging-darkroom) 17:21:44 INFO - PROCESS | 5316 | RSS: Main: 164753408 17:21:44 INFO - PROCESS | 5316 | 17:21:47 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55548/tests/kraken/driver.html?testName=imaging-desaturate) 17:21:48 INFO - PROCESS | 5316 | RSS: Main: 163360768 17:21:48 INFO - PROCESS | 5316 | 17:21:51 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55548/tests/kraken/driver.html?testName=json-parse-financial) 17:21:52 INFO - PROCESS | 5316 | RSS: Main: 163684352 17:21:52 INFO - PROCESS | 5316 | 17:21:53 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:21:54 INFO - PROCESS | 5316 | RSS: Main: 163790848 17:21:54 INFO - PROCESS | 5316 | 17:21:56 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:21:56 INFO - PROCESS | 5316 | RSS: Main: 164474880 17:21:56 INFO - PROCESS | 5316 | 17:21:59 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:21:59 INFO - PROCESS | 5316 | RSS: Main: 164081664 17:21:59 INFO - PROCESS | 5316 | 17:22:02 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:03 INFO - PROCESS | 5316 | RSS: Main: 164687872 17:22:03 INFO - PROCESS | 5316 | 17:22:06 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:06 INFO - PROCESS | 5316 | RSS: Main: 164978688 17:22:06 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:55548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55548/tests/kraken/driver.html?testName=ai-astar) 17:22:08 INFO - PROCESS | 5316 | RSS: Main: 166043648 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | __start_tp_report 17:22:08 INFO - PROCESS | 5316 | _x_x_mozilla_page_load 17:22:08 INFO - PROCESS | 5316 | _x_x_mozilla_page_load_details 17:22:08 INFO - PROCESS | 5316 | |i|pagename|runs| 17:22:08 INFO - PROCESS | 5316 | |0;ai-astar;115;117;107;119;115;115;109;115;115;115 17:22:08 INFO - PROCESS | 5316 | |1;audio-beat-detection;165;131;156;187;134;162;167;133;187;132 17:22:08 INFO - PROCESS | 5316 | |2;audio-dft;163;164;170;178;163;161;163;164;162;163 17:22:08 INFO - PROCESS | 5316 | |3;audio-fft;77;76;77;158;77;75;76;76;179;77 17:22:08 INFO - PROCESS | 5316 | |4;audio-oscillator;93;95;150;94;101;93;138;93;93;146 17:22:08 INFO - PROCESS | 5316 | |5;imaging-gaussian-blur;117;117;117;118;118;118;118;117;120;118 17:22:08 INFO - PROCESS | 5316 | |6;imaging-darkroom;148;150;148;148;147;147;148;147;147;148 17:22:08 INFO - PROCESS | 5316 | |7;imaging-desaturate;95;96;95;95;95;96;98;100;97;95 17:22:08 INFO - PROCESS | 5316 | |8;json-parse-financial;69;68;68;67;70;69;67;83;65;66 17:22:08 INFO - PROCESS | 5316 | |9;json-stringify-tinderbox;64;63;66;64;65;64;64;64;64;65 17:22:08 INFO - PROCESS | 5316 | |10;stanford-crypto-aes;87;87;85;83;84;83;84;87;89;85 17:22:08 INFO - PROCESS | 5316 | |11;stanford-crypto-ccm;155;135;135;151;138;138;133;134;219;141 17:22:08 INFO - PROCESS | 5316 | |12;stanford-crypto-pbkdf2;178;173;175;174;172;177;175;173;172;174 17:22:08 INFO - PROCESS | 5316 | |13;stanford-crypto-sha256-iterative;68;70;68;67;67;69;67;70;67;76 17:22:08 INFO - PROCESS | 5316 | __end_tp_report 17:22:08 INFO - PROCESS | 5316 | __start_cc_report 17:22:08 INFO - PROCESS | 5316 | _x_x_mozilla_cycle_collect,936 17:22:08 INFO - PROCESS | 5316 | __end_cc_report 17:22:08 INFO - PROCESS | 5316 | __startTimestamp1462580528902__endTimestamp 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | ------- Summary: start ------- 17:22:08 INFO - PROCESS | 5316 | Number of tests: 14 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:3.55 (3.1%) stddev-sans-first:3.76 17:22:08 INFO - PROCESS | 5316 | Values: 115.0 117.0 107.0 119.0 115.0 115.0 109.0 115.0 115.0 115.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:163.50 stddev:22.04 (13.5%) stddev-sans-first:23.10 17:22:08 INFO - PROCESS | 5316 | Values: 165.0 131.0 156.0 187.0 134.0 162.0 167.0 133.0 187.0 132.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#2] audio-dft Cycles:10 Average:165.10 Median:163.50 stddev:5.13 (3.1%) stddev-sans-first:5.39 17:22:08 INFO - PROCESS | 5316 | Values: 163.0 164.0 170.0 178.0 163.0 161.0 163.0 164.0 162.0 163.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.50 stddev:39.16 (51.2%) stddev-sans-first:41.01 17:22:08 INFO - PROCESS | 5316 | Values: 77.0 76.0 77.0 158.0 77.0 75.0 76.0 76.0 179.0 77.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:24.49 (26.3%) stddev-sans-first:25.22 17:22:08 INFO - PROCESS | 5316 | Values: 93.0 95.0 150.0 94.0 101.0 93.0 138.0 93.0 93.0 146.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 17:22:08 INFO - PROCESS | 5316 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 120.0 118.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:22:08 INFO - PROCESS | 5316 | Values: 148.0 150.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.50 stddev:1.69 (1.8%) stddev-sans-first:1.73 17:22:08 INFO - PROCESS | 5316 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 98.0 100.0 97.0 95.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:68.50 stddev:5.07 (7.4%) stddev-sans-first:5.38 17:22:08 INFO - PROCESS | 5316 | Values: 69.0 68.0 68.0 67.0 70.0 69.0 67.0 83.0 65.0 66.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 17:22:08 INFO - PROCESS | 5316 | Values: 64.0 63.0 66.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:2.01 (2.3%) stddev-sans-first:2.05 17:22:08 INFO - PROCESS | 5316 | Values: 87.0 87.0 85.0 83.0 84.0 83.0 84.0 87.0 89.0 85.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:139.50 stddev:26.05 (18.7%) stddev-sans-first:27.50 17:22:08 INFO - PROCESS | 5316 | Values: 155.0 135.0 135.0 151.0 138.0 138.0 133.0 134.0 219.0 141.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:2.00 (1.1%) stddev-sans-first:1.62 17:22:08 INFO - PROCESS | 5316 | Values: 178.0 173.0 175.0 174.0 172.0 177.0 175.0 173.0 172.0 174.0 17:22:08 INFO - PROCESS | 5316 | 17:22:08 INFO - PROCESS | 5316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.77 (4.0%) stddev-sans-first:2.92 17:22:08 INFO - PROCESS | 5316 | Values: 68.0 70.0 68.0 67.0 67.0 69.0 67.0 70.0 67.0 76.0 17:22:08 INFO - PROCESS | 5316 | -------- Summary: end -------- 17:22:08 INFO - PROCESS | 5316 | 17:22:09 INFO - TEST-INFO | 5316: exit 0 17:22:09 INFO - TEST-OK | kraken | took 63450ms 17:22:09 INFO - SUITE-END | took 1178s 17:22:10 INFO - Completed test suite (00:19:38) 17:22:10 INFO - javascript benchmark 17:22:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.1500762252267, 2661.760441560259, 2675.7725593324567, 2680.4103097318593, 2687.0998215597774, 4687.554682305184, 4698.412698412699, 4731.33761273422, 4808.350872632193, 4851.417829860422, 4603.3785438965815, 4739.4075740532435, 4741.5495527924795, 4761.47623761386, 4840.201366774478, 4332.740035597859, 4336.111097225069, 4387.517373088974, 4473.351364052211, 4496.348029535716, 4378.992831648723, 4493.752843593617, 4495.011097558532, 4522.819087236507, 4528.886777830564, 4241.4698162729655, 4263.509696384925, 4355.891102722426, 4420.8673739787855, 4435.645148388137, 4286.164197981395, 4288.31386978082, 4294.3343781713575, 4310.633596144332, 4333.9133217335475, 4291.506476755182, 4311.28863737483, 4315.654747620214, 4318.503372112216, 4347.043650396908, 4572.817087316504, 4599.218132917412, 4651.883702907455, 4668.019715859639, 4669.533046695304, 5027.371578552681, 5056.115179843513, 5056.469070747592, 5063.240513922904, 5132.204508301219, 5055.191169412913, 5086.974565127188, 5088.898222035576, 5098.770555325019, 5116.411612664554, 4657.4876763555985, 4713.7643117844655, 4714.481407045222, 4715.882102947454, 4724.126036683225, 5121.129408000649, 5134.666246693953, 5149.7940082397035, 5150.4849515048945, 5157.716325602053, 4811.037792441526, 4862.95137048632, 4937.604991600663, 4943.9258411123865, 4988.0, 4983.5763960063805, 4995.775190116454, 5024.874378140576, 5038.974805126024, 5075.771590278372, 4778.904421911542, 4951.232558953368, 4966.726830024383, 4994.850154495371, 5025.648204625714, 4809.44691360491, 4868.805247790119, 4984.077945580007, 4985.601151907838, 5036.7733451994745, 4218.430511880857, 4224.091820258659, 4225.852095176654, 4227.0, 4244.893877653083, 3696.1683621185557, 3759.962400376016, 3760.2855457463543, 3787.337215987191, 3804.0489877530617, 4435.512093669694, 4453.220686379936, 4487.932681009787, 4488.236999710057, 4506.278995360726, 4879.4388645305535, 5036.823711170165, 5084.9745751271, 5180.637355385087, 5219.347581552306, 4426.535213802569, 4437.023854751949, 4443.244648409778, 4451.198784218872, 4476.552344765562, 4522.479914809839, 4539.5460453955, 4547.295169248771, 4566.794494247767, 4591.334256532784, 4676.438827340741, 4734.692245004064, 4757.524247575215, 4776.426828780569, 4784.521547845187, 5014.07239660664, 5047.4700156484505, 5063.392392912874, 5099.056674515226, 5104.310918026019, 4646.024334889711, 4740.762961851962, 4788.257820037899, 4801.447833499053, 4840.128776820206, 4920.089783390084, 4942.357493525818, 4962.255661650781, 4983.27742477346, 4990.750462476789, 4990.6506544541535, 5056.74716264178, 5082.415522214993, 5083.2883396323805, 5131.79472821083, 4730.2431610942085, 4889.584385327287, 4922.680025798311, 4929.112759703288, 4976.8755781105765, 4838.588719958843, 4873.853784386474, 4891.584215341736, 4962.379702537183, 5024.572911302434, 4836.830710925101, 4859.271109333628, 4863.878403039811, 4881.658283920092, 4900.828471003498, 4782.52174782519, 4971.477994810492, 4973.254011898244, 4993.950060499348, 4995.300657907968, 4840.080384726891, 4846.079244943449, 4861.1006963711825, 4879.975600121977, 4882.511748825089], "value": 4639.702142347056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.4163503416311, 599.7511032921337, 601.1853937914126, 611.1260896917406, 625.7278084033443, 35938.281234375296, 39476.0, 39612.207755844865, 39739.60260397395, 39784.0, 39782.80108599453, 40203.39694904579, 40310.0, 40328.19343613126, 40393.19213615726, 7833.37333013359, 7956.562389068599, 7960.7213747518845, 7974.3221826144845, 7975.561344126071, 7762.30139287464, 7773.611319434006, 7817.960910195469, 7822.413319001098, 7844.254795794419, 7850.568218747995, 7870.134285228621, 7896.763097107068, 7901.0, 7902.2097790220805, 7862.371010319161, 7892.250236227549, 7897.328727058207, 7898.170692077335, 7921.524708517479, 7929.326007289387, 7949.761507154737, 7985.800354991114, 7985.880211796828, 7989.081255655616, 31074.0, 37758.81120594407, 37894.43158352627, 38153.618463815284, 38180.0, 2900.7244311790346, 3264.1023718477372, 3299.983500082484, 3721.0, 3777.414500752388, 28279.717202827913, 30435.17344013746, 30842.228944276347, 30845.845770771004, 30999.845000775076, 3529.7176225901867, 3541.9645803541894, 3567.4827150063356, 3636.654517820803, 3653.178034942117, 257130.0, 263413.0, 263462.0, 263576.0, 264294.0, 60061.69969150214, 60767.08849367263, 60823.391766082656, 60840.69579652073, 60988.0, 36907.0, 37271.440928386095, 37426.0, 39295.0, 65898.0, 15470.922645386701, 15596.298166582532, 15611.3755449783, 15659.843401566066, 15668.68662626741, 11745.647630571097, 11863.88136118645, 11876.465559049864, 11877.88122118785, 11880.108991825475, 20564.691529627067, 20761.792382075986, 20781.792182077985, 20809.479763006046, 20931.581368372852, 7711.334642541294, 7717.215326497608, 7889.566073865878, 7988.281054705104, 8102.541542522403, 867.1588559097665, 992.2855544008303, 996.5067291690659, 1001.5843424978552, 1015.1675625986768, 27777.722222777513, 28619.14142575726, 28864.71135288662, 29388.0, 29466.11601651954, 1040.8334666453331, 1080.470569420978, 1097.6487523992405, 1101.7576133250673, 1113.8050841102774, 15314.693706125816, 15657.373705051898, 15720.842791572166, 15767.684646307009, 15921.681566368608, 386099.0, 388223.0, 389954.0, 390705.0, 390705.0, 49756.50243497591, 50668.0, 50697.49302507001, 51111.0, 51248.23127653088, 1276.8084787281796, 1305.3081866610712, 1310.541310541322, 1310.6657802260363, 1316.8551459339465, 27560.17319480419, 28023.159305220877, 28282.85858570694, 28616.14151575456, 28964.0, 44743.776281118386, 44895.55104448914, 45147.548524514335, 45339.77330113328, 45428.54571454243, 306494.0, 310894.0, 312212.0, 313484.0, 314204.0, 26637.733622663527, 26743.732562674126, 26919.05783297575, 27001.459970800868, 27019.594706079817, 43179.68203179657, 43350.78324608483, 43535.34696979611, 44378.0, 44497.0, 36800.63199368079, 37229.81385093057, 37397.43903841499, 37851.432228516045, 38026.239475210896, 36145.45781813222, 37675.62324376831, 37696.811515942245, 37772.0, 38453.230935380576, 31520.842395787873, 36041.819790900874, 36691.63308366882, 36709.0, 37027.44458833174, 32405.675943240265, 34302.48546271858, 34448.0, 34468.138296542784, 34620.13449663779, 25496.362590935376, 25902.43660364205, 26433.73566264313, 26451.338716532242, 26539.867300663373], "value": 18148.663253641953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.26440309195516, 376.7212262925435, 384.9557300910394, 398.9960100398995, 400.0039900647389, 15747.763783543242, 17462.563435914108, 17601.47195584133, 17980.730289045674, 18188.18153183105, 17057.57356066099, 17437.73843392347, 17735.55661108473, 17855.19651615677, 17874.553136171602, 5167.173252279646, 5334.786608535654, 5370.3287089113865, 5388.137897936331, 5397.62216644835, 3627.3289441453417, 5848.561357898154, 6150.753969841201, 6168.599041062316, 6214.5649804513705, 5991.580589358747, 6114.113453549233, 6203.038529028008, 6231.968840155793, 6240.344763799803, 6052.425019623129, 6149.0468977308365, 6153.569250152491, 6157.3534778848025, 6170.796694644546, 5368.248445217672, 5419.810306639288, 6051.788187413419, 6482.67586620667, 6517.837054073639, 21055.5788884223, 22311.888440557857, 23059.88470057639, 23696.881515592486, 23957.0, 2045.4068320187127, 2056.362527616444, 2172.8261739060836, 2179.727534058243, 2486.3784053986506, 13438.798418023738, 14148.221847798366, 14630.0, 14737.189454579993, 15168.924155379264, 1920.5198700324918, 1954.5113721569608, 1964.5285131568464, 1968.7342208801915, 1986.523234423728, 82520.17479825184, 83398.58300708518, 83489.16510834875, 84716.0, 85286.0, 15654.37382504687, 16872.57818554546, 17076.57308567271, 17257.223424945907, 17313.65372692539, 29825.254368640522, 29904.40191196164, 30040.849795751317, 30214.84892575567, 30302.545461818092, 8883.511406872683, 9198.862017069749, 9228.215601673934, 9298.103774099693, 9437.76405589852, 7549.886751698729, 7623.199564045806, 7700.0, 7717.459777815611, 7934.047914250327, 8444.944381952257, 8455.365847561457, 8688.652453901774, 8829.779255518535, 8879.24526415249, 1464.8315443723895, 1550.3488534815406, 1584.429605342076, 1595.5213435969163, 1608.228050535726, 877.4428238068872, 1007.5264625625944, 1011.1758916483043, 1013.9695809125737, 1046.199657262195, 16872.746908796376, 16944.91527542379, 16980.49058528246, 17100.0, 17413.0, 872.2455076358904, 883.7127933421664, 886.9778255543534, 906.7370462565782, 909.6497848328441, 9309.674161404319, 9401.153896149379, 9414.717558473258, 9612.615495380247, 9692.9030709692, 307116.0, 311493.0, 313844.0, 435269.0, 444053.0, 78771.0, 81711.59144204241, 81787.5910620443, 85732.0, 86874.0, 956.7225504603726, 977.0424983516052, 985.1527686189871, 1008.3899240959261, 1012.2054187462807, 14862.702745944804, 15163.620909477351, 15178.31697573634, 15234.847651523787, 15600.765988510408, 34134.487982680774, 34406.65593344034, 34670.0, 34691.30617387689, 35664.078056551385, 47910.76044619754, 50328.245076324616, 50339.496605033484, 50418.24372634487, 50431.0, 5439.912017596575, 6627.3372662733345, 7651.0, 7688.730894418893, 7763.61181940912, 9764.755881103029, 10733.677989660322, 10890.128789696964, 11123.610673626385, 11314.15143864197, 10114.004968037438, 10293.845592316271, 10439.843402348819, 10494.632687856194, 10504.632337868137, 10126.594936202764, 10158.0, 10356.792864142826, 10360.689179324632, 10410.323328983895, 10184.745381365525, 10413.583456661649, 10435.956404359504, 10531.578736850746, 10815.0, 7743.303102720783, 7752.0, 7796.181400952818, 7851.4111441643245, 7933.920660793318, 7816.218378162138, 9201.86197207029, 10147.137493313152, 10336.544463921107, 10351.327163734333], "value": 9093.317781206226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.2418728542084, 1537.9077255364678, 1704.3267909175877, 1804.3143605429934, 1858.3774435564094, 6755.9662201688925, 7310.780676579698, 7452.441066919982, 8004.039515258162, 8006.719764808233, 7358.558486490814, 7469.4024478041765, 7681.0, 7687.654055567499, 7718.922810771891, 2244.3154837774514, 2291.9541609167804, 2302.5625131225097, 2303.0327262549686, 2305.101010605865, 2236.9217077402295, 2243.8204943604474, 2262.7737226277404, 2264.830137739668, 2280.4070941555233, 2182.15986845065, 2191.4192738924116, 2191.6712493126, 2199.483121466454, 2238.350878245307, 2209.160519002785, 2209.6575030870163, 2220.6335954567476, 2226.1318085946414, 2233.095596283508, 2209.624363858148, 2220.200727738013, 2225.1989283857797, 2228.665700144975, 2229.67669687896, 7594.772156835304, 7608.163102058769, 7636.3890888728765, 7636.50362726421, 7680.270374314487, 4500.189965806154, 4624.791884365178, 4634.281686338623, 4647.326137710047, 4662.044280922437, 2834.3906060197155, 2999.0, 3041.406925649499, 3057.052313782712, 3063.7395821355212, 968.3366893677783, 985.2167526816198, 985.5959056786683, 989.342087511811, 1009.5406590001531, 10261.230407719377, 10471.947640261826, 10498.265121441425, 10526.842097368546, 10598.364098154136, 4126.628603425706, 4222.978885105616, 4241.936370954438, 4290.849820256276, 4295.871123866289, 9111.17999380059, 9118.40730352525, 9145.451272923647, 9168.81662366749, 9171.58727857248, 4529.977350113229, 4570.451545814457, 4592.97703511487, 4596.839110631112, 4599.839005634787, 3663.2673465307043, 3913.62820532049, 4022.6379625833815, 4107.67138628909, 4203.222403855236, 3657.8719744808805, 3706.592274849764, 3806.0, 3816.8282427290837, 3826.5025546678753, 1224.6938265433641, 1231.5381731850557, 1238.5479300055415, 1241.3979220078254, 1246.8254444377794, 843.4812590256947, 860.9569521523899, 888.5690440136658, 899.6896070855545, 916.4592890194817, 5374.381946076173, 5383.569314454834, 5447.754851031713, 5493.2034854945805, 5500.50495455411, 934.5233930695258, 938.9857762514009, 944.6127087893931, 977.8826540815147, 984.9409035457895, 3340.9665903341142, 3748.5689145748042, 3942.113024569449, 3957.248122856648, 4056.350983842571, 9185.0, 9805.558749856273, 9816.067473589997, 9921.50392480373, 9928.900710992943, 9700.611975521042, 9719.222462203006, 9752.804943901225, 9806.558704858298, 9816.803663926681, 7030.402415794612, 7317.414606831547, 7394.223606521346, 7402.29678180572, 7407.185209627044, 5455.0, 5532.695701736443, 5567.721613919207, 5693.174489699053, 5699.059655156852, 8644.956775216084, 8688.869666954874, 8833.160849719523, 8992.50541220213, 9117.680881169128, 8613.440126391764, 8881.777955551162, 9085.727428177166, 9215.262778977532, 9226.538673066185, 5946.048632218824, 6624.370684784938, 6836.28219036994, 6881.724731010904, 7004.684789184397, 7664.271894170045, 7676.309132178131, 7676.846463070596, 7724.918511408295, 7735.187805280365, 6718.462522998246, 6923.238443771081, 6994.755183568551, 7073.469489788389, 7127.643617818984, 6698.057563306586, 6774.898376524257, 6778.288279730557, 6798.0, 6908.689108990007, 6109.816705498843, 6330.778422755181, 6333.524985626004, 6377.17096777416, 6378.107065010995, 4501.189785838449, 4624.630029597692, 4660.0, 4706.0, 4770.856874293777, 4701.318308845267, 4771.761411929459, 4779.545943135397, 4862.635302352267, 4906.8773280668265], "value": 4231.184030324799, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6560783138548, 314.7403392201434, 316.0439669998255, 320.626470162261, 320.9181658677037, 4853.70877747335, 4900.456356247784, 4948.352631342233, 4956.6121485983895, 4957.62817788666, 4909.189983652693, 4914.4348399934015, 4915.311856340115, 4919.606431485481, 4959.181735013718, 3637.418013117902, 3755.7370984031127, 3848.1149335652817, 3869.496965394495, 3887.0, 3855.3445914194513, 3855.8457661693496, 3856.267309211241, 3868.70984676149, 3872.2642697887313, 3843.9231215375817, 3844.2503711776217, 3854.63380978808, 3859.517560304962, 3878.5151856017997, 3578.5526809148855, 3775.4336849472525, 3826.890201841463, 3839.4240863870505, 3852.901922951973, 3308.553345298378, 3320.020593924798, 3330.733541316689, 3331.6168640606156, 3352.044667269841, 4602.240630295997, 4615.376924115235, 4628.426335046101, 4666.696664716783, 4678.0410015946645, 4297.419848320468, 4332.371806088131, 4344.717593356453, 4360.4331436913, 4376.803043863034, 4981.7794640312995, 5042.369703787027, 5047.4447810740785, 5064.645474816764, 5083.74581270935, 3605.675489205984, 3629.89110326688, 3636.254567813592, 3662.212624285791, 3692.2430901665093, 5369.731513424314, 5409.486098820645, 5439.456054394568, 5466.671999679992, 5487.533559647435, 3620.6741393274206, 3656.0859785053735, 3667.669909708139, 3676.6028909014403, 3743.9438408423894, 3740.756850804689, 3744.494493243432, 3747.569029561581, 3753.4557489163917, 3796.9430458543143, 4265.210935976854, 4270.572942705705, 4283.336082907154, 4293.635041021485, 4312.310030395184, 4843.321934929113, 5087.414947281036, 5109.693418394908, 5158.0, 5212.367754284138, 1283.4866053578644, 1288.2528133682442, 1293.2886912198442, 1294.2169987157822, 1297.4939773488347, 818.7420962396826, 851.9446235994641, 872.8341615093112, 885.7387070814125, 893.2942975049768, 4443.555644435531, 4562.657800664963, 4577.764003718978, 4578.610818080434, 4580.908381832344, 5224.708433686753, 5248.8425347239645, 5294.364676238876, 5317.7341132943975, 5357.973210133924, 4491.887702807456, 4552.476465206478, 4577.679562430598, 4579.511658710866, 4614.2617181250835, 2710.3224193951514, 2750.986245068762, 2758.441480563475, 2759.5170845102025, 2763.3367991681853, 4837.758112094381, 4870.053617561395, 4876.756162191876, 4877.292792545061, 4878.9022469943975, 5171.689698618095, 5278.2346559749385, 5329.840104796862, 5362.731863406814, 5373.737171764632, 4805.255185446262, 4820.734859582757, 4847.418309802846, 4852.878678033077, 4935.703857768545, 5127.1540195867265, 5146.356705411824, 5152.76812543444, 5161.019406312788, 5187.559057480005, 4852.636052296021, 5055.360140698691, 5088.643794934319, 5090.643654944119, 5253.527182553588, 5029.471905450021, 5031.000354717935, 5041.218611115283, 5044.293798868088, 5053.292539044463, 3699.7975657910747, 3710.6474884885893, 3737.0, 3741.7754934704003, 3745.3258413485833, 5132.2814805926455, 5300.840974770763, 5321.5476684482255, 5330.413654498079, 5335.919961200662, 5028.899422011466, 5132.230165475208, 5151.845444636667, 5167.560757335668, 5235.764390602356, 5117.5394214520875, 5152.948470515247, 5166.070107380708, 5168.3539557555305, 5202.427732949448, 4995.925061124159, 5007.298978143136, 5101.7194054327365, 5109.6678715883345, 5130.846074617767, 4913.557779799835, 5074.594032477319, 5113.463086376026, 5189.948100519097, 5200.713960732196, 5017.0, 5077.289179514944, 5079.974600126976, 5088.389393272683, 5113.207452844815], "value": 3856.0837575555115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.4132805747489, 752.0223709178067, 778.4006315137344, 799.3125911715925, 837.5477242289164, 14202.0, 14578.854211457909, 14690.412383504647, 14713.0, 14741.262936853169, 14523.346449409775, 14573.34419951102, 14587.614176653227, 14596.489122880701, 14616.4884229052, 677.9661016949133, 840.8192238668685, 868.695956415256, 878.9516576588285, 889.4618755652834, 853.7268074216254, 855.6106971328062, 859.7807559072459, 862.7411776467035, 865.1996902864856, 901.6483571407124, 902.9683961061364, 905.5155491811882, 906.6282824042144, 909.2453263791037, 876.9561521923943, 887.3877024852895, 889.4129874282975, 893.7452825944607, 896.050186801992, 658.7793089315085, 660.4221306356937, 664.5979182594509, 665.6971078159474, 665.8302132956065, 12151.939240303831, 12213.084018698633, 12254.509819607294, 12274.570390036306, 12302.569410070693, 12201.93899030508, 12469.812952805714, 12496.437660305308, 12620.621381358575, 12640.431180596803, 9979.80040399188, 10022.498875056219, 10185.643502477378, 10295.3822770634, 10461.476926153739, 3253.316803471274, 3288.62180849203, 3299.3236386540943, 3306.553615261933, 3326.7307120927103, 43039.35440968357, 43401.56598434007, 43694.0, 43925.78037109794, 44066.779666101465, 9429.339946203838, 9645.758856028655, 9712.320137590443, 9739.853902191473, 9916.057974492413, 17094.40169594058, 17128.486145415656, 17268.481945541655, 17436.564085897953, 17461.65076698459, 6516.380943810331, 6580.605163690194, 6648.5678430901835, 6670.699818508178, 6712.597244165366, 3709.3137769512728, 3732.664060234592, 3735.6451137141926, 3802.372608519563, 3817.541894972621, 2824.50571150052, 2880.971190288112, 2909.3017675757665, 2989.0, 2990.1926479850317, 563.2677519225073, 564.6160610784706, 574.4198359656776, 574.6408494690818, 577.3245302995506, 584.7339460545442, 634.3878157577959, 646.0986923242051, 648.0469138256597, 650.2164891305965, 8121.959390203129, 8466.872996905051, 8583.914160858312, 8672.826543469222, 8673.6530538779, 551.7489542258263, 558.9441055894459, 592.1768741449389, 617.746723843231, 643.4171937034946, 3762.8682996095004, 3878.3600705883778, 3901.551321597996, 3914.530256369197, 3989.4414781930554, 55775.44224557783, 56441.0, 56694.716526417105, 56750.71624641933, 57026.0, 31502.84248578788, 50764.49235507671, 51529.742351288005, 51691.22463163055, 53193.73403132959, 19104.8089519103, 40798.0, 47328.290075648896, 47784.5221547787, 47926.520734792204, 7496.625168741432, 7574.030752004629, 7643.503172293783, 7708.8458230836195, 7943.324817390587, 30244.54633180548, 30827.383452330378, 31001.534976974912, 31055.534166987964, 31785.523217152222, 40655.59344406518, 41776.0, 41812.372814408416, 41995.58004419917, 42520.0, 9756.365836220622, 9962.302638815214, 10278.588856445958, 10521.947390263, 10546.947265263625, 10508.011057935451, 10701.518431670438, 10856.34861908288, 10875.945620271848, 10877.075448586958, 10068.748281293027, 10098.0, 10170.745731356776, 10207.234457415576, 10236.539355729159, 10477.287623890177, 10532.473376331305, 10619.840702389625, 10722.678319650424, 10830.783384332426, 10014.799704006025, 10491.94754026225, 11475.0, 11496.310221386744, 11772.117091218364, 8826.338024648048, 9114.40756350835, 9132.908670913206, 9148.405353651991, 9154.130357616015, 9787.265955053257, 10135.239857010607, 10251.794964100825, 10255.794884102426, 10258.692239232834], "value": 6075.893416894163, "unit": "score"}], "name": "dromaeo_css", "value": 6507.10579520936, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 107.0, 119.0, 115.0, 115.0, 109.0, 115.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 156.0, 187.0, 134.0, 162.0, 167.0, 133.0, 187.0, 132.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 170.0, 178.0, 163.0, 161.0, 163.0, 164.0, 162.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 158.0, 77.0, 75.0, 76.0, 76.0, 179.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 150.0, 94.0, 101.0, 93.0, 138.0, 93.0, 93.0, 146.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 98.0, 100.0, 97.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 67.0, 70.0, 69.0, 67.0, 83.0, 65.0, 66.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 83.0, 84.0, 83.0, 84.0, 87.0, 89.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 135.0, 151.0, 138.0, 138.0, 133.0, 134.0, 219.0, 141.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 175.0, 174.0, 172.0, 177.0, 175.0, 173.0, 172.0, 174.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 67.0, 67.0, 69.0, 67.0, 70.0, 67.0, 76.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1610.9000000000003, "alertThreshold": 2.0}]} 17:22:10 INFO - Return code: 0 17:22:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:22:10 ERROR - # TBPL SUCCESS # 17:22:10 INFO - Running post-action listener: _resource_record_post_action 17:22:10 INFO - ##### 17:22:10 INFO - ##### Finished run-tests step (success) 17:22:10 INFO - ##### 17:22:10 INFO - Running post-run listener: _resource_record_post_run 17:22:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 526303232; Read time: 0; Write time: 402764 17:22:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 241836032; Read time: 0; Write time: 198376 17:22:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 284467200; Read time: 0; Write time: 204388 17:22:11 INFO - Running post-run listener: _upload_blobber_files 17:22:11 INFO - Blob upload gear active. 17:22:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:11 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 17:22:11 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:22:11 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:22:11 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:12 INFO - (blobuploader) - INFO - Done attempting. 17:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:13 INFO - (blobuploader) - INFO - Done attempting. 17:22:13 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:13 INFO - Return code: 0 17:22:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5df21e1f0a23d1499e50c87dff3d26c1be750402633a95cae11108b0e8fa55e869213b62b43690117f12f33ae74184d8ffc5c6bf97df2cfa86ef595165738c82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/251983fed7d99fbf05612f63c746c2288a2127b248620750321c4ced17565187382b31c9bf5aa70b9342ed03ea85dcb7120fd292fcd54720bfac318f0128e5e9"} 17:22:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:13 INFO - Contents: 17:22:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5df21e1f0a23d1499e50c87dff3d26c1be750402633a95cae11108b0e8fa55e869213b62b43690117f12f33ae74184d8ffc5c6bf97df2cfa86ef595165738c82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/251983fed7d99fbf05612f63c746c2288a2127b248620750321c4ced17565187382b31c9bf5aa70b9342ed03ea85dcb7120fd292fcd54720bfac318f0128e5e9"} 17:22:13 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:13 INFO - Copying logs to upload dir... 17:22:13 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.202487 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-06 17:22:12.504112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 17:22:12.508101) ========= 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=3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366 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/Firefox-Non-PGO/sha512/5df21e1f0a23d1499e50c87dff3d26c1be750402633a95cae11108b0e8fa55e869213b62b43690117f12f33ae74184d8ffc5c6bf97df2cfa86ef595165738c82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/251983fed7d99fbf05612f63c746c2288a2127b248620750321c4ced17565187382b31c9bf5aa70b9342ed03ea85dcb7120fd292fcd54720bfac318f0128e5e9"} build_url:https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/JjhOa2XoT2KF7siqhoyAsg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5df21e1f0a23d1499e50c87dff3d26c1be750402633a95cae11108b0e8fa55e869213b62b43690117f12f33ae74184d8ffc5c6bf97df2cfa86ef595165738c82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/251983fed7d99fbf05612f63c746c2288a2127b248620750321c4ced17565187382b31c9bf5aa70b9342ed03ea85dcb7120fd292fcd54720bfac318f0128e5e9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 17:22:12.533864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:22:12.534249) ========= 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=3a3620fb28aea1604ab609ef000001d2-1462579207.754041-1804042366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:22:12.616613) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 17:22:12.616980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 17:22:12.617334) ========= ========= Total master_lag: 0.15 =========