builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1468591065.72 results: success (0) buildid: 20160714105543 builduid: aa8f78178def422782ab8d456f54c137 revision: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:45.717582) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:45.718023) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:45.718358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:45.800582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:45.800921) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 06:57:45-- 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% 14.2M=0.001s 2016-07-15 06:57:46 (14.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.229214 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:46.066061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:46.066573) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.141727 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:46.220369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:46.220718) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4087792d5fa736a0dc18df7aeefecf0a34d99f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4087792d5fa736a0dc18df7aeefecf0a34d99f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 06:57:46,268 truncating revision to first 12 chars 2016-07-15 06:57:46,268 Setting DEBUG logging. 2016-07-15 06:57:46,268 attempt 1/10 2016-07-15 06:57:46,268 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0b4087792d5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 06:57:46,740 unpacking tar archive at: mozilla-beta-0b4087792d5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.809218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:47.043062) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:47.043466) ========= script_repo_revision: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:47.043914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:47.044177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:47.053870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-15 06:57:47.054318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:47 INFO - MultiFileLogger online at 20160715 06:57:47 in /builds/slave/test 06:57:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:57:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:47 INFO - {'append_to_log': False, 06:57:47 INFO - 'base_work_dir': '/builds/slave/test', 06:57:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:57:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:47 INFO - 'branch': 'Mozilla-Beta', 06:57:47 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:47 INFO - 'config_files': ('talos/linux_config.py',), 06:57:47 INFO - 'default_actions': ('clobber', 06:57:47 INFO - 'read-buildbot-config', 06:57:47 INFO - 'download-and-extract', 06:57:47 INFO - 'populate-webroot', 06:57:47 INFO - 'create-virtualenv', 06:57:47 INFO - 'install', 06:57:47 INFO - 'run-tests'), 06:57:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:47 INFO - 'download_minidump_stackwalk': True, 06:57:47 INFO - 'download_symbols': 'ondemand', 06:57:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:47 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:47 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:47 INFO - 'installer_path': 'installer.exe', 06:57:47 INFO - 'log_level': 'info', 06:57:47 INFO - 'log_name': 'talos', 06:57:47 INFO - 'log_to_console': True, 06:57:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:47 INFO - 'opt_config_files': (), 06:57:47 INFO - 'pip_index': False, 06:57:47 INFO - 'sps_profile': False, 06:57:47 INFO - 'sps_profile_interval': 0, 06:57:47 INFO - 'suite': 'dromaeojs', 06:57:47 INFO - 'system_bits': '32', 06:57:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:47 INFO - 'title': 'talos-linux64-ix-064', 06:57:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:47 INFO - 'use_talos_json': True, 06:57:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:47 INFO - 'work_dir': 'build'} 06:57:47 INFO - ##### 06:57:47 INFO - ##### Running clobber step. 06:57:47 INFO - ##### 06:57:47 INFO - Running pre-action listener: _resource_record_pre_action 06:57:47 INFO - Running main action method: clobber 06:57:47 INFO - rmtree: /builds/slave/test/build 06:57:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:52 INFO - Running post-action listener: _resource_record_post_action 06:57:52 INFO - ##### 06:57:52 INFO - ##### Running read-buildbot-config step. 06:57:52 INFO - ##### 06:57:52 INFO - Running pre-action listener: _resource_record_pre_action 06:57:52 INFO - Running main action method: read_buildbot_config 06:57:52 INFO - Using buildbot properties: 06:57:52 INFO - { 06:57:52 INFO - "project": "", 06:57:52 INFO - "product": "firefox", 06:57:52 INFO - "script_repo_revision": "production", 06:57:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:57:52 INFO - "repository": "", 06:57:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:57:52 INFO - "buildid": "20160714105543", 06:57:52 INFO - "pgo_build": "True", 06:57:52 INFO - "basedir": "/builds/slave/test", 06:57:52 INFO - "buildnumber": 106, 06:57:52 INFO - "slavename": "talos-linux64-ix-064", 06:57:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:57:52 INFO - "platform": "ubuntu64_hw", 06:57:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:57:52 INFO - "branch": "mozilla-beta", 06:57:52 INFO - "repo_path": "releases/mozilla-beta", 06:57:52 INFO - "revision": "0b4087792d5fa736a0dc18df7aeefecf0a34d99f", 06:57:52 INFO - "stage_platform": "linux64-pgo", 06:57:52 INFO - "builduid": "aa8f78178def422782ab8d456f54c137", 06:57:52 INFO - "slavebuilddir": "test" 06:57:52 INFO - } 06:57:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:57:52 INFO - Running post-action listener: _resource_record_post_action 06:57:52 INFO - ##### 06:57:52 INFO - ##### Running download-and-extract step. 06:57:52 INFO - ##### 06:57:52 INFO - Running pre-action listener: _resource_record_pre_action 06:57:52 INFO - Running main action method: download_and_extract 06:57:52 INFO - mkdir: /builds/slave/test/build/tests 06:57: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')]} 06:57:52 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:57:53 INFO - Downloaded 1327 bytes. 06:57:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:53 INFO - Using the following test package requirements: 06:57:53 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:57:53 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:53 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:57:53 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'jsshell-linux-x86_64.zip'], 06:57:53 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:53 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:57:53 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:57:53 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:57:53 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:53 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:53 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:53 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:55 INFO - Downloaded 24199700 bytes. 06:57:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:57 INFO - Return code: 0 06:57:57 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:57 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:59 INFO - Downloaded 24199700 bytes. 06:57:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:58:00 INFO - Return code: 0 06:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:00 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:58:01 INFO - Downloaded 10840145 bytes. 06:58:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:58:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:58:01 INFO - Return code: 0 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:58:03 INFO - Downloaded 56036779 bytes. 06:58:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:03 INFO - mkdir: /builds/slave/test/properties 06:58:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:03 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:03 INFO - Contents: 06:58:03 INFO - build_url:https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:03 INFO - Running post-action listener: _resource_record_post_action 06:58:03 INFO - Running post-action listener: set_extra_try_arguments 06:58:03 INFO - ##### 06:58:03 INFO - ##### Running populate-webroot step. 06:58:03 INFO - ##### 06:58:03 INFO - Running pre-action listener: _resource_record_pre_action 06:58:03 INFO - Running main action method: populate_webroot 06:58:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:03 INFO - '--tppagecycles', 06:58:03 INFO - '7'], 06:58:03 INFO - 'tests': ['tsvgm']}}, 06:58:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['damp', 'tps']}, 06:58:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'tests': ['damp', 'tps']}, 06:58:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['dromaeo_dom']}, 06:58:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['a11yr', 06:58:03 INFO - 'ts_paint', 06:58:03 INFO - 'tpaint', 06:58:03 INFO - 'sessionrestore', 06:58:03 INFO - 'sessionrestore_no_auto_restore', 06:58:03 INFO - 'tabpaint']}, 06:58:03 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:03 INFO - 'ts_paint', 06:58:03 INFO - 'tpaint', 06:58:03 INFO - 'sessionrestore', 06:58:03 INFO - 'sessionrestore_no_auto_restore', 06:58:03 INFO - 'tabpaint']}, 06:58:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:03 INFO - 'ts_paint', 06:58:03 INFO - 'tpaint', 06:58:03 INFO - 'sessionrestore', 06:58:03 INFO - 'sessionrestore_no_auto_restore', 06:58:03 INFO - 'tabpaint']}, 06:58:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:03 INFO - 'ts_paint', 06:58:03 INFO - 'tpaint', 06:58:03 INFO - 'sessionrestore', 06:58:03 INFO - 'sessionrestore_no_auto_restore', 06:58:03 INFO - 'tabpaint']}, 06:58:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['a11yr', 06:58:03 INFO - 'ts_paint', 06:58:03 INFO - 'tpaint', 06:58:03 INFO - 'sessionrestore', 06:58:03 INFO - 'sessionrestore_no_auto_restore', 06:58:03 INFO - 'tabpaint']}, 06:58:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['a11yr', 06:58:03 INFO - 'ts_paint', 06:58:03 INFO - 'tpaint', 06:58:03 INFO - 'sessionrestore', 06:58:03 INFO - 'sessionrestore_no_auto_restore', 06:58:03 INFO - 'tabpaint']}, 06:58:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['tsvgx', 06:58:03 INFO - 'tsvgr_opacity', 06:58:03 INFO - 'tart', 06:58:03 INFO - 'tscrollx', 06:58:03 INFO - 'cart']}, 06:58:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:03 INFO - 'tsvgr_opacity', 06:58:03 INFO - 'tart', 06:58:03 INFO - 'tscrollx', 06:58:03 INFO - 'cart']}, 06:58:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'talos_options': ['--disable-e10s'], 06:58:03 INFO - 'tests': ['tp5o']}, 06:58:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'tests': ['tp5o']}, 06:58:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'talos_options': ['--disable-e10s', 06:58:03 INFO - '--xperf_path', 06:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:03 INFO - 'tests': ['tp5n']}, 06:58:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:03 INFO - 'talos_options': ['--xperf_path', 06:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:03 INFO - 'tests': ['tp5n']}}, 06:58:03 INFO - 'talos.zip': {'path': '', 06:58:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:03 INFO - Running post-action listener: _resource_record_post_action 06:58:03 INFO - ##### 06:58:03 INFO - ##### Running create-virtualenv step. 06:58:03 INFO - ##### 06:58:03 INFO - Running pre-action listener: _resource_record_pre_action 06:58:03 INFO - Running main action method: create_virtualenv 06:58:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:58:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:04 INFO - Using real prefix '/usr' 06:58:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:04 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:06 INFO - Installing pip.................done. 06:58:06 INFO - Return code: 0 06:58:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:06 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:58:06 INFO - Using env: {'DISPLAY': ':0', 06:58:06 INFO - 'HOME': '/home/cltbld', 06:58:06 INFO - 'LANG': 'en_US.UTF-8', 06:58:06 INFO - 'LANGUAGE': 'en_US:en', 06:58:06 INFO - 'LOGNAME': 'cltbld', 06:58:06 INFO - 'MAIL': '/var/mail/cltbld', 06:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:06 INFO - 'MOZ_NO_REMOTE': '1', 06:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:06 INFO - 'NO_EM_RESTART': '1', 06:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:06 INFO - 'PWD': '/builds/slave/test', 06:58:06 INFO - 'SHELL': '/bin/bash', 06:58:06 INFO - 'SHLVL': '1', 06:58:06 INFO - 'TERM': 'linux', 06:58:06 INFO - 'TMOUT': '86400', 06:58:06 INFO - 'USER': 'cltbld', 06:58:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:06 INFO - '_': '/tools/buildbot/bin/python'} 06:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:58:06 INFO - Cleaning up... 06:58:06 INFO - Return code: 0 06:58:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:06 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:58:06 INFO - Using env: {'DISPLAY': ':0', 06:58:06 INFO - 'HOME': '/home/cltbld', 06:58:06 INFO - 'LANG': 'en_US.UTF-8', 06:58:06 INFO - 'LANGUAGE': 'en_US:en', 06:58:06 INFO - 'LOGNAME': 'cltbld', 06:58:06 INFO - 'MAIL': '/var/mail/cltbld', 06:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:06 INFO - 'MOZ_NO_REMOTE': '1', 06:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:06 INFO - 'NO_EM_RESTART': '1', 06:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:06 INFO - 'PWD': '/builds/slave/test', 06:58:06 INFO - 'SHELL': '/bin/bash', 06:58:06 INFO - 'SHLVL': '1', 06:58:06 INFO - 'TERM': 'linux', 06:58:06 INFO - 'TMOUT': '86400', 06:58:06 INFO - 'USER': 'cltbld', 06:58:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:06 INFO - '_': '/tools/buildbot/bin/python'} 06:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:07 INFO - Downloading/unpacking psutil>=0.7.1 06:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:09 INFO - Installing collected packages: psutil 06:58:09 INFO - Running setup.py install for psutil 06:58:09 INFO - building 'psutil._psutil_linux' extension 06:58:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:58:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:58:10 INFO - building 'psutil._psutil_posix' extension 06:58:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:58:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:58:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:10 INFO - Successfully installed psutil 06:58:10 INFO - Cleaning up... 06:58:10 INFO - Return code: 0 06:58:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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', '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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:58: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 mozsystemmonitor==0.0.0 06:58:10 INFO - Using env: {'DISPLAY': ':0', 06:58:10 INFO - 'HOME': '/home/cltbld', 06:58:10 INFO - 'LANG': 'en_US.UTF-8', 06:58:10 INFO - 'LANGUAGE': 'en_US:en', 06:58:10 INFO - 'LOGNAME': 'cltbld', 06:58:10 INFO - 'MAIL': '/var/mail/cltbld', 06:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:10 INFO - 'MOZ_NO_REMOTE': '1', 06:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:10 INFO - 'NO_EM_RESTART': '1', 06:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:10 INFO - 'PWD': '/builds/slave/test', 06:58:10 INFO - 'SHELL': '/bin/bash', 06:58:10 INFO - 'SHLVL': '1', 06:58:10 INFO - 'TERM': 'linux', 06:58:10 INFO - 'TMOUT': '86400', 06:58:10 INFO - 'USER': 'cltbld', 06:58:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:10 INFO - '_': '/tools/buildbot/bin/python'} 06:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:58:12 INFO - Installing collected packages: mozsystemmonitor 06:58:12 INFO - Running setup.py install for mozsystemmonitor 06:58:13 INFO - Successfully installed mozsystemmonitor 06:58:13 INFO - Cleaning up... 06:58:13 INFO - Return code: 0 06:58:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:13 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:58:13 INFO - Using env: {'DISPLAY': ':0', 06:58:13 INFO - 'HOME': '/home/cltbld', 06:58:13 INFO - 'LANG': 'en_US.UTF-8', 06:58:13 INFO - 'LANGUAGE': 'en_US:en', 06:58:13 INFO - 'LOGNAME': 'cltbld', 06:58:13 INFO - 'MAIL': '/var/mail/cltbld', 06:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:13 INFO - 'MOZ_NO_REMOTE': '1', 06:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:13 INFO - 'NO_EM_RESTART': '1', 06:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:13 INFO - 'PWD': '/builds/slave/test', 06:58:13 INFO - 'SHELL': '/bin/bash', 06:58:13 INFO - 'SHLVL': '1', 06:58:13 INFO - 'TERM': 'linux', 06:58:13 INFO - 'TMOUT': '86400', 06:58:13 INFO - 'USER': 'cltbld', 06:58:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:13 INFO - '_': '/tools/buildbot/bin/python'} 06:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:15 INFO - Downloading docopt-0.6.1.tar.gz 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:16 INFO - Running setup.py install for blobuploader 06:58:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:16 INFO - Running setup.py install for requests 06:58:16 INFO - Running setup.py install for docopt 06:58:16 INFO - Successfully installed blobuploader requests docopt 06:58:16 INFO - Cleaning up... 06:58:16 INFO - Return code: 0 06:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:58:16 INFO - Using env: {'DISPLAY': ':0', 06:58:16 INFO - 'HOME': '/home/cltbld', 06:58:16 INFO - 'LANG': 'en_US.UTF-8', 06:58:16 INFO - 'LANGUAGE': 'en_US:en', 06:58:16 INFO - 'LOGNAME': 'cltbld', 06:58:16 INFO - 'MAIL': '/var/mail/cltbld', 06:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:16 INFO - 'MOZ_NO_REMOTE': '1', 06:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:16 INFO - 'NO_EM_RESTART': '1', 06:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:16 INFO - 'PWD': '/builds/slave/test', 06:58:16 INFO - 'SHELL': '/bin/bash', 06:58:16 INFO - 'SHLVL': '1', 06:58:16 INFO - 'TERM': 'linux', 06:58:16 INFO - 'TMOUT': '86400', 06:58:16 INFO - 'USER': 'cltbld', 06:58:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:16 INFO - '_': '/tools/buildbot/bin/python'} 06:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:16 INFO - Running setup.py (path:/tmp/pip-uzyO22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:16 INFO - Running setup.py (path:/tmp/pip-46htIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:16 INFO - Running setup.py (path:/tmp/pip-R7Zb_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:17 INFO - Running setup.py (path:/tmp/pip-X3vfIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:17 INFO - Running setup.py (path:/tmp/pip-OPSSql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:17 INFO - Running setup.py (path:/tmp/pip-ui39sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:17 INFO - Running setup.py (path:/tmp/pip-1z2WhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:17 INFO - Running setup.py (path:/tmp/pip-8Sq9tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:17 INFO - Running setup.py (path:/tmp/pip-PdnaeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:17 INFO - Running setup.py (path:/tmp/pip-Rkc5sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:17 INFO - Running setup.py (path:/tmp/pip-rMba8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:17 INFO - Running setup.py (path:/tmp/pip-3DvbBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:17 INFO - Running setup.py (path:/tmp/pip-z6Zxzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:17 INFO - Running setup.py (path:/tmp/pip-A_0QdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:17 INFO - Running setup.py (path:/tmp/pip-jvtcVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:17 INFO - Running setup.py (path:/tmp/pip-w8iPwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:17 INFO - Running setup.py (path:/tmp/pip-diu2EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:18 INFO - Running setup.py install for manifestparser 06:58:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozcrash 06:58:18 INFO - Running setup.py install for mozdebug 06:58:18 INFO - Running setup.py install for mozdevice 06:58:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozfile 06:58:18 INFO - Running setup.py install for mozhttpd 06:58:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozinfo 06:58:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozInstall 06:58:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozleak 06:58:18 INFO - Running setup.py install for mozlog 06:58:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for moznetwork 06:58:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for mozprocess 06:58:19 INFO - Running setup.py install for mozprofile 06:58:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for mozrunner 06:58:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for mozscreenshot 06:58:19 INFO - Running setup.py install for moztest 06:58:19 INFO - Running setup.py install for mozversion 06:58:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:19 INFO - Cleaning up... 06:58:19 INFO - Return code: 0 06:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:19 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:58:19 INFO - Using env: {'DISPLAY': ':0', 06:58:19 INFO - 'HOME': '/home/cltbld', 06:58:19 INFO - 'LANG': 'en_US.UTF-8', 06:58:19 INFO - 'LANGUAGE': 'en_US:en', 06:58:19 INFO - 'LOGNAME': 'cltbld', 06:58:19 INFO - 'MAIL': '/var/mail/cltbld', 06:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:19 INFO - 'MOZ_NO_REMOTE': '1', 06:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:19 INFO - 'NO_EM_RESTART': '1', 06:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:19 INFO - 'PWD': '/builds/slave/test', 06:58:19 INFO - 'SHELL': '/bin/bash', 06:58:19 INFO - 'SHLVL': '1', 06:58:19 INFO - 'TERM': 'linux', 06:58:19 INFO - 'TMOUT': '86400', 06:58:19 INFO - 'USER': 'cltbld', 06:58:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:19 INFO - '_': '/tools/buildbot/bin/python'} 06:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:20 INFO - Running setup.py (path:/tmp/pip-oPHQLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:20 INFO - Running setup.py (path:/tmp/pip-61G3Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:20 INFO - Running setup.py (path:/tmp/pip-rLq4nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:20 INFO - Running setup.py (path:/tmp/pip-_JJwy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:20 INFO - Running setup.py (path:/tmp/pip-ZRaKlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:20 INFO - Running setup.py (path:/tmp/pip-F4hmdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:20 INFO - Running setup.py (path:/tmp/pip-5xnD32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:20 INFO - Running setup.py (path:/tmp/pip-KkJz9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:20 INFO - Running setup.py (path:/tmp/pip-nFU_MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:20 INFO - Running setup.py (path:/tmp/pip-JtzN5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:20 INFO - Running setup.py (path:/tmp/pip-bclgSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:20 INFO - Running setup.py (path:/tmp/pip-agMykD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:20 INFO - Running setup.py (path:/tmp/pip-pjwUmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:20 INFO - Running setup.py (path:/tmp/pip-RKsRFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:21 INFO - Running setup.py (path:/tmp/pip-oTFUde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:21 INFO - Running setup.py (path:/tmp/pip-583LvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:21 INFO - Running setup.py (path:/tmp/pip-FLbot9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - Downloading blessings-1.6.tar.gz 06:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:23 INFO - Installing collected packages: blessings 06:58:23 INFO - Running setup.py install for blessings 06:58:23 INFO - Successfully installed blessings 06:58:23 INFO - Cleaning up... 06:58:23 INFO - Return code: 0 06:58:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:23 INFO - Reading from file tmpfile_stdout 06:58:23 INFO - Current package versions: 06:58:23 INFO - argparse == 1.2.1 06:58:23 INFO - blessings == 1.6 06:58:23 INFO - blobuploader == 1.2.4 06:58:23 INFO - docopt == 0.6.1 06:58:23 INFO - manifestparser == 1.1 06:58:23 INFO - mozInstall == 1.12 06:58:23 INFO - mozcrash == 0.17 06:58:23 INFO - mozdebug == 0.1 06:58:23 INFO - mozdevice == 0.48 06:58:23 INFO - mozfile == 1.2 06:58:23 INFO - mozhttpd == 0.7 06:58:23 INFO - mozinfo == 0.9 06:58:23 INFO - mozleak == 0.1 06:58:23 INFO - mozlog == 3.1 06:58:23 INFO - moznetwork == 0.27 06:58:23 INFO - mozprocess == 0.22 06:58:23 INFO - mozprofile == 0.28 06:58:23 INFO - mozrunner == 6.11 06:58:23 INFO - mozscreenshot == 0.1 06:58:23 INFO - mozsystemmonitor == 0.0 06:58:23 INFO - moztest == 0.7 06:58:23 INFO - mozversion == 1.4 06:58:23 INFO - psutil == 3.1.1 06:58:23 INFO - requests == 1.2.3 06:58:23 INFO - wsgiref == 0.1.2 06:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:58:23 INFO - Using env: {'DISPLAY': ':0', 06:58:23 INFO - 'HOME': '/home/cltbld', 06:58:23 INFO - 'LANG': 'en_US.UTF-8', 06:58:23 INFO - 'LANGUAGE': 'en_US:en', 06:58:23 INFO - 'LOGNAME': 'cltbld', 06:58:23 INFO - 'MAIL': '/var/mail/cltbld', 06:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:23 INFO - 'MOZ_NO_REMOTE': '1', 06:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:23 INFO - 'NO_EM_RESTART': '1', 06:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:23 INFO - 'PWD': '/builds/slave/test', 06:58:23 INFO - 'SHELL': '/bin/bash', 06:58:23 INFO - 'SHLVL': '1', 06:58:23 INFO - 'TERM': 'linux', 06:58:23 INFO - 'TMOUT': '86400', 06:58:23 INFO - 'USER': 'cltbld', 06:58:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:23 INFO - '_': '/tools/buildbot/bin/python'} 06:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:58:23 INFO - Cleaning up... 06:58:23 INFO - Return code: 0 06:58:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:58:23 INFO - Using env: {'DISPLAY': ':0', 06:58:23 INFO - 'HOME': '/home/cltbld', 06:58:23 INFO - 'LANG': 'en_US.UTF-8', 06:58:23 INFO - 'LANGUAGE': 'en_US:en', 06:58:23 INFO - 'LOGNAME': 'cltbld', 06:58:23 INFO - 'MAIL': '/var/mail/cltbld', 06:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:23 INFO - 'MOZ_NO_REMOTE': '1', 06:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:23 INFO - 'NO_EM_RESTART': '1', 06:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:23 INFO - 'PWD': '/builds/slave/test', 06:58:23 INFO - 'SHELL': '/bin/bash', 06:58:23 INFO - 'SHLVL': '1', 06:58:23 INFO - 'TERM': 'linux', 06:58:23 INFO - 'TMOUT': '86400', 06:58:23 INFO - 'USER': 'cltbld', 06:58:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:23 INFO - '_': '/tools/buildbot/bin/python'} 06:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:24 INFO - Downloading/unpacking jsonschema 06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:26 INFO - Downloading/unpacking functools32 (from jsonschema) 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:26 INFO - warning: no files found matching '*.txt' 06:58:26 INFO - no previously-included directories found matching 'build' 06:58:26 INFO - no previously-included directories found matching 'dist' 06:58:26 INFO - no previously-included directories found matching '.git*' 06:58:26 INFO - Installing collected packages: jsonschema, functools32 06:58:26 INFO - Running setup.py install for functools32 06:58:26 INFO - warning: no files found matching '*.txt' 06:58:26 INFO - no previously-included directories found matching 'build' 06:58:26 INFO - no previously-included directories found matching 'dist' 06:58:26 INFO - no previously-included directories found matching '.git*' 06:58:26 INFO - Successfully installed jsonschema functools32 06:58:26 INFO - Cleaning up... 06:58:26 INFO - Return code: 0 06:58:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:26 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 0x7f1d7d7d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:58:26 INFO - Using env: {'DISPLAY': ':0', 06:58:26 INFO - 'HOME': '/home/cltbld', 06:58:26 INFO - 'LANG': 'en_US.UTF-8', 06:58:26 INFO - 'LANGUAGE': 'en_US:en', 06:58:26 INFO - 'LOGNAME': 'cltbld', 06:58:26 INFO - 'MAIL': '/var/mail/cltbld', 06:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:26 INFO - 'MOZ_NO_REMOTE': '1', 06:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:26 INFO - 'NO_EM_RESTART': '1', 06:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:26 INFO - 'PWD': '/builds/slave/test', 06:58:26 INFO - 'SHELL': '/bin/bash', 06:58:26 INFO - 'SHLVL': '1', 06:58:26 INFO - 'TERM': 'linux', 06:58:26 INFO - 'TMOUT': '86400', 06:58:26 INFO - 'USER': 'cltbld', 06:58:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:26 INFO - '_': '/tools/buildbot/bin/python'} 06:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:26 INFO - Downloading/unpacking flake8 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:58:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:58:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:29 INFO - no previously-included directories found matching 'docs/_build' 06:58:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:58:29 INFO - Running setup.py install for pep8 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:29 INFO - no previously-included directories found matching 'docs/_build' 06:58:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:58:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:58:29 INFO - Cleaning up... 06:58:29 INFO - Return code: 0 06:58:29 INFO - Running post-action listener: _resource_record_post_action 06:58:29 INFO - Running post-action listener: _start_resource_monitoring 06:58:29 INFO - Starting resource monitoring. 06:58:29 INFO - ##### 06:58:29 INFO - ##### Running install step. 06:58:29 INFO - ##### 06:58:29 INFO - Running pre-action listener: _resource_record_pre_action 06:58:29 INFO - Running main action method: install 06:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:29 INFO - Reading from file tmpfile_stdout 06:58:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:29 INFO - Reading from file tmpfile_stdout 06:58:29 INFO - Output received: 06:58:29 INFO - Usage: mozinstall [options] installer 06:58:29 INFO - Options: 06:58:29 INFO - -h, --help show this help message and exit 06:58:29 INFO - -d DEST, --destination=DEST 06:58:29 INFO - Directory to install application into. [default: 06:58:29 INFO - "/builds/slave/test"] 06:58:29 INFO - --app=APP Application being installed. [default: firefox] 06:58:29 INFO - mkdir: /builds/slave/test/build/application 06:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:58:43 INFO - Reading from file tmpfile_stdout 06:58:43 INFO - Output received: 06:58:43 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:43 INFO - Running post-action listener: _resource_record_post_action 06:58:43 INFO - ##### 06:58:43 INFO - ##### Running run-tests step. 06:58:43 INFO - ##### 06:58:43 INFO - Running pre-action listener: _resource_record_pre_action 06:58:43 INFO - Running main action method: run_tests 06:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:43 INFO - Python 2.7.3 06:58:43 INFO - Return code: 0 06:58:43 INFO - grabbing minidump binary from tooltool 06:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:43 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 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:58:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:58:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:43 INFO - Return code: 0 06:58:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:58:44 INFO - Return code: 0 06:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:58:44 INFO - Using env: {'DISPLAY': ':0', 06:58:44 INFO - 'HOME': '/home/cltbld', 06:58:44 INFO - 'LANG': 'en_US.UTF-8', 06:58:44 INFO - 'LANGUAGE': 'en_US:en', 06:58:44 INFO - 'LOGNAME': 'cltbld', 06:58:44 INFO - 'MAIL': '/var/mail/cltbld', 06:58:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:44 INFO - 'MOZ_NO_REMOTE': '1', 06:58:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:44 INFO - 'NO_EM_RESTART': '1', 06:58:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:44 INFO - 'PWD': '/builds/slave/test', 06:58:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:44 INFO - 'SHELL': '/bin/bash', 06:58:44 INFO - 'SHLVL': '1', 06:58:44 INFO - 'TERM': 'linux', 06:58:44 INFO - 'TMOUT': '86400', 06:58:44 INFO - 'USER': 'cltbld', 06:58:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744', 06:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:44 INFO - '_': '/tools/buildbot/bin/python'} 06:58:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:58:44 INFO - mozversion application_buildid: 20160714105543 06:58:44 INFO - mozversion application_changeset: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f 06:58:44 INFO - mozversion application_display_name: Firefox 06:58:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:44 INFO - mozversion application_name: Firefox 06:58:44 INFO - mozversion application_remotingname: firefox 06:58:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:58:44 INFO - mozversion application_vendor: Mozilla 06:58:44 INFO - mozversion application_version: 48.0 06:58:44 INFO - mozversion platform_buildid: 20160714105543 06:58:44 INFO - mozversion platform_changeset: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f 06:58:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:58:44 INFO - mozversion platform_version: 48.0 06:58:44 INFO - using testdate: 1468591124 06:58:44 INFO - actual date: 1468591124 06:58:44 INFO - starting webserver on 'localhost:45519' 06:58:44 INFO - SUITE-START | Running 2 tests 06:58:44 INFO - TEST-START | dromaeo_css 06:58:44 INFO - operating with platform_type : linux_ 06:58:44 INFO - Initialising browser for dromaeo_css test... 06:58:44 INFO - TEST-INFO | started process 3331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYGiPJ/profile http://localhost:45519/getInfo.html) 06:58:50 INFO - PROCESS | 3331 | __metrics Screen width/height:1600/1200 06:58:50 INFO - PROCESS | 3331 | colorDepth:24 06:58:50 INFO - PROCESS | 3331 | Browser inner width/height: 1024/697 06:58:50 INFO - PROCESS | 3331 | __metrics 06:58:51 INFO - PROCESS | 3331 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:58:51 ERROR - PROCESS | 3331 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:58:51 INFO - TEST-INFO | 3331: exit 0 06:58:51 INFO - Browser initialized. 06:58:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:51 INFO - TEST-INFO | started process 3424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYGiPJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:03 INFO - PROCESS | 3424 | RSS: Main: 139448320 06:59:03 INFO - PROCESS | 3424 | 06:59:54 INFO - PROCESS | 3424 | 1468591194559 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] 07:02:02 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:45519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45519/tests/dromaeo/cssquery-ext.html) 07:02:03 INFO - PROCESS | 3424 | RSS: Main: 248197120 07:02:03 INFO - PROCESS | 3424 | 07:05:05 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:45519/tests/dromaeo/cssquery-ext.html (next: http://localhost:45519/tests/dromaeo/cssquery-jquery.html) 07:05:05 INFO - PROCESS | 3424 | RSS: Main: 224325632 07:05:05 INFO - PROCESS | 3424 | 07:08:07 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:45519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45519/tests/dromaeo/cssquery-mootools.html) 07:08:08 INFO - PROCESS | 3424 | RSS: Main: 213651456 07:08:08 INFO - PROCESS | 3424 | 07:11:10 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:45519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45519/tests/dromaeo/cssquery-prototype.html) 07:11:10 INFO - PROCESS | 3424 | RSS: Main: 217911296 07:11:10 INFO - PROCESS | 3424 | 07:14:13 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:45519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45519/tests/dromaeo/cssquery-yui.html) 07:14:13 INFO - PROCESS | 3424 | RSS: Main: 210616320 07:14:13 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:45519/tests/dromaeo/cssquery-yui.html (next: http://localhost:45519/tests/dromaeo/cssquery-dojo.html) 07:17:16 INFO - PROCESS | 3424 | RSS: Main: 252555264 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | __start_tp_report 07:17:16 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 07:17:16 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 07:17:16 INFO - PROCESS | 3424 | |i|pagename|runs| 07:17:16 INFO - PROCESS | 3424 | |0;dojo.html;3275.541424200612;3334.333133373326;3336.316055208684;3341.1146046297727;3375.358681850448;5420.349558053034;5436;5449.264349312842;5453.15476101204;5458.372287186975;5430.67415955043;5437.728113594324;5475.425080366564;5485.341758988917;5513.9448605514035;4899.216125419934;5002.849914502571;5032.924506132411;5077.898442031157;5107.540321371076;4887.1447496688115;4966.701997880121;5003.4246061702825;5018.272350509193;5027.698338099707;4952.281919121725;5012.949870501285;5021.899562008758;5040.143175660147;5084.084864724348;4969.676970996874;4994.250862370655;4997.475265097149;4999.625028122905;5013.949860501385;4885.511448855122;4890.339804126433;4913.926291105637;4952.430470495903;4963.305137280783;5293.497117773805;5347.0909945309395;5368.30212072432;5374.113271310229;5394.217838413408;5813.128030795372;5822.272215973004;5833.270841144857;5834.241548598698;5835.912461313083;5804.361520232771;5845.941540584582;5860.706964651793;5875.823725288248;5916.674582897939;5390.110631745757;5432.837014889559;5433.293671822637;5438.048341540254;5442.91835622466;5734.283214598176;5899.46904778572;5907.645541267538;5908.911366329508;5942.940570594325;5678.5741069419955;5731.426857314235;5738.11059285803;5761.164631128463;5784.595078344475;5822.039363504974;5828.504577110993;5835.44563266489;5838.4745372915795;5840.1531777892815;5601.467860553241;5655.688937108416;5788.305403351625;5796;5804.651720896675;5758.395368486333;5775.220345253337;5781.797637082682;5788.044972579477;5823.213866128019;4435.379046933432;4446.933296000562;4447.510773814878;4455.1757924784015;4472.44094488189;3949.8420063197723;3958.7228893977144;4007.639312461834;4022.8591999279884;4045.838166473367;5446;5469.288992431038;5499.450054994469;5500.367457742331;5558.027345214571;5836.766529338779;5837.708114594253;5842.182094506772;5845.88308233833;5851.297844258716;5409.594280428983;5507.917381239285;5549.056660367747;5550.611457197957;5580.107182850806;4959.330490383824;5002.349694539686;5002.449730529639;5004.549590536869;5026.095302845523;6048.304444988883;6052.606580572248;6058.515318774487;6065.969670151621;6084.969575152184;5696.629719068247;5798.855028624318;5807.419258074159;5890.175375447527;5893.616914900518;6029.879402412015;6035.396460354105;6038.12447195163;6038.4867286279405;6043.697815109315;5679.6876171810945;5722.969865424264;5730.885382292414;5733.369329373682;5738.110592858114;5741.45456181662;5753.1945527627;5820.068788993741;5846.386129456346;5853.473187413153;5661.235733175969;5670.5180059695385;5676.148577713211;5677.545796336366;5683.914741278967;5477.507024367826;5666.263385759825;5675.971620141873;5678.14827775837;5682.772689092555;5568.136938774496;5619.606627536034;5629.043062679272;5654.038813401649;5656.321241451053;5670.262865827416;5689.260396148474;5700.800471983461;5703.828885133453;5707.743151558107;5513.255710479194;5564.582656300875;5574.749136288796;5583.106702927512;5587.664740115606 07:17:16 INFO - PROCESS | 3424 | |1;ext.html;659.6503852957934;676.6379986707107;693.6358411833787;721.8375865430279;745.7986343687203;31540.842295788516;39442.40836387453;39762.8011859941;39802.40296395553;39826.60173398265;42463.15073698524;43147.568524314745;43173;43198.78400608;43269.35095973563;7748.690052397926;8630.223279904807;8798.6920457784;8802.779930501725;10154.89845101547;10180.083792458678;10319.793604127914;10321.225908056887;10321.225908056926;10327.741806454824;10562.419066951315;10693.251472396936;10696.251262411633;10699.732506687316;10704.946475267652;10565.101966332872;10615.256932014761;10643.042126208678;10645.467726613715;10647.201459890463;10436.112930400925;10660.893391066067;10669;10673.679789606324;10677.305975111592;43993.78003109996;44527.55472445299;44563.55436445659;44575.10849782986;44617.77691111524;4026.4362989181536;4061.5938406159444;4148.854790082363;4328.61042506176;4579.084183163381;33312.3337533248;33758.49362259568;33823.32353352944;35141.64858351409;35324.82337588296;4556.908861822778;4574.451065872084;4619.099275641252;4620.075984803019;4640.443146822369;339003;339393;339497;340411;341503;38888.22223555513;60549.69725151434;61573.69213153906;61654.383456165764;61660.69169654123;37506.249875002344;37919.62080379161;37957;37968.43047354292;37999.810000949816;15505.379784808707;16847.241874115694;17072.829271707124;17086.743698844526;17088.401905933482;13708;13825.446982120804;13860.029797914049;13868.722625547432;13882.583522494342;9009.324300677476;9079.45523268606;9084.137006984325;9119.316051296179;9160.404573702821;3505.789652620851;3555.6266592007983;3565.4830049642655;3570.946435803465;3629.1108678373967;1107.3687997841314;1108.6286094158547;1115.0864639236765;1160.6634076118;1206.2280140709952;33053.66946330554;33632.663673363444;33888.40841261164;33902.49146262808;34967.12582185466;1186.9465874035689;1228.1157566552247;1241.5175432910771;1323.8940884729197;1338.444545513601;17013.149342532823;17112.48662540126;17292.308307667554;17342.219600118024;17763.20065597051;491702;494430;496170;498391;498883;60197;61289.08066379008;61325.38674613286;61352;61495.69252153711;1299.3178581244922;1514.3109885002298;1528.9311980961106;1594.8883578149419;1597.752348386002;29806.850965745034;30562.235944101576;30936.53595196119;31527.684723153394;31624.841875790473;44027;44171.77914110409;44665;44744.55255447404;44752.32871506865;257013;257526;257619;258062;259374;27083.322916927234;49351.50648493469;49384;49415.50584494109;49712.25431618601;49786.50213497819;50114.49885501244;50136;51022.23466647929;51138.23292650688;39996.40005399863;40513;40887;41695.37456938209;44214;40209.79895100506;40629.796851015555;41009.58990410177;41016.384754228115;42237.78881105575;42706.145877082905;42984.78507607442;43626;43901.780491098616;44055.11889762123;37204.81397593103;37782;38036;38052.42921356126;38382.42426363551;28427.573586395807;30193.547096793125;30631.846840765655;31183.376332473676;32483.512747308338 07:17:16 INFO - PROCESS | 3424 | |2;jquery.html;416.5875782974855;421.9957800421995;423.57430782064023;429.4202826184651;432.33204698740445;12904.54834080805;18300.633987320263;18991.62016759664;19000.809991900078;19195.23219071239;14057.507987220424;18204.726929096076;18538.907305463454;18851.811481885175;19038.90480547595;5622.044252477079;5816.709164541777;5825.8252252432285;5852.385499522531;5873.588848780587;5744.368119506851;5871.031279838821;5883.411658834125;5884.558658100638;5885.85285367865;5556.361018482886;5832.6792026438525;5854;5860.560457965648;5861.384554621767;5779.971100144472;5813.128030795372;5831.271091113611;5853.034249348873;5855;5171.250168725552;5234.7120908350025;5240;5243.842684719464;5253.4221235664045;22524;22886.42783930415;23127.653085203736;23222;23226.65160022601;2610.738926107393;2654.615080813271;2658.3752818087733;2866.125831621355;2889;14106.365213565414;14991.250437478191;15193.392264309414;15223.086614803147;15333.463328783551;2054.5685406064745;2064.9380518584467;2086.874787512754;2125.27740568206;2182.3671135370723;78714;79458;80245.59877200636;81322;81429.18570814276;10287.948560257151;10439.634612788515;10720.35677859331;10805.621803236849;10896.237263391646;15212;15291.158986255641;15303;15319.770203446735;15335.846641533664;8398.286145677686;8429.157084291523;8736.08271131522;8885.644574216958;9045.592948317342;7965.243301886311;8072.112067672669;8105.959470202612;8106.797330066795;8220.671173153127;5888.735006924699;6584.333622076476;6679.56582822115;6790.864182716318;6842.144731908512;1813.3200049981258;1863.6552237836045;1881.9153138108818;1916.4633902507321;1967.5081229692578;1032.9535170917327;1093.786711591248;1129.2264798612975;1159.252282277926;1176.8940795328463;18619.627607448045;18846.905765471085;18912;18952.24191032343;19302.806971930382;1060.984085238722;1078.1159449251538;1118.8433619293305;1134.8978591926766;1143.4454289669504;10725.678229653124;11077.723056923642;11085.890458112382;11132.116773795502;11152.219344645797;489303;501010;510140;515473;521887;83549.58225208835;86378;87134;87859;88003.55998220095;1128.4414214963645;1131.9377434241196;1145.8510393648771;1152.3028567716578;1156.5373850459882;16555.815830787134;16617.50147495577;16926.83073169302;17055.914720426317;17089.14554272306;38376.6162338373;38544.22911541809;38593.88105603778;38619.329585011845;40135;53261.73369133285;54130.729346354594;54653;54828.45171548233;55410.72294638501;8292;8397.328213743009;8585.484870907765;8630.180132887366;8634.740957771277;8961.820763584561;11790.351530665896;12546.749065018466;12927.353632318534;13166.605001849959;11461.911118443735;11563;11658.475368608264;11723.472443740222;11904.880951190376;10909.618163364245;11500.194986350874;11920;11982.520699171935;12015;11684.240524365889;11774.293542387484;11869.52521899149;12075.637730868088;12425.75148497007;8769.38614296993;8862.379633425599;8867.512286824029;8947.955260223918;9154.313426492907;10688.358698478116;11172.273802203155;11182.273152245078;11238.157138214503;11273.154513411691 07:17:16 INFO - PROCESS | 3424 | |3;mootools.html;1370.362781306692;1559.2359743725574;1589.6502769390734;1800.720888262319;1912.894790786507;8155.551444670541;8317.334613230942;8321.833563328744;8335.24982751553;8337.708180213695;8140.511569305831;8298.377621678368;8304.875426868603;8305.833883322344;8310.293625041879;2396.8202384821166;2414.7343792182846;2416.637504374349;2419.3104965084954;2422.2248880358293;2424.9515009699794;2457.938551536217;2473.5671257529953;2474.4061425257987;2478.913238036669;2336.976630233693;2360.563295790276;2362.14962613459;2398.5202959408102;2412.8069754419694;2380.3811009137576;2415.52897185049;2426.454047839231;2440.023990403835;2441.475082857194;2383.535210633927;2460.495598402323;2466.3834041489627;2472.035905996645;2480.751924807505;7124.14510258767;7268.200497945222;8505.829883402297;8540.615672294762;8546.316294696471;5069;5139.460356662534;5167.302414174113;5173.793048278064;5184.066867963765;3513.437849944022;3552.3605750964816;3581.6776490116013;3634.6547078027547;3684.189478314793;1216.2155409760655;1221.6884694402959;1227.6808029912197;1228.8832560906699;1229.6311106667963;11832.112591555668;11932.880671193263;11958.760824783543;11966.34185119818;11967.64097077089;4458.799354029012;4550.453945526558;4578.633709303248;4600.3099535070005;4600.631949444037;10078.79054513463;10125.797484050425;10152.187824973984;10163.898361016296;10164.796704065877;5182.4299327073995;5190.6107041972;5204.583633309327;5209.114450543417;5209.947900521022;4748.264019077049;4748.477667456577;4750.406199225097;4758.1673207188605;4778.522147785263;3836.7889766063136;4061.4923134608175;4062.898427539276;4081.469408976814;4108.239975604522;1302.4920281090383;1315.7697402954445;1318.6835159561829;1328.4022190014339;1333.1601091312411;1024.5696807340935;1031.6698656429871;1032.0402026115635;1034.9120324772327;1053.1627356251645;5869.8239052828485;6115.816525504242;6117.908231376533;6188.659623720649;6302.054691796267;444.0630270130023;445.23641954048963;452.81660927324486;454.76806828517033;464.7838754978951;4044.7168698190844;4077.4903137107863;4119.464469618931;4160.396742472385;4276.615104640598;10224.948875255724;10677.519511621995;10749.301295415773;10754.978277063667;10776.084032857138;10413.9479302603;10556.524956376981;10574.577016919391;10587.364758114383;10608.946955265328;8049.114597394282;8130.878036829452;8211.876821847676;8230.09468958426;8231.670733170606;5692.715364231689;5713.257276554022;5835.883282334415;5854.2389489367815;5899.793507227227;9138.68014619485;9146.817063658822;9287.814243715224;9382.530873456437;9443.811123777623;9188.264938805014;9211.815763684823;9375.390599611004;9464.337496375188;9518.19095376873;7347.155077166194;7436.107667079985;7441.293077157878;7442.4790264683115;7459.030326057577;8122.147174546588;8151.30713889326;8161.183881612029;8170.264676179172;8176.550289734122;7337.156227033959;7457.216992215739;7461.941103608198;7539.472236943361;7651.464397492122;7459.552426854406;7468.9626551866895;7542.660580273791;7549.584772837547;7677.424193185422;6930.826729331807;7088.964555177191;7094.716211351488;7102.9644851777475;7112.35988761014;4518.796654150506;4975.601951843916;5262.184361423985;5289.021531016774;5305.602079844104;5366.034113859543;5388.946110538845;5406.648567843235;5472.233887255867;5516.917246241229 07:17:16 INFO - PROCESS | 3424 | |4;prototype.html;352.3499144079175;354.3409258778671;356.0369201310455;361.23057886701304;363.03070800961433;6212.968935155329;6234.251889773228;6236.625802451845;6247.12540244365;6250.7499700012;6135.754569817202;6156;6208.16189814375;6229.688515574226;6241.375862413756;4464.6874718769695;4640.791164397593;4726.881827954294;4742.454617718955;4748.548887855648;4739.2654138608395;4751.596114330286;4762.97618511907;4777.140114779339;4783.1868582341085;4456.844010459635;4725.716457012573;4731.668783185179;4732.408448943882;4735.881602959919;4621.468531118914;4743.312219728155;4752.1921273383605;4756.667033307635;4761.619070474371;4173.5409104998425;4175.039740859619;4182.121754431573;4187.246295666779;4192.392103145057;5961.493273071794;5966.224390829165;5968.46283834457;5975.731092100866;5979.641221526679;5506.972465137648;5509.035918714249;5512.503874651301;5515.669059856422;5516.227728118067;6336.4930805535905;6529.934700652981;6534.477241820643;6537.378948999837;6551.967240163769;4636;4642.117997580449;4642.605378542828;4653.557911998355;4655.674102812771;6807.625580593065;6839.1451068616425;6844;6846.828829279209;6856.6228857412825;4740.336352910595;4748;4753.263244197155;4754.096721622881;4754.976225118921;4805.159097158054;4807.110684523374;4809.567138957511;4814.061258054646;4816.975915120472;5495.175723641406;5497.780088796483;5504.614676972574;5504.697241651747;5506.779728810803;6349.746010159634;6525.543211975116;6531.771388001397;6535.379138981789;6588.571742836701;1619.3522590963473;1632.6489804692048;1639.6392793585392;1640.9015459072493;1641.6880792649358;1017.3946501831399;1049.7113293844254;1066.5627092892032;1084.5011294804478;1091.661584908665;6306.1171435998995;6323.9683801580695;6329.208848893888;6332.873342533216;6335.714892829834;6616.239132499728;6679;6686;6691.063251144844;6696.330366963265;6264.496520834967;6318.8420289492215;6325.399087086719;6327.050942358683;6339.080833279241;3506.807125608116;3590.317839610466;3591.44332628443;3593.69453596442;3598.1004748812798;6876.759313424006;7014.964925175444;7021.684024218923;7032.1912980007955;7038.718451261892;6794.150731158606;6818.352256535622;6821.761238356634;6826.658667066627;6831.795046148623;6950.200726916368;6975.930240697629;6988.475864310197;6989.580625162506;6992.650367481606;6641.369069938348;6651.833704157435;6652.301508341748;6654.334566543501;6659;6426.935730642634;6566.507511936719;6575.539712220098;6585.80242592723;6600.207975043026;6945.513814032969;6973.895391569232;6977.546459480118;6978.825529361604;6991.056207411934;4580.770961451847;4601.677882548323;4611.400517932647;4619.422572178478;4622.699524530894;6642.667866606747;6643.800685979429;6654.201495820533;6656.334366563305;6665.566738162004;6375.776847810304;6450.645214513247;6463.15978922737;6474.741010359533;6495.512836537184;6447.516436267392;6488.870222595428;6510.804675859732;6516.185476815398;6548.574342667712;6336.049592561153;6337.8732425352155;6344;6347.206599175103;6349.206349206349;6492.31830657793;6552;6553.2136143661155;6563.868722625425;6565.80302590923;6026.578139530367;6165.106059621419;6323.936760632335;6335.3981371769605;6339.619622822645 07:17:16 INFO - PROCESS | 3424 | |5;yui.html;841.8737189421586;878.8945326560812;887.9334049946251;902.6344330546123;910.1035480052152;15063.623409414757;15101;15123.924380378083;15254.618634534143;15458.381664733412;13822.308884555783;14128.505502307422;14169.29153542324;14201.147931124115;14228.502002429917;700.6006576251539;874.623911717961;881.3874357321664;898.5956319656149;904.4934836491553;891.2112780189514;893.9865902011475;895.3016647015338;897.4346161917982;897.537768049455;932.2914584915479;938.568258601041;941.6798288581881;942.1755963531909;942.8491441369382;741.7478057460462;912.9315301352392;929.3169520402499;931.5109567477061;932.3426983976315;686.9690863911136;687.5496549759915;688.5662032919279;688.7589343729704;688.8691148681735;15281.312340944572;15371.308291126927;15390.538283851502;15405.537833865003;15490.07059576429;15464.613384665361;15640.061596304258;15720.449784257611;15819;15978.360865565364;12171.33057681827;12447;12490.437930293068;12714.554990575378;12791.808122878165;4086.366613174963;4098.569650186747;4143.606357396043;4145.813438395279;4177.101923086551;56814;57202.42797571971;57208;57270;57432.42567574313;11326.490307936163;11484.827727584094;11632.127590430751;11736.178467507363;12006.09954253417;19469.12388942501;19478.707819382722;19492.317768878303;19501;19511.31710390158;8511.616977235915;8665.43674661145;8831.425957312755;8930.553472326357;8938.642454301886;5057.367829021372;5126.282320475137;5130.948690513122;5155.845324640267;5172.9741351293005;3508.649135086522;3596.2447885944243;3618.5476815398074;3623.673869351771;3624.9637503625154;632.8639342541376;642.1459458919626;688.7004153193377;731.4879584291018;733.5818583407406;809.8339840332718;813.4143416739938;831.4512421801581;857.7212405968086;860.1871231685997;9561;9973.501324933724;10021.599136034623;10071.043250891154;10088.899111008943;716.5951237550767;840.478903080082;859.673324136824;862.969796057135;871.350843621506;4397.34039894012;4427;4461.910761784746;4475.552444755498;4539.591436770706;66604.66697666481;68999;69016.30983690199;69021.3097869025;69047;57369;57953.71023144942;58986;59226.70386648039;60781.69609151926;53809.73095134577;54188.187177192376;54427;54603.18095228575;55258.72370638121;8822.867656985021;8981.281497480317;8982.550872456482;9118.95440522793;9193.172614464731;39058.6094139055;39148.412773807846;41069;41091.17817643571;41269.174616508106;50372.49627503678;52185;52451;53361.46638533565;53543.46456535385;11284.43577821122;11300.265482743594;11750.823737644114;11909.285442873455;11940.462679179283;13004.739905202032;13192.20846749198;13250.337483125611;13318.866811331764;13330;12455.439505222468;12611.68470788201;12915.160514566898;12948.417321220757;13579.93210033983;12961.157524761238;13003.024773141862;13416;13548.796768048684;13558.93220533891;12754.362281886055;12902.419391127609;13303.866961330263;13307.866921330662;13426.261555614536;11326.716832079264;11422.428878555873;11655;11984.700382490508;12091.879081209076;11230.606928757454;11271.211015228855;11407.087433005505;11447.25592836463;11657 07:17:16 INFO - PROCESS | 3424 | __end_tp_report 07:17:16 INFO - PROCESS | 3424 | __start_cc_report 07:17:16 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,792 07:17:16 INFO - PROCESS | 3424 | __end_cc_report 07:17:16 INFO - PROCESS | 3424 | __startTimestamp1468592236388__endTimestamp 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | ------- Summary: start ------- 07:17:16 INFO - PROCESS | 3424 | Number of tests: 6 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:5411.00 Median:5601.47 stddev:584.28 (10.4%) stddev-sans-first:561.54 07:17:16 INFO - PROCESS | 3424 | Values: 3275.5 3334.3 3336.3 3341.1 3375.4 5420.3 5436.0 5449.3 5453.2 5458.4 5430.7 5437.7 5475.4 5485.3 5513.9 4899.2 5002.8 5032.9 5077.9 5107.5 4887.1 4966.7 5003.4 5018.3 5027.7 4952.3 5012.9 5021.9 5040.1 5084.1 4969.7 4994.3 4997.5 4999.6 5013.9 4885.5 4890.3 4913.9 4952.4 4963.3 5293.5 5347.1 5368.3 5374.1 5394.2 5813.1 5822.3 5833.3 5834.2 5835.9 5804.4 5845.9 5860.7 5875.8 5916.7 5390.1 5432.8 5433.3 5438.0 5442.9 5734.3 5899.5 5907.6 5908.9 5942.9 5678.6 5731.4 5738.1 5761.2 5784.6 5822.0 5828.5 5835.4 5838.5 5840.2 5601.5 5655.7 5788.3 5796.0 5804.7 5758.4 5775.2 5781.8 5788.0 5823.2 4435.4 4446.9 4447.5 4455.2 4472.4 3949.8 3958.7 4007.6 4022.9 4045.8 5446.0 5469.3 5499.5 5500.4 5558.0 5836.8 5837.7 5842.2 5845.9 5851.3 5409.6 5507.9 5549.1 5550.6 5580.1 4959.3 5002.3 5002.4 5004.5 5026.1 6048.3 6052.6 6058.5 6066.0 6085.0 5696.6 5798.9 5807.4 5890.2 5893.6 6029.9 6035.4 6038.1 6038.5 6043.7 5679.7 5723.0 5730.9 5733.4 5738.1 5741.5 5753.2 5820.1 5846.4 5853.5 5661.2 5670.5 5676.1 5677.5 5683.9 5477.5 5666.3 5676.0 5678.1 5682.8 5568.1 5619.6 5629.0 5654.0 5656.3 5670.3 5689.3 5700.8 5703.8 5707.7 5513.3 5564.6 5574.7 5583.1 5587.7 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:53711.09 Median:37850.81 stddev:99855.07 (263.8%) stddev-sans-first:100055.75 07:17:16 INFO - PROCESS | 3424 | Values: 659.7 676.6 693.6 721.8 745.8 31540.8 39442.4 39762.8 39802.4 39826.6 42463.2 43147.6 43173.0 43198.8 43269.4 7748.7 8630.2 8798.7 8802.8 10154.9 10180.1 10319.8 10321.2 10321.2 10327.7 10562.4 10693.3 10696.3 10699.7 10704.9 10565.1 10615.3 10643.0 10645.5 10647.2 10436.1 10660.9 10669.0 10673.7 10677.3 43993.8 44527.6 44563.6 44575.1 44617.8 4026.4 4061.6 4148.9 4328.6 4579.1 33312.3 33758.5 33823.3 35141.6 35324.8 4556.9 4574.5 4619.1 4620.1 4640.4 339003.0 339393.0 339497.0 340411.0 341503.0 38888.2 60549.7 61573.7 61654.4 61660.7 37506.2 37919.6 37957.0 37968.4 37999.8 15505.4 16847.2 17072.8 17086.7 17088.4 13708.0 13825.4 13860.0 13868.7 13882.6 9009.3 9079.5 9084.1 9119.3 9160.4 3505.8 3555.6 3565.5 3570.9 3629.1 1107.4 1108.6 1115.1 1160.7 1206.2 33053.7 33632.7 33888.4 33902.5 34967.1 1186.9 1228.1 1241.5 1323.9 1338.4 17013.1 17112.5 17292.3 17342.2 17763.2 491702.0 494430.0 496170.0 498391.0 498883.0 60197.0 61289.1 61325.4 61352.0 61495.7 1299.3 1514.3 1528.9 1594.9 1597.8 29806.9 30562.2 30936.5 31527.7 31624.8 44027.0 44171.8 44665.0 44744.6 44752.3 257013.0 257526.0 257619.0 258062.0 259374.0 27083.3 49351.5 49384.0 49415.5 49712.3 49786.5 50114.5 50136.0 51022.2 51138.2 39996.4 40513.0 40887.0 41695.4 44214.0 40209.8 40629.8 41009.6 41016.4 42237.8 42706.1 42984.8 43626.0 43901.8 44055.1 37204.8 37782.0 38036.0 38052.4 38382.4 28427.6 30193.5 30631.8 31183.4 32483.5 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:29219.19 Median:23007.04 stddev:83420.33 (362.6%) stddev-sans-first:83626.31 07:17:16 INFO - PROCESS | 3424 | Values: 416.6 422.0 423.6 429.4 432.3 12904.5 18300.6 18991.6 19000.8 19195.2 14057.5 18204.7 18538.9 18851.8 19038.9 5622.0 5816.7 5825.8 5852.4 5873.6 5744.4 5871.0 5883.4 5884.6 5885.9 5556.4 5832.7 5854.0 5860.6 5861.4 5780.0 5813.1 5831.3 5853.0 5855.0 5171.3 5234.7 5240.0 5243.8 5253.4 22524.0 22886.4 23127.7 23222.0 23226.7 2610.7 2654.6 2658.4 2866.1 2889.0 14106.4 14991.3 15193.4 15223.1 15333.5 2054.6 2064.9 2086.9 2125.3 2182.4 78714.0 79458.0 80245.6 81322.0 81429.2 10287.9 10439.6 10720.4 10805.6 10896.2 15212.0 15291.2 15303.0 15319.8 15335.8 8398.3 8429.2 8736.1 8885.6 9045.6 7965.2 8072.1 8106.0 8106.8 8220.7 5888.7 6584.3 6679.6 6790.9 6842.1 1813.3 1863.7 1881.9 1916.5 1967.5 1033.0 1093.8 1129.2 1159.3 1176.9 18619.6 18846.9 18912.0 18952.2 19302.8 1061.0 1078.1 1118.8 1134.9 1143.4 10725.7 11077.7 11085.9 11132.1 11152.2 489303.0 501010.0 510140.0 515473.0 521887.0 83549.6 86378.0 87134.0 87859.0 88003.6 1128.4 1131.9 1145.9 1152.3 1156.5 16555.8 16617.5 16926.8 17055.9 17089.1 38376.6 38544.2 38593.9 38619.3 40135.0 53261.7 54130.7 54653.0 54828.5 55410.7 8292.0 8397.3 8585.5 8630.2 8634.7 8961.8 11790.4 12546.7 12927.4 13166.6 11461.9 11563.0 11658.5 11723.5 11904.9 10909.6 11500.2 11920.0 11982.5 12015.0 11684.2 11774.3 11869.5 12075.6 12425.8 8769.4 8862.4 8867.5 8948.0 9154.3 10688.4 11172.3 11182.3 11238.2 11273.2 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:5664.87 Median:2606.52 stddev:3113.70 (119.5%) stddev-sans-first:3105.71 07:17:16 INFO - PROCESS | 3424 | Values: 1370.4 1559.2 1589.7 1800.7 1912.9 8155.6 8317.3 8321.8 8335.2 8337.7 8140.5 8298.4 8304.9 8305.8 8310.3 2396.8 2414.7 2416.6 2419.3 2422.2 2425.0 2457.9 2473.6 2474.4 2478.9 2337.0 2360.6 2362.1 2398.5 2412.8 2380.4 2415.5 2426.5 2440.0 2441.5 2383.5 2460.5 2466.4 2472.0 2480.8 7124.1 7268.2 8505.8 8540.6 8546.3 5069.0 5139.5 5167.3 5173.8 5184.1 3513.4 3552.4 3581.7 3634.7 3684.2 1216.2 1221.7 1227.7 1228.9 1229.6 11832.1 11932.9 11958.8 11966.3 11967.6 4458.8 4550.5 4578.6 4600.3 4600.6 10078.8 10125.8 10152.2 10163.9 10164.8 5182.4 5190.6 5204.6 5209.1 5209.9 4748.3 4748.5 4750.4 4758.2 4778.5 3836.8 4061.5 4062.9 4081.5 4108.2 1302.5 1315.8 1318.7 1328.4 1333.2 1024.6 1031.7 1032.0 1034.9 1053.2 5869.8 6115.8 6117.9 6188.7 6302.1 444.1 445.2 452.8 454.8 464.8 4044.7 4077.5 4119.5 4160.4 4276.6 10224.9 10677.5 10749.3 10755.0 10776.1 10413.9 10556.5 10574.6 10587.4 10608.9 8049.1 8130.9 8211.9 8230.1 8231.7 5692.7 5713.3 5835.9 5854.2 5899.8 9138.7 9146.8 9287.8 9382.5 9443.8 9188.3 9211.8 9375.4 9464.3 9518.2 7347.2 7436.1 7441.3 7442.5 7459.0 8122.1 8151.3 8161.2 8170.3 8176.6 7337.2 7457.2 7461.9 7539.5 7651.5 7459.6 7469.0 7542.7 7549.6 7677.4 6930.8 7089.0 7094.7 7103.0 7112.4 4518.8 4975.6 5262.2 5289.0 5305.6 5366.0 5388.9 5406.6 5472.2 5516.9 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:5464.82 Median:6248.94 stddev:1635.48 (26.2%) stddev-sans-first:1594.41 07:17:16 INFO - PROCESS | 3424 | Values: 352.3 354.3 356.0 361.2 363.0 6213.0 6234.3 6236.6 6247.1 6250.7 6135.8 6156.0 6208.2 6229.7 6241.4 4464.7 4640.8 4726.9 4742.5 4748.5 4739.3 4751.6 4763.0 4777.1 4783.2 4456.8 4725.7 4731.7 4732.4 4735.9 4621.5 4743.3 4752.2 4756.7 4761.6 4173.5 4175.0 4182.1 4187.2 4192.4 5961.5 5966.2 5968.5 5975.7 5979.6 5507.0 5509.0 5512.5 5515.7 5516.2 6336.5 6529.9 6534.5 6537.4 6552.0 4636.0 4642.1 4642.6 4653.6 4655.7 6807.6 6839.1 6844.0 6846.8 6856.6 4740.3 4748.0 4753.3 4754.1 4755.0 4805.2 4807.1 4809.6 4814.1 4817.0 5495.2 5497.8 5504.6 5504.7 5506.8 6349.7 6525.5 6531.8 6535.4 6588.6 1619.4 1632.6 1639.6 1640.9 1641.7 1017.4 1049.7 1066.6 1084.5 1091.7 6306.1 6324.0 6329.2 6332.9 6335.7 6616.2 6679.0 6686.0 6691.1 6696.3 6264.5 6318.8 6325.4 6327.1 6339.1 3506.8 3590.3 3591.4 3593.7 3598.1 6876.8 7015.0 7021.7 7032.2 7038.7 6794.2 6818.4 6821.8 6826.7 6831.8 6950.2 6975.9 6988.5 6989.6 6992.7 6641.4 6651.8 6652.3 6654.3 6659.0 6426.9 6566.5 6575.5 6585.8 6600.2 6945.5 6973.9 6977.5 6978.8 6991.1 4580.8 4601.7 4611.4 4619.4 4622.7 6642.7 6643.8 6654.2 6656.3 6665.6 6375.8 6450.6 6463.2 6474.7 6495.5 6447.5 6488.9 6510.8 6516.2 6548.6 6336.0 6337.9 6344.0 6347.2 6349.2 6492.3 6552.0 6553.2 6563.9 6565.8 6026.6 6165.1 6323.9 6335.4 6339.6 07:17:16 INFO - PROCESS | 3424 | 07:17:16 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:15990.89 Median:4468.73 stddev:18751.10 (419.6%) stddev-sans-first:18769.19 07:17:16 INFO - PROCESS | 3424 | Values: 841.9 878.9 887.9 902.6 910.1 15063.6 15101.0 15123.9 15254.6 15458.4 13822.3 14128.5 14169.3 14201.1 14228.5 700.6 874.6 881.4 898.6 904.5 891.2 894.0 895.3 897.4 897.5 932.3 938.6 941.7 942.2 942.8 741.7 912.9 929.3 931.5 932.3 687.0 687.5 688.6 688.8 688.9 15281.3 15371.3 15390.5 15405.5 15490.1 15464.6 15640.1 15720.4 15819.0 15978.4 12171.3 12447.0 12490.4 12714.6 12791.8 4086.4 4098.6 4143.6 4145.8 4177.1 56814.0 57202.4 57208.0 57270.0 57432.4 11326.5 11484.8 11632.1 11736.2 12006.1 19469.1 19478.7 19492.3 19501.0 19511.3 8511.6 8665.4 8831.4 8930.6 8938.6 5057.4 5126.3 5130.9 5155.8 5173.0 3508.6 3596.2 3618.5 3623.7 3625.0 632.9 642.1 688.7 731.5 733.6 809.8 813.4 831.5 857.7 860.2 9561.0 9973.5 10021.6 10071.0 10088.9 716.6 840.5 859.7 863.0 871.4 4397.3 4427.0 4461.9 4475.6 4539.6 66604.7 68999.0 69016.3 69021.3 69047.0 57369.0 57953.7 58986.0 59226.7 60781.7 53809.7 54188.2 54427.0 54603.2 55258.7 8822.9 8981.3 8982.6 9119.0 9193.2 39058.6 39148.4 41069.0 41091.2 41269.2 50372.5 52185.0 52451.0 53361.5 53543.5 11284.4 11300.3 11750.8 11909.3 11940.5 13004.7 13192.2 13250.3 13318.9 13330.0 12455.4 12611.7 12915.2 12948.4 13579.9 12961.2 13003.0 13416.0 13548.8 13558.9 12754.4 12902.4 13303.9 13307.9 13426.3 11326.7 11422.4 11655.0 11984.7 12091.9 11230.6 11271.2 11407.1 11447.3 11657.0 07:17:16 INFO - PROCESS | 3424 | -------- Summary: end -------- 07:17:16 INFO - PROCESS | 3424 | 07:17:17 INFO - TEST-INFO | 3424: exit 0 07:17:17 INFO - TEST-OK | dromaeo_css | took 1112572ms 07:17:17 INFO - TEST-START | kraken 07:17:17 INFO - operating with platform_type : linux_ 07:17:17 INFO - Initialising browser for kraken test... 07:17:17 INFO - TEST-INFO | started process 3624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEO07vK/profile http://localhost:45519/getInfo.html) 07:17:20 INFO - PROCESS | 3624 | __metrics Screen width/height:1600/1200 07:17:20 INFO - PROCESS | 3624 | colorDepth:24 07:17:20 INFO - PROCESS | 3624 | Browser inner width/height: 1024/697 07:17:20 INFO - PROCESS | 3624 | __metrics 07:17:21 INFO - PROCESS | 3624 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:17:21 ERROR - PROCESS | 3624 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:17:22 INFO - TEST-INFO | 3624: exit 0 07:17:22 INFO - Browser initialized. 07:17:22 INFO - Running cycle 1/1 for kraken test... 07:17:22 INFO - TEST-INFO | started process 3712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEO07vK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:34 INFO - PROCESS | 3712 | RSS: Main: 139436032 07:17:34 INFO - PROCESS | 3712 | 07:17:37 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45519/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:37 INFO - PROCESS | 3712 | RSS: Main: 197382144 07:17:37 INFO - PROCESS | 3712 | 07:17:40 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45519/tests/kraken/driver.html?testName=audio-dft) 07:17:41 INFO - PROCESS | 3712 | RSS: Main: 184557568 07:17:41 INFO - PROCESS | 3712 | 07:17:44 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45519/tests/kraken/driver.html?testName=audio-fft) 07:17:44 INFO - PROCESS | 3712 | RSS: Main: 273297408 07:17:44 INFO - PROCESS | 3712 | 07:17:46 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45519/tests/kraken/driver.html?testName=audio-oscillator) 07:17:47 INFO - PROCESS | 3712 | RSS: Main: 180158464 07:17:47 INFO - PROCESS | 3712 | 07:17:49 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:50 INFO - PROCESS | 3712 | RSS: Main: 178630656 07:17:50 INFO - PROCESS | 3712 | 07:17:53 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45519/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:53 INFO - PROCESS | 3712 | RSS: Main: 212533248 07:17:53 INFO - PROCESS | 3712 | 07:17:56 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45519/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:57 INFO - PROCESS | 3712 | RSS: Main: 212660224 07:17:57 INFO - PROCESS | 3712 | 07:18:00 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45519/tests/kraken/driver.html?testName=json-parse-financial) 07:18:00 INFO - PROCESS | 3712 | RSS: Main: 212205568 07:18:00 INFO - PROCESS | 3712 | 07:18:02 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:02 INFO - PROCESS | 3712 | RSS: Main: 193474560 07:18:02 INFO - PROCESS | 3712 | 07:18:04 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:05 INFO - PROCESS | 3712 | RSS: Main: 196845568 07:18:05 INFO - PROCESS | 3712 | 07:18:07 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:07 INFO - PROCESS | 3712 | RSS: Main: 209420288 07:18:07 INFO - PROCESS | 3712 | 07:18:10 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:10 INFO - PROCESS | 3712 | RSS: Main: 217096192 07:18:10 INFO - PROCESS | 3712 | 07:18:13 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:14 INFO - PROCESS | 3712 | RSS: Main: 213540864 07:18:14 INFO - PROCESS | 3712 | 07:18:15 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:45519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45519/tests/kraken/driver.html?testName=ai-astar) 07:18:16 INFO - PROCESS | 3712 | RSS: Main: 274427904 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | __start_tp_report 07:18:16 INFO - PROCESS | 3712 | _x_x_mozilla_page_load 07:18:16 INFO - PROCESS | 3712 | _x_x_mozilla_page_load_details 07:18:16 INFO - PROCESS | 3712 | |i|pagename|runs| 07:18:16 INFO - PROCESS | 3712 | |0;ai-astar;110;111;112;111;112;112;108;108;110;110 07:18:16 INFO - PROCESS | 3712 | |1;audio-beat-detection;150;132;156;173;125;152;165;126;189;130 07:18:16 INFO - PROCESS | 3712 | |2;audio-dft;160;160;160;160;161;160;161;160;159;158 07:18:16 INFO - PROCESS | 3712 | |3;audio-fft;76;77;72;184;77;74;76;76;162;74 07:18:16 INFO - PROCESS | 3712 | |4;audio-oscillator;91;91;152;92;93;93;153;93;91;154 07:18:16 INFO - PROCESS | 3712 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;116;117;117 07:18:16 INFO - PROCESS | 3712 | |6;imaging-darkroom;145;145;146;145;146;146;146;147;146;145 07:18:16 INFO - PROCESS | 3712 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;94 07:18:16 INFO - PROCESS | 3712 | |8;json-parse-financial;54;55;55;54;55;54;54;75;52;53 07:18:16 INFO - PROCESS | 3712 | |9;json-stringify-tinderbox;59;60;59;59;60;59;59;59;59;59 07:18:16 INFO - PROCESS | 3712 | |10;stanford-crypto-aes;73;73;72;72;75;73;74;74;73;74 07:18:16 INFO - PROCESS | 3712 | |11;stanford-crypto-ccm;117;116;114;114;115;112;112;115;129;130 07:18:16 INFO - PROCESS | 3712 | |12;stanford-crypto-pbkdf2;163;162;162;159;158;160;165;157;156;156 07:18:16 INFO - PROCESS | 3712 | |13;stanford-crypto-sha256-iterative;65;67;66;67;65;66;66;65;65;71 07:18:16 INFO - PROCESS | 3712 | __end_tp_report 07:18:16 INFO - PROCESS | 3712 | __start_cc_report 07:18:16 INFO - PROCESS | 3712 | _x_x_mozilla_cycle_collect,1603 07:18:16 INFO - PROCESS | 3712 | __end_cc_report 07:18:16 INFO - PROCESS | 3712 | __startTimestamp1468592296073__endTimestamp 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | ------- Summary: start ------- 07:18:16 INFO - PROCESS | 3712 | Number of tests: 14 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.51 (1.4%) stddev-sans-first:1.59 07:18:16 INFO - PROCESS | 3712 | Values: 110.0 111.0 112.0 111.0 112.0 112.0 108.0 108.0 110.0 110.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.00 stddev:21.70 (14.1%) stddev-sans-first:23.02 07:18:16 INFO - PROCESS | 3712 | Values: 150.0 132.0 156.0 173.0 125.0 152.0 165.0 126.0 189.0 130.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 07:18:16 INFO - PROCESS | 3712 | Values: 160.0 160.0 160.0 160.0 161.0 160.0 161.0 160.0 159.0 158.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:41.57 (54.7%) stddev-sans-first:43.53 07:18:16 INFO - PROCESS | 3712 | Values: 76.0 77.0 72.0 184.0 77.0 74.0 76.0 76.0 162.0 74.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:91.50 stddev:29.48 (32.2%) stddev-sans-first:30.43 07:18:16 INFO - PROCESS | 3712 | Values: 91.0 91.0 152.0 92.0 93.0 93.0 153.0 93.0 91.0 154.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:18:16 INFO - PROCESS | 3712 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 07:18:16 INFO - PROCESS | 3712 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 145.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:18:16 INFO - PROCESS | 3712 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.50 stddev:6.71 (12.3%) stddev-sans-first:7.07 07:18:16 INFO - PROCESS | 3712 | Values: 54.0 55.0 55.0 54.0 55.0 54.0 54.0 75.0 52.0 53.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 07:18:16 INFO - PROCESS | 3712 | Values: 59.0 60.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.50 stddev:0.95 (1.3%) stddev-sans-first:1.00 07:18:16 INFO - PROCESS | 3712 | Values: 73.0 73.0 72.0 72.0 75.0 73.0 74.0 74.0 73.0 74.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:115.50 stddev:6.57 (5.7%) stddev-sans-first:6.97 07:18:16 INFO - PROCESS | 3712 | Values: 117.0 116.0 114.0 114.0 115.0 112.0 112.0 115.0 129.0 130.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:161.00 stddev:3.12 (1.9%) stddev-sans-first:3.09 07:18:16 INFO - PROCESS | 3712 | Values: 163.0 162.0 162.0 159.0 158.0 160.0 165.0 157.0 156.0 156.0 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - PROCESS | 3712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.88 07:18:16 INFO - PROCESS | 3712 | Values: 65.0 67.0 66.0 67.0 65.0 66.0 66.0 65.0 65.0 71.0 07:18:16 INFO - PROCESS | 3712 | -------- Summary: end -------- 07:18:16 INFO - PROCESS | 3712 | 07:18:16 INFO - TEST-INFO | 3712: exit 0 07:18:17 INFO - TEST-OK | kraken | took 59945ms 07:18:17 INFO - SUITE-END | took 1172s 07:18:17 INFO - Completed test suite (00:19:32) 07:18:17 INFO - javascript benchmark 07:18:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.541424200612, 3334.333133373326, 3336.316055208684, 3341.1146046297727, 3375.358681850448, 5420.349558053034, 5436.0, 5449.264349312842, 5453.15476101204, 5458.372287186975, 5430.67415955043, 5437.728113594324, 5475.425080366564, 5485.341758988917, 5513.9448605514035, 4899.216125419934, 5002.849914502571, 5032.924506132411, 5077.898442031157, 5107.540321371076, 4887.1447496688115, 4966.701997880121, 5003.4246061702825, 5018.272350509193, 5027.698338099707, 4952.281919121725, 5012.949870501285, 5021.899562008758, 5040.143175660147, 5084.084864724348, 4969.676970996874, 4994.250862370655, 4997.475265097149, 4999.625028122905, 5013.949860501385, 4885.511448855122, 4890.339804126433, 4913.926291105637, 4952.430470495903, 4963.305137280783, 5293.497117773805, 5347.0909945309395, 5368.30212072432, 5374.113271310229, 5394.217838413408, 5813.128030795372, 5822.272215973004, 5833.270841144857, 5834.241548598698, 5835.912461313083, 5804.361520232771, 5845.941540584582, 5860.706964651793, 5875.823725288248, 5916.674582897939, 5390.110631745757, 5432.837014889559, 5433.293671822637, 5438.048341540254, 5442.91835622466, 5734.283214598176, 5899.46904778572, 5907.645541267538, 5908.911366329508, 5942.940570594325, 5678.5741069419955, 5731.426857314235, 5738.11059285803, 5761.164631128463, 5784.595078344475, 5822.039363504974, 5828.504577110993, 5835.44563266489, 5838.4745372915795, 5840.1531777892815, 5601.467860553241, 5655.688937108416, 5788.305403351625, 5796.0, 5804.651720896675, 5758.395368486333, 5775.220345253337, 5781.797637082682, 5788.044972579477, 5823.213866128019, 4435.379046933432, 4446.933296000562, 4447.510773814878, 4455.1757924784015, 4472.44094488189, 3949.8420063197723, 3958.7228893977144, 4007.639312461834, 4022.8591999279884, 4045.838166473367, 5446.0, 5469.288992431038, 5499.450054994469, 5500.367457742331, 5558.027345214571, 5836.766529338779, 5837.708114594253, 5842.182094506772, 5845.88308233833, 5851.297844258716, 5409.594280428983, 5507.917381239285, 5549.056660367747, 5550.611457197957, 5580.107182850806, 4959.330490383824, 5002.349694539686, 5002.449730529639, 5004.549590536869, 5026.095302845523, 6048.304444988883, 6052.606580572248, 6058.515318774487, 6065.969670151621, 6084.969575152184, 5696.629719068247, 5798.855028624318, 5807.419258074159, 5890.175375447527, 5893.616914900518, 6029.879402412015, 6035.396460354105, 6038.12447195163, 6038.4867286279405, 6043.697815109315, 5679.6876171810945, 5722.969865424264, 5730.885382292414, 5733.369329373682, 5738.110592858114, 5741.45456181662, 5753.1945527627, 5820.068788993741, 5846.386129456346, 5853.473187413153, 5661.235733175969, 5670.5180059695385, 5676.148577713211, 5677.545796336366, 5683.914741278967, 5477.507024367826, 5666.263385759825, 5675.971620141873, 5678.14827775837, 5682.772689092555, 5568.136938774496, 5619.606627536034, 5629.043062679272, 5654.038813401649, 5656.321241451053, 5670.262865827416, 5689.260396148474, 5700.800471983461, 5703.828885133453, 5707.743151558107, 5513.255710479194, 5564.582656300875, 5574.749136288796, 5583.106702927512, 5587.664740115606], "value": 5374.217444545481, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.6503852957934, 676.6379986707107, 693.6358411833787, 721.8375865430279, 745.7986343687203, 31540.842295788516, 39442.40836387453, 39762.8011859941, 39802.40296395553, 39826.60173398265, 42463.15073698524, 43147.568524314745, 43173.0, 43198.78400608, 43269.35095973563, 7748.690052397926, 8630.223279904807, 8798.6920457784, 8802.779930501725, 10154.89845101547, 10180.083792458678, 10319.793604127914, 10321.225908056887, 10321.225908056926, 10327.741806454824, 10562.419066951315, 10693.251472396936, 10696.251262411633, 10699.732506687316, 10704.946475267652, 10565.101966332872, 10615.256932014761, 10643.042126208678, 10645.467726613715, 10647.201459890463, 10436.112930400925, 10660.893391066067, 10669.0, 10673.679789606324, 10677.305975111592, 43993.78003109996, 44527.55472445299, 44563.55436445659, 44575.10849782986, 44617.77691111524, 4026.4362989181536, 4061.5938406159444, 4148.854790082363, 4328.61042506176, 4579.084183163381, 33312.3337533248, 33758.49362259568, 33823.32353352944, 35141.64858351409, 35324.82337588296, 4556.908861822778, 4574.451065872084, 4619.099275641252, 4620.075984803019, 4640.443146822369, 339003.0, 339393.0, 339497.0, 340411.0, 341503.0, 38888.22223555513, 60549.69725151434, 61573.69213153906, 61654.383456165764, 61660.69169654123, 37506.249875002344, 37919.62080379161, 37957.0, 37968.43047354292, 37999.810000949816, 15505.379784808707, 16847.241874115694, 17072.829271707124, 17086.743698844526, 17088.401905933482, 13708.0, 13825.446982120804, 13860.029797914049, 13868.722625547432, 13882.583522494342, 9009.324300677476, 9079.45523268606, 9084.137006984325, 9119.316051296179, 9160.404573702821, 3505.789652620851, 3555.6266592007983, 3565.4830049642655, 3570.946435803465, 3629.1108678373967, 1107.3687997841314, 1108.6286094158547, 1115.0864639236765, 1160.6634076118, 1206.2280140709952, 33053.66946330554, 33632.663673363444, 33888.40841261164, 33902.49146262808, 34967.12582185466, 1186.9465874035689, 1228.1157566552247, 1241.5175432910771, 1323.8940884729197, 1338.444545513601, 17013.149342532823, 17112.48662540126, 17292.308307667554, 17342.219600118024, 17763.20065597051, 491702.0, 494430.0, 496170.0, 498391.0, 498883.0, 60197.0, 61289.08066379008, 61325.38674613286, 61352.0, 61495.69252153711, 1299.3178581244922, 1514.3109885002298, 1528.9311980961106, 1594.8883578149419, 1597.752348386002, 29806.850965745034, 30562.235944101576, 30936.53595196119, 31527.684723153394, 31624.841875790473, 44027.0, 44171.77914110409, 44665.0, 44744.55255447404, 44752.32871506865, 257013.0, 257526.0, 257619.0, 258062.0, 259374.0, 27083.322916927234, 49351.50648493469, 49384.0, 49415.50584494109, 49712.25431618601, 49786.50213497819, 50114.49885501244, 50136.0, 51022.23466647929, 51138.23292650688, 39996.40005399863, 40513.0, 40887.0, 41695.37456938209, 44214.0, 40209.79895100506, 40629.796851015555, 41009.58990410177, 41016.384754228115, 42237.78881105575, 42706.145877082905, 42984.78507607442, 43626.0, 43901.780491098616, 44055.11889762123, 37204.81397593103, 37782.0, 38036.0, 38052.42921356126, 38382.42426363551, 28427.573586395807, 30193.547096793125, 30631.846840765655, 31183.376332473676, 32483.512747308338], "value": 19871.18985369717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.5875782974855, 421.9957800421995, 423.57430782064023, 429.4202826184651, 432.33204698740445, 12904.54834080805, 18300.633987320263, 18991.62016759664, 19000.809991900078, 19195.23219071239, 14057.507987220424, 18204.726929096076, 18538.907305463454, 18851.811481885175, 19038.90480547595, 5622.044252477079, 5816.709164541777, 5825.8252252432285, 5852.385499522531, 5873.588848780587, 5744.368119506851, 5871.031279838821, 5883.411658834125, 5884.558658100638, 5885.85285367865, 5556.361018482886, 5832.6792026438525, 5854.0, 5860.560457965648, 5861.384554621767, 5779.971100144472, 5813.128030795372, 5831.271091113611, 5853.034249348873, 5855.0, 5171.250168725552, 5234.7120908350025, 5240.0, 5243.842684719464, 5253.4221235664045, 22524.0, 22886.42783930415, 23127.653085203736, 23222.0, 23226.65160022601, 2610.738926107393, 2654.615080813271, 2658.3752818087733, 2866.125831621355, 2889.0, 14106.365213565414, 14991.250437478191, 15193.392264309414, 15223.086614803147, 15333.463328783551, 2054.5685406064745, 2064.9380518584467, 2086.874787512754, 2125.27740568206, 2182.3671135370723, 78714.0, 79458.0, 80245.59877200636, 81322.0, 81429.18570814276, 10287.948560257151, 10439.634612788515, 10720.35677859331, 10805.621803236849, 10896.237263391646, 15212.0, 15291.158986255641, 15303.0, 15319.770203446735, 15335.846641533664, 8398.286145677686, 8429.157084291523, 8736.08271131522, 8885.644574216958, 9045.592948317342, 7965.243301886311, 8072.112067672669, 8105.959470202612, 8106.797330066795, 8220.671173153127, 5888.735006924699, 6584.333622076476, 6679.56582822115, 6790.864182716318, 6842.144731908512, 1813.3200049981258, 1863.6552237836045, 1881.9153138108818, 1916.4633902507321, 1967.5081229692578, 1032.9535170917327, 1093.786711591248, 1129.2264798612975, 1159.252282277926, 1176.8940795328463, 18619.627607448045, 18846.905765471085, 18912.0, 18952.24191032343, 19302.806971930382, 1060.984085238722, 1078.1159449251538, 1118.8433619293305, 1134.8978591926766, 1143.4454289669504, 10725.678229653124, 11077.723056923642, 11085.890458112382, 11132.116773795502, 11152.219344645797, 489303.0, 501010.0, 510140.0, 515473.0, 521887.0, 83549.58225208835, 86378.0, 87134.0, 87859.0, 88003.55998220095, 1128.4414214963645, 1131.9377434241196, 1145.8510393648771, 1152.3028567716578, 1156.5373850459882, 16555.815830787134, 16617.50147495577, 16926.83073169302, 17055.914720426317, 17089.14554272306, 38376.6162338373, 38544.22911541809, 38593.88105603778, 38619.329585011845, 40135.0, 53261.73369133285, 54130.729346354594, 54653.0, 54828.45171548233, 55410.72294638501, 8292.0, 8397.328213743009, 8585.484870907765, 8630.180132887366, 8634.740957771277, 8961.820763584561, 11790.351530665896, 12546.749065018466, 12927.353632318534, 13166.605001849959, 11461.911118443735, 11563.0, 11658.475368608264, 11723.472443740222, 11904.880951190376, 10909.618163364245, 11500.194986350874, 11920.0, 11982.520699171935, 12015.0, 11684.240524365889, 11774.293542387484, 11869.52521899149, 12075.637730868088, 12425.75148497007, 8769.38614296993, 8862.379633425599, 8867.512286824029, 8947.955260223918, 9154.313426492907, 10688.358698478116, 11172.273802203155, 11182.273152245078, 11238.157138214503, 11273.154513411691], "value": 9461.704896399098, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.362781306692, 1559.2359743725574, 1589.6502769390734, 1800.720888262319, 1912.894790786507, 8155.551444670541, 8317.334613230942, 8321.833563328744, 8335.24982751553, 8337.708180213695, 8140.511569305831, 8298.377621678368, 8304.875426868603, 8305.833883322344, 8310.293625041879, 2396.8202384821166, 2414.7343792182846, 2416.637504374349, 2419.3104965084954, 2422.2248880358293, 2424.9515009699794, 2457.938551536217, 2473.5671257529953, 2474.4061425257987, 2478.913238036669, 2336.976630233693, 2360.563295790276, 2362.14962613459, 2398.5202959408102, 2412.8069754419694, 2380.3811009137576, 2415.52897185049, 2426.454047839231, 2440.023990403835, 2441.475082857194, 2383.535210633927, 2460.495598402323, 2466.3834041489627, 2472.035905996645, 2480.751924807505, 7124.14510258767, 7268.200497945222, 8505.829883402297, 8540.615672294762, 8546.316294696471, 5069.0, 5139.460356662534, 5167.302414174113, 5173.793048278064, 5184.066867963765, 3513.437849944022, 3552.3605750964816, 3581.6776490116013, 3634.6547078027547, 3684.189478314793, 1216.2155409760655, 1221.6884694402959, 1227.6808029912197, 1228.8832560906699, 1229.6311106667963, 11832.112591555668, 11932.880671193263, 11958.760824783543, 11966.34185119818, 11967.64097077089, 4458.799354029012, 4550.453945526558, 4578.633709303248, 4600.3099535070005, 4600.631949444037, 10078.79054513463, 10125.797484050425, 10152.187824973984, 10163.898361016296, 10164.796704065877, 5182.4299327073995, 5190.6107041972, 5204.583633309327, 5209.114450543417, 5209.947900521022, 4748.264019077049, 4748.477667456577, 4750.406199225097, 4758.1673207188605, 4778.522147785263, 3836.7889766063136, 4061.4923134608175, 4062.898427539276, 4081.469408976814, 4108.239975604522, 1302.4920281090383, 1315.7697402954445, 1318.6835159561829, 1328.4022190014339, 1333.1601091312411, 1024.5696807340935, 1031.6698656429871, 1032.0402026115635, 1034.9120324772327, 1053.1627356251645, 5869.8239052828485, 6115.816525504242, 6117.908231376533, 6188.659623720649, 6302.054691796267, 444.0630270130023, 445.23641954048963, 452.81660927324486, 454.76806828517033, 464.7838754978951, 4044.7168698190844, 4077.4903137107863, 4119.464469618931, 4160.396742472385, 4276.615104640598, 10224.948875255724, 10677.519511621995, 10749.301295415773, 10754.978277063667, 10776.084032857138, 10413.9479302603, 10556.524956376981, 10574.577016919391, 10587.364758114383, 10608.946955265328, 8049.114597394282, 8130.878036829452, 8211.876821847676, 8230.09468958426, 8231.670733170606, 5692.715364231689, 5713.257276554022, 5835.883282334415, 5854.2389489367815, 5899.793507227227, 9138.68014619485, 9146.817063658822, 9287.814243715224, 9382.530873456437, 9443.811123777623, 9188.264938805014, 9211.815763684823, 9375.390599611004, 9464.337496375188, 9518.19095376873, 7347.155077166194, 7436.107667079985, 7441.293077157878, 7442.4790264683115, 7459.030326057577, 8122.147174546588, 8151.30713889326, 8161.183881612029, 8170.264676179172, 8176.550289734122, 7337.156227033959, 7457.216992215739, 7461.941103608198, 7539.472236943361, 7651.464397492122, 7459.552426854406, 7468.9626551866895, 7542.660580273791, 7549.584772837547, 7677.424193185422, 6930.826729331807, 7088.964555177191, 7094.716211351488, 7102.9644851777475, 7112.35988761014, 4518.796654150506, 4975.601951843916, 5262.184361423985, 5289.021531016774, 5305.602079844104, 5366.034113859543, 5388.946110538845, 5406.648567843235, 5472.233887255867, 5516.917246241229], "value": 4540.812989141394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.3499144079175, 354.3409258778671, 356.0369201310455, 361.23057886701304, 363.03070800961433, 6212.968935155329, 6234.251889773228, 6236.625802451845, 6247.12540244365, 6250.7499700012, 6135.754569817202, 6156.0, 6208.16189814375, 6229.688515574226, 6241.375862413756, 4464.6874718769695, 4640.791164397593, 4726.881827954294, 4742.454617718955, 4748.548887855648, 4739.2654138608395, 4751.596114330286, 4762.97618511907, 4777.140114779339, 4783.1868582341085, 4456.844010459635, 4725.716457012573, 4731.668783185179, 4732.408448943882, 4735.881602959919, 4621.468531118914, 4743.312219728155, 4752.1921273383605, 4756.667033307635, 4761.619070474371, 4173.5409104998425, 4175.039740859619, 4182.121754431573, 4187.246295666779, 4192.392103145057, 5961.493273071794, 5966.224390829165, 5968.46283834457, 5975.731092100866, 5979.641221526679, 5506.972465137648, 5509.035918714249, 5512.503874651301, 5515.669059856422, 5516.227728118067, 6336.4930805535905, 6529.934700652981, 6534.477241820643, 6537.378948999837, 6551.967240163769, 4636.0, 4642.117997580449, 4642.605378542828, 4653.557911998355, 4655.674102812771, 6807.625580593065, 6839.1451068616425, 6844.0, 6846.828829279209, 6856.6228857412825, 4740.336352910595, 4748.0, 4753.263244197155, 4754.096721622881, 4754.976225118921, 4805.159097158054, 4807.110684523374, 4809.567138957511, 4814.061258054646, 4816.975915120472, 5495.175723641406, 5497.780088796483, 5504.614676972574, 5504.697241651747, 5506.779728810803, 6349.746010159634, 6525.543211975116, 6531.771388001397, 6535.379138981789, 6588.571742836701, 1619.3522590963473, 1632.6489804692048, 1639.6392793585392, 1640.9015459072493, 1641.6880792649358, 1017.3946501831399, 1049.7113293844254, 1066.5627092892032, 1084.5011294804478, 1091.661584908665, 6306.1171435998995, 6323.9683801580695, 6329.208848893888, 6332.873342533216, 6335.714892829834, 6616.239132499728, 6679.0, 6686.0, 6691.063251144844, 6696.330366963265, 6264.496520834967, 6318.8420289492215, 6325.399087086719, 6327.050942358683, 6339.080833279241, 3506.807125608116, 3590.317839610466, 3591.44332628443, 3593.69453596442, 3598.1004748812798, 6876.759313424006, 7014.964925175444, 7021.684024218923, 7032.1912980007955, 7038.718451261892, 6794.150731158606, 6818.352256535622, 6821.761238356634, 6826.658667066627, 6831.795046148623, 6950.200726916368, 6975.930240697629, 6988.475864310197, 6989.580625162506, 6992.650367481606, 6641.369069938348, 6651.833704157435, 6652.301508341748, 6654.334566543501, 6659.0, 6426.935730642634, 6566.507511936719, 6575.539712220098, 6585.80242592723, 6600.207975043026, 6945.513814032969, 6973.895391569232, 6977.546459480118, 6978.825529361604, 6991.056207411934, 4580.770961451847, 4601.677882548323, 4611.400517932647, 4619.422572178478, 4622.699524530894, 6642.667866606747, 6643.800685979429, 6654.201495820533, 6656.334366563305, 6665.566738162004, 6375.776847810304, 6450.645214513247, 6463.15978922737, 6474.741010359533, 6495.512836537184, 6447.516436267392, 6488.870222595428, 6510.804675859732, 6516.185476815398, 6548.574342667712, 6336.049592561153, 6337.8732425352155, 6344.0, 6347.206599175103, 6349.206349206349, 6492.31830657793, 6552.0, 6553.2136143661155, 6563.868722625425, 6565.80302590923, 6026.578139530367, 6165.106059621419, 6323.936760632335, 6335.3981371769605, 6339.619622822645], "value": 4930.849805015216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.8737189421586, 878.8945326560812, 887.9334049946251, 902.6344330546123, 910.1035480052152, 15063.623409414757, 15101.0, 15123.924380378083, 15254.618634534143, 15458.381664733412, 13822.308884555783, 14128.505502307422, 14169.29153542324, 14201.147931124115, 14228.502002429917, 700.6006576251539, 874.623911717961, 881.3874357321664, 898.5956319656149, 904.4934836491553, 891.2112780189514, 893.9865902011475, 895.3016647015338, 897.4346161917982, 897.537768049455, 932.2914584915479, 938.568258601041, 941.6798288581881, 942.1755963531909, 942.8491441369382, 741.7478057460462, 912.9315301352392, 929.3169520402499, 931.5109567477061, 932.3426983976315, 686.9690863911136, 687.5496549759915, 688.5662032919279, 688.7589343729704, 688.8691148681735, 15281.312340944572, 15371.308291126927, 15390.538283851502, 15405.537833865003, 15490.07059576429, 15464.613384665361, 15640.061596304258, 15720.449784257611, 15819.0, 15978.360865565364, 12171.33057681827, 12447.0, 12490.437930293068, 12714.554990575378, 12791.808122878165, 4086.366613174963, 4098.569650186747, 4143.606357396043, 4145.813438395279, 4177.101923086551, 56814.0, 57202.42797571971, 57208.0, 57270.0, 57432.42567574313, 11326.490307936163, 11484.827727584094, 11632.127590430751, 11736.178467507363, 12006.09954253417, 19469.12388942501, 19478.707819382722, 19492.317768878303, 19501.0, 19511.31710390158, 8511.616977235915, 8665.43674661145, 8831.425957312755, 8930.553472326357, 8938.642454301886, 5057.367829021372, 5126.282320475137, 5130.948690513122, 5155.845324640267, 5172.9741351293005, 3508.649135086522, 3596.2447885944243, 3618.5476815398074, 3623.673869351771, 3624.9637503625154, 632.8639342541376, 642.1459458919626, 688.7004153193377, 731.4879584291018, 733.5818583407406, 809.8339840332718, 813.4143416739938, 831.4512421801581, 857.7212405968086, 860.1871231685997, 9561.0, 9973.501324933724, 10021.599136034623, 10071.043250891154, 10088.899111008943, 716.5951237550767, 840.478903080082, 859.673324136824, 862.969796057135, 871.350843621506, 4397.34039894012, 4427.0, 4461.910761784746, 4475.552444755498, 4539.591436770706, 66604.66697666481, 68999.0, 69016.30983690199, 69021.3097869025, 69047.0, 57369.0, 57953.71023144942, 58986.0, 59226.70386648039, 60781.69609151926, 53809.73095134577, 54188.187177192376, 54427.0, 54603.18095228575, 55258.72370638121, 8822.867656985021, 8981.281497480317, 8982.550872456482, 9118.95440522793, 9193.172614464731, 39058.6094139055, 39148.412773807846, 41069.0, 41091.17817643571, 41269.174616508106, 50372.49627503678, 52185.0, 52451.0, 53361.46638533565, 53543.46456535385, 11284.43577821122, 11300.265482743594, 11750.823737644114, 11909.285442873455, 11940.462679179283, 13004.739905202032, 13192.20846749198, 13250.337483125611, 13318.866811331764, 13330.0, 12455.439505222468, 12611.68470788201, 12915.160514566898, 12948.417321220757, 13579.93210033983, 12961.157524761238, 13003.024773141862, 13416.0, 13548.796768048684, 13558.93220533891, 12754.362281886055, 12902.419391127609, 13303.866961330263, 13307.866921330662, 13426.261555614536, 11326.716832079264, 11422.428878555873, 11655.0, 11984.700382490508, 12091.879081209076, 11230.606928757454, 11271.211015228855, 11407.087433005505, 11447.25592836463, 11657.0], "value": 7241.36707531925, "unit": "score"}], "name": "dromaeo_css", "value": 7397.257574502835, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 111.0, 112.0, 112.0, 108.0, 108.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 156.0, 173.0, 125.0, 152.0, 165.0, 126.0, 189.0, 130.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 159.0, 158.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 72.0, 184.0, 77.0, 74.0, 76.0, 76.0, 162.0, 74.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 152.0, 92.0, 93.0, 93.0, 153.0, 93.0, 91.0, 154.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 75.0, 52.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 72.0, 75.0, 73.0, 74.0, 74.0, 73.0, 74.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 114.0, 115.0, 112.0, 112.0, 115.0, 129.0, 130.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 159.0, 158.0, 160.0, 165.0, 157.0, 156.0, 156.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0, 71.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1514.3999999999999, "alertThreshold": 2.0}]} 07:18:17 INFO - Return code: 0 07:18:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:18:17 ERROR - # TBPL SUCCESS # 07:18:17 INFO - Running post-action listener: _resource_record_post_action 07:18:17 INFO - Running post-run listener: _resource_record_post_run 07:18:18 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 7725056; Write bytes: 415043584; Read time: 1996; Write time: 303604 07:18:18 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 69525504; Read time: 0; Write time: 37640 07:18:18 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 5939200; Write bytes: 343273472; Read time: 1872; Write time: 265524 07:18:18 INFO - Running post-run listener: _upload_blobber_files 07:18:18 INFO - Blob upload gear active. 07:18:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:18:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:19 INFO - (blobuploader) - INFO - Done attempting. 07:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:20 INFO - (blobuploader) - INFO - Done attempting. 07:18:20 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:20 INFO - Return code: 0 07:18:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4142c47880ba7c544a0c272e3c2ddf53d8de0d676a4b9118db7edf53be97f127028290ab7e9798164663f6a921e4da09a8b7e06c412b762e2ebe6e97b4c1add6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21689ac0ce057c591bec27bb5a6af5b0dedcf2d8b974e37a65d3220fbe2a7699c38dba519f1dc2814da44522bba57d63d5f668c15daf5100b333211ad5b7c4e4"} 07:18:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:20 INFO - Contents: 07:18:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4142c47880ba7c544a0c272e3c2ddf53d8de0d676a4b9118db7edf53be97f127028290ab7e9798164663f6a921e4da09a8b7e06c412b762e2ebe6e97b4c1add6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21689ac0ce057c591bec27bb5a6af5b0dedcf2d8b974e37a65d3220fbe2a7699c38dba519f1dc2814da44522bba57d63d5f668c15daf5100b333211ad5b7c4e4"} 07:18:20 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:20 INFO - Copying logs to upload dir... 07:18:20 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.440396 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-15 07:18:20.416929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:20.420746) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4142c47880ba7c544a0c272e3c2ddf53d8de0d676a4b9118db7edf53be97f127028290ab7e9798164663f6a921e4da09a8b7e06c412b762e2ebe6e97b4c1add6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21689ac0ce057c591bec27bb5a6af5b0dedcf2d8b974e37a65d3220fbe2a7699c38dba519f1dc2814da44522bba57d63d5f668c15daf5100b333211ad5b7c4e4"} build_url:https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4142c47880ba7c544a0c272e3c2ddf53d8de0d676a4b9118db7edf53be97f127028290ab7e9798164663f6a921e4da09a8b7e06c412b762e2ebe6e97b4c1add6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21689ac0ce057c591bec27bb5a6af5b0dedcf2d8b974e37a65d3220fbe2a7699c38dba519f1dc2814da44522bba57d63d5f668c15daf5100b333211ad5b7c4e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:20.446322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:20.446655) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1468590975.568590-885796744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:20.529106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:18:20.529439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:18:20.529779) ========= ========= Total master_lag: 0.08 =========