builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1468602757.63 results: success (0) buildid: 20160714110442 builduid: 9b77baf87c934dfca292b0a239c48418 revision: 8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.627106) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.627693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.628025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.659658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.660042) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 10:12:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-07-15 10:12:37 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.747715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.748082) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:37.797432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:12:37.797772) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5 --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 8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5 --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=c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 10:12:37,924 truncating revision to first 12 chars 2016-07-15 10:12:37,924 Setting DEBUG logging. 2016-07-15 10:12:37,924 attempt 1/10 2016-07-15 10:12:37,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8139a58cc0c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 10:12:38,320 unpacking tar archive at: mozilla-beta-8139a58cc0c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736563 ========= master_lag: 0.59 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:12:39.125246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:39.125614) ========= script_repo_revision: 8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:39.126095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:39.126389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:12:39.141145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-15 10:12:39.141575) ========= /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=c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:12:39 INFO - MultiFileLogger online at 20160715 10:12:39 in /builds/slave/test 10:12:39 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 10:12:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:39 INFO - {'append_to_log': False, 10:12:39 INFO - 'base_work_dir': '/builds/slave/test', 10:12:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:12:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:39 INFO - 'branch': 'Mozilla-Beta', 10:12:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:39 INFO - 'config_files': ('talos/linux_config.py',), 10:12:39 INFO - 'default_actions': ('clobber', 10:12:39 INFO - 'read-buildbot-config', 10:12:39 INFO - 'download-and-extract', 10:12:39 INFO - 'populate-webroot', 10:12:39 INFO - 'create-virtualenv', 10:12:39 INFO - 'install', 10:12:39 INFO - 'run-tests'), 10:12:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:39 INFO - 'download_minidump_stackwalk': True, 10:12:39 INFO - 'download_symbols': 'ondemand', 10:12:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:39 INFO - 'installer_path': 'installer.exe', 10:12:39 INFO - 'log_level': 'info', 10:12:39 INFO - 'log_name': 'talos', 10:12:39 INFO - 'log_to_console': True, 10:12:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:12:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:12:39 INFO - 'opt_config_files': (), 10:12:39 INFO - 'pip_index': False, 10:12:39 INFO - 'sps_profile': False, 10:12:39 INFO - 'sps_profile_interval': 0, 10:12:39 INFO - 'suite': 'dromaeojs', 10:12:39 INFO - 'system_bits': '32', 10:12:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:39 INFO - 'title': 'talos-linux64-ix-004', 10:12:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:39 INFO - 'use_talos_json': True, 10:12:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:39 INFO - 'work_dir': 'build'} 10:12:39 INFO - ##### 10:12:39 INFO - ##### Running clobber step. 10:12:39 INFO - ##### 10:12:39 INFO - Running pre-action listener: _resource_record_pre_action 10:12:39 INFO - Running main action method: clobber 10:12:39 INFO - rmtree: /builds/slave/test/build 10:12:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:40 INFO - Running post-action listener: _resource_record_post_action 10:12:40 INFO - ##### 10:12:40 INFO - ##### Running read-buildbot-config step. 10:12:40 INFO - ##### 10:12:40 INFO - Running pre-action listener: _resource_record_pre_action 10:12:40 INFO - Running main action method: read_buildbot_config 10:12:40 INFO - Using buildbot properties: 10:12:40 INFO - { 10:12:40 INFO - "project": "", 10:12:40 INFO - "product": "firefox", 10:12:40 INFO - "script_repo_revision": "production", 10:12:40 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:12:40 INFO - "repository": "", 10:12:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:12:40 INFO - "buildid": "20160714110442", 10:12:40 INFO - "pgo_build": "True", 10:12:40 INFO - "basedir": "/builds/slave/test", 10:12:40 INFO - "buildnumber": 170, 10:12:40 INFO - "slavename": "talos-linux64-ix-004", 10:12:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:12:40 INFO - "platform": "ubuntu64_hw", 10:12:40 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:12:40 INFO - "branch": "mozilla-beta", 10:12:40 INFO - "repo_path": "releases/mozilla-beta", 10:12:40 INFO - "revision": "8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5", 10:12:40 INFO - "stage_platform": "linux64-pgo", 10:12:40 INFO - "builduid": "9b77baf87c934dfca292b0a239c48418", 10:12:40 INFO - "slavebuilddir": "test" 10:12:40 INFO - } 10:12:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:12:40 INFO - Running post-action listener: _resource_record_post_action 10:12:40 INFO - ##### 10:12:40 INFO - ##### Running download-and-extract step. 10:12:40 INFO - ##### 10:12:40 INFO - Running pre-action listener: _resource_record_pre_action 10:12:40 INFO - Running main action method: download_and_extract 10:12:40 INFO - mkdir: /builds/slave/test/build/tests 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:40 INFO - https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:42 INFO - Downloaded 1327 bytes. 10:12:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:12:42 INFO - Using the following test package requirements: 10:12:42 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:12:42 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:12:42 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:12:42 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'jsshell-linux-x86_64.zip'], 10:12:42 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:12:42 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:12:42 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:12:42 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:12:42 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:12:42 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:12:42 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:12:42 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:42 INFO - https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:45 INFO - Downloaded 24200960 bytes. 10:12:45 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'] 10:12:45 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 10:12:46 INFO - Return code: 0 10:12:46 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 10:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:46 INFO - https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:12:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:12:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:49 INFO - Downloaded 24200960 bytes. 10:12:49 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'] 10:12:49 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 10:12:50 INFO - Return code: 0 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:50 INFO - https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:12:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:12:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:51 INFO - Downloaded 10840145 bytes. 10:12:51 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'] 10:12:51 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 10:12:51 INFO - Return code: 0 10:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:51 INFO - https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:12:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:12:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsAZZVcpQlyruhHPGXGixw/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 10:12:53 INFO - Downloaded 56022851 bytes. 10:12:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:12:53 INFO - mkdir: /builds/slave/test/properties 10:12:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:53 INFO - Contents: 10:12:53 INFO - build_url:https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:12:53 INFO - Running post-action listener: _resource_record_post_action 10:12:53 INFO - Running post-action listener: set_extra_try_arguments 10:12:53 INFO - ##### 10:12:53 INFO - ##### Running populate-webroot step. 10:12:53 INFO - ##### 10:12:53 INFO - Running pre-action listener: _resource_record_pre_action 10:12:53 INFO - Running main action method: populate_webroot 10:12:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:53 INFO - '--tppagecycles', 10:12:53 INFO - '7'], 10:12:53 INFO - 'tests': ['tsvgm']}}, 10:12:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['damp', 'tps']}, 10:12:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'tests': ['damp', 'tps']}, 10:12:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['dromaeo_dom']}, 10:12:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['a11yr', 10:12:53 INFO - 'ts_paint', 10:12:53 INFO - 'tpaint', 10:12:53 INFO - 'sessionrestore', 10:12:53 INFO - 'sessionrestore_no_auto_restore', 10:12:53 INFO - 'tabpaint']}, 10:12:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:53 INFO - 'ts_paint', 10:12:53 INFO - 'tpaint', 10:12:53 INFO - 'sessionrestore', 10:12:53 INFO - 'sessionrestore_no_auto_restore', 10:12:53 INFO - 'tabpaint']}, 10:12:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:53 INFO - 'ts_paint', 10:12:53 INFO - 'tpaint', 10:12:53 INFO - 'sessionrestore', 10:12:53 INFO - 'sessionrestore_no_auto_restore', 10:12:53 INFO - 'tabpaint']}, 10:12:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:53 INFO - 'ts_paint', 10:12:53 INFO - 'tpaint', 10:12:53 INFO - 'sessionrestore', 10:12:53 INFO - 'sessionrestore_no_auto_restore', 10:12:53 INFO - 'tabpaint']}, 10:12:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['a11yr', 10:12:53 INFO - 'ts_paint', 10:12:53 INFO - 'tpaint', 10:12:53 INFO - 'sessionrestore', 10:12:53 INFO - 'sessionrestore_no_auto_restore', 10:12:53 INFO - 'tabpaint']}, 10:12:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['a11yr', 10:12:53 INFO - 'ts_paint', 10:12:53 INFO - 'tpaint', 10:12:53 INFO - 'sessionrestore', 10:12:53 INFO - 'sessionrestore_no_auto_restore', 10:12:53 INFO - 'tabpaint']}, 10:12:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['tsvgx', 10:12:53 INFO - 'tsvgr_opacity', 10:12:53 INFO - 'tart', 10:12:53 INFO - 'tscrollx', 10:12:53 INFO - 'cart']}, 10:12:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:53 INFO - 'tsvgr_opacity', 10:12:53 INFO - 'tart', 10:12:53 INFO - 'tscrollx', 10:12:53 INFO - 'cart']}, 10:12:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'talos_options': ['--disable-e10s'], 10:12:53 INFO - 'tests': ['tp5o']}, 10:12:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'tests': ['tp5o']}, 10:12:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'talos_options': ['--disable-e10s', 10:12:53 INFO - '--xperf_path', 10:12:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:53 INFO - 'tests': ['tp5n']}, 10:12:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:53 INFO - 'talos_options': ['--xperf_path', 10:12:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:53 INFO - 'tests': ['tp5n']}}, 10:12:53 INFO - 'talos.zip': {'path': '', 10:12:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:53 INFO - Running post-action listener: _resource_record_post_action 10:12:53 INFO - ##### 10:12:53 INFO - ##### Running create-virtualenv step. 10:12:53 INFO - ##### 10:12:53 INFO - Running pre-action listener: _resource_record_pre_action 10:12:53 INFO - Running main action method: create_virtualenv 10:12:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:53 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 10:12:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:53 INFO - Using real prefix '/usr' 10:12:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:56 INFO - Installing pip.................done. 10:12:56 INFO - Return code: 0 10:12:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:56 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')]} 10:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:56 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')]} 10:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:56 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:12:56 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 10:12:56 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 10:12:56 INFO - Using env: {'DISPLAY': ':0', 10:12:56 INFO - 'HOME': '/home/cltbld', 10:12:56 INFO - 'LANG': 'en_US.UTF-8', 10:12:56 INFO - 'LANGUAGE': 'en_US:en', 10:12:56 INFO - 'LOGNAME': 'cltbld', 10:12:56 INFO - 'MAIL': '/var/mail/cltbld', 10:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:56 INFO - 'MOZ_NO_REMOTE': '1', 10:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:56 INFO - 'NO_EM_RESTART': '1', 10:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:56 INFO - 'PWD': '/builds/slave/test', 10:12:56 INFO - 'SHELL': '/bin/bash', 10:12:56 INFO - 'SHLVL': '1', 10:12:56 INFO - 'TERM': 'linux', 10:12:56 INFO - 'TMOUT': '86400', 10:12:56 INFO - 'USER': 'cltbld', 10:12:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:56 INFO - '_': '/tools/buildbot/bin/python'} 10:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:56 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 10:12:56 INFO - Cleaning up... 10:12:56 INFO - Return code: 0 10:12:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:56 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')]} 10:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:56 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')]} 10:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:56 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:12:56 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 10:12:56 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 10:12:56 INFO - Using env: {'DISPLAY': ':0', 10:12:56 INFO - 'HOME': '/home/cltbld', 10:12:56 INFO - 'LANG': 'en_US.UTF-8', 10:12:56 INFO - 'LANGUAGE': 'en_US:en', 10:12:56 INFO - 'LOGNAME': 'cltbld', 10:12:56 INFO - 'MAIL': '/var/mail/cltbld', 10:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:56 INFO - 'MOZ_NO_REMOTE': '1', 10:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:56 INFO - 'NO_EM_RESTART': '1', 10:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:56 INFO - 'PWD': '/builds/slave/test', 10:12:56 INFO - 'SHELL': '/bin/bash', 10:12:56 INFO - 'SHLVL': '1', 10:12:56 INFO - 'TERM': 'linux', 10:12:56 INFO - 'TMOUT': '86400', 10:12:56 INFO - 'USER': 'cltbld', 10:12:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:56 INFO - '_': '/tools/buildbot/bin/python'} 10:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:56 INFO - Downloading/unpacking psutil>=0.7.1 10:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:58 INFO - Installing collected packages: psutil 10:12:58 INFO - Running setup.py install for psutil 10:12:59 INFO - building 'psutil._psutil_linux' extension 10:12:59 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 10:12:59 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 10:12:59 INFO - building 'psutil._psutil_posix' extension 10:12:59 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 10:12:59 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 10:12:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:59 INFO - Successfully installed psutil 10:12:59 INFO - Cleaning up... 10:12:59 INFO - Return code: 0 10:12:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12:59 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')]} 10:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:59 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')]} 10:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:59 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:12:59 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 10:12:59 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 10:12:59 INFO - Using env: {'DISPLAY': ':0', 10:12:59 INFO - 'HOME': '/home/cltbld', 10:12:59 INFO - 'LANG': 'en_US.UTF-8', 10:12:59 INFO - 'LANGUAGE': 'en_US:en', 10:12:59 INFO - 'LOGNAME': 'cltbld', 10:12:59 INFO - 'MAIL': '/var/mail/cltbld', 10:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:59 INFO - 'MOZ_NO_REMOTE': '1', 10:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:59 INFO - 'NO_EM_RESTART': '1', 10:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:59 INFO - 'PWD': '/builds/slave/test', 10:12:59 INFO - 'SHELL': '/bin/bash', 10:12:59 INFO - 'SHLVL': '1', 10:12:59 INFO - 'TERM': 'linux', 10:12:59 INFO - 'TMOUT': '86400', 10:12:59 INFO - 'USER': 'cltbld', 10:12:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:59 INFO - '_': '/tools/buildbot/bin/python'} 10:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:13:01 INFO - Installing collected packages: mozsystemmonitor 10:13:01 INFO - Running setup.py install for mozsystemmonitor 10:13:01 INFO - Successfully installed mozsystemmonitor 10:13:01 INFO - Cleaning up... 10:13:01 INFO - Return code: 0 10:13:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:01 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:13:01 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 10:13:01 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 10:13:01 INFO - Using env: {'DISPLAY': ':0', 10:13:01 INFO - 'HOME': '/home/cltbld', 10:13:01 INFO - 'LANG': 'en_US.UTF-8', 10:13:01 INFO - 'LANGUAGE': 'en_US:en', 10:13:01 INFO - 'LOGNAME': 'cltbld', 10:13:01 INFO - 'MAIL': '/var/mail/cltbld', 10:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:01 INFO - 'MOZ_NO_REMOTE': '1', 10:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:01 INFO - 'NO_EM_RESTART': '1', 10:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:01 INFO - 'PWD': '/builds/slave/test', 10:13:01 INFO - 'SHELL': '/bin/bash', 10:13:01 INFO - 'SHLVL': '1', 10:13:01 INFO - 'TERM': 'linux', 10:13:01 INFO - 'TMOUT': '86400', 10:13:01 INFO - 'USER': 'cltbld', 10:13:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:01 INFO - '_': '/tools/buildbot/bin/python'} 10:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:03 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 10:13:03 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 10:13:03 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 10:13:03 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 10:13:03 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 10:13:03 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 10:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:04 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 10:13:04 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 10:13:04 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 10:13:04 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 10:13:04 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 10:13:04 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 10:13:04 INFO - Downloading docopt-0.6.1.tar.gz 10:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:04 INFO - Running setup.py install for blobuploader 10:13:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:04 INFO - Running setup.py install for requests 10:13:05 INFO - Running setup.py install for docopt 10:13:05 INFO - Successfully installed blobuploader requests docopt 10:13:05 INFO - Cleaning up... 10:13:05 INFO - Return code: 0 10:13:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:05 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')]} 10:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:05 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')]} 10:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:05 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:13:05 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 10:13:05 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 10:13:05 INFO - Using env: {'DISPLAY': ':0', 10:13:05 INFO - 'HOME': '/home/cltbld', 10:13:05 INFO - 'LANG': 'en_US.UTF-8', 10:13:05 INFO - 'LANGUAGE': 'en_US:en', 10:13:05 INFO - 'LOGNAME': 'cltbld', 10:13:05 INFO - 'MAIL': '/var/mail/cltbld', 10:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:05 INFO - 'MOZ_NO_REMOTE': '1', 10:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:05 INFO - 'NO_EM_RESTART': '1', 10:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:05 INFO - 'PWD': '/builds/slave/test', 10:13:05 INFO - 'SHELL': '/bin/bash', 10:13:05 INFO - 'SHLVL': '1', 10:13:05 INFO - 'TERM': 'linux', 10:13:05 INFO - 'TMOUT': '86400', 10:13:05 INFO - 'USER': 'cltbld', 10:13:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:05 INFO - '_': '/tools/buildbot/bin/python'} 10:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:05 INFO - Running setup.py (path:/tmp/pip-EO7aD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:05 INFO - Running setup.py (path:/tmp/pip-dVCKEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:05 INFO - Running setup.py (path:/tmp/pip-w9Pb9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:05 INFO - Running setup.py (path:/tmp/pip-6u2vuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:05 INFO - Running setup.py (path:/tmp/pip-9Vt6_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:05 INFO - Running setup.py (path:/tmp/pip-5laNLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:05 INFO - Running setup.py (path:/tmp/pip-_wFTUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:05 INFO - Running setup.py (path:/tmp/pip-Q8PcPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:06 INFO - Running setup.py (path:/tmp/pip-n4fFaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:06 INFO - Running setup.py (path:/tmp/pip-rsp4hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:06 INFO - Running setup.py (path:/tmp/pip-Tfa3GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:06 INFO - Running setup.py (path:/tmp/pip-q4b3Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:06 INFO - Running setup.py (path:/tmp/pip-TGPU86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:06 INFO - Running setup.py (path:/tmp/pip-2Yfh7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:06 INFO - Running setup.py (path:/tmp/pip-OwfLjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:06 INFO - Running setup.py (path:/tmp/pip-aDpEBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:06 INFO - Running setup.py (path:/tmp/pip-4EyJl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:06 INFO - Running setup.py install for manifestparser 10:13:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:06 INFO - Running setup.py install for mozcrash 10:13:06 INFO - Running setup.py install for mozdebug 10:13:07 INFO - Running setup.py install for mozdevice 10:13:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Running setup.py install for mozfile 10:13:07 INFO - Running setup.py install for mozhttpd 10:13:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Running setup.py install for mozinfo 10:13:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Running setup.py install for mozInstall 10:13:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Running setup.py install for mozleak 10:13:07 INFO - Running setup.py install for mozlog 10:13:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Running setup.py install for moznetwork 10:13:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:07 INFO - Running setup.py install for mozprocess 10:13:07 INFO - Running setup.py install for mozprofile 10:13:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:08 INFO - Running setup.py install for mozrunner 10:13:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:08 INFO - Running setup.py install for mozscreenshot 10:13:08 INFO - Running setup.py install for moztest 10:13:08 INFO - Running setup.py install for mozversion 10:13:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:08 INFO - Cleaning up... 10:13:08 INFO - Return code: 0 10:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:08 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:13:08 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 10:13:08 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 10:13:08 INFO - Using env: {'DISPLAY': ':0', 10:13:08 INFO - 'HOME': '/home/cltbld', 10:13:08 INFO - 'LANG': 'en_US.UTF-8', 10:13:08 INFO - 'LANGUAGE': 'en_US:en', 10:13:08 INFO - 'LOGNAME': 'cltbld', 10:13:08 INFO - 'MAIL': '/var/mail/cltbld', 10:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:08 INFO - 'MOZ_NO_REMOTE': '1', 10:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:08 INFO - 'NO_EM_RESTART': '1', 10:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:08 INFO - 'PWD': '/builds/slave/test', 10:13:08 INFO - 'SHELL': '/bin/bash', 10:13:08 INFO - 'SHLVL': '1', 10:13:08 INFO - 'TERM': 'linux', 10:13:08 INFO - 'TMOUT': '86400', 10:13:08 INFO - 'USER': 'cltbld', 10:13:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:08 INFO - '_': '/tools/buildbot/bin/python'} 10:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:08 INFO - Running setup.py (path:/tmp/pip-s721n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:08 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)) 10:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:08 INFO - Running setup.py (path:/tmp/pip-aoI_is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:08 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)) 10:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:08 INFO - Running setup.py (path:/tmp/pip-hz3Ljy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:08 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)) 10:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:08 INFO - Running setup.py (path:/tmp/pip-DIlSdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:09 INFO - Running setup.py (path:/tmp/pip-kKmeot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:09 INFO - Running setup.py (path:/tmp/pip-7CnP90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:09 INFO - Running setup.py (path:/tmp/pip-kl9rIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:09 INFO - Running setup.py (path:/tmp/pip-xQOOxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:09 INFO - Running setup.py (path:/tmp/pip-VkNFUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:09 INFO - Running setup.py (path:/tmp/pip-B_ti7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:09 INFO - Running setup.py (path:/tmp/pip-SMbQup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:09 INFO - Running setup.py (path:/tmp/pip-NHsx9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:09 INFO - Running setup.py (path:/tmp/pip-hWGXVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:09 INFO - Running setup.py (path:/tmp/pip-Udo9bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:09 INFO - Running setup.py (path:/tmp/pip-d2ARjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:09 INFO - Running setup.py (path:/tmp/pip-lFwoZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:09 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)) 10:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:09 INFO - Running setup.py (path:/tmp/pip-38n_67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:09 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)) 10:13:09 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)) 10:13:09 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)) 10:13:09 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)) 10:13:09 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)) 10:13:09 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)) 10:13:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:11 INFO - Downloading blessings-1.6.tar.gz 10:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:11 INFO - Installing collected packages: blessings 10:13:11 INFO - Running setup.py install for blessings 10:13:12 INFO - Successfully installed blessings 10:13:12 INFO - Cleaning up... 10:13:12 INFO - Return code: 0 10:13:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:12 INFO - Reading from file tmpfile_stdout 10:13:12 INFO - Current package versions: 10:13:12 INFO - argparse == 1.2.1 10:13:12 INFO - blessings == 1.6 10:13:12 INFO - blobuploader == 1.2.4 10:13:12 INFO - docopt == 0.6.1 10:13:12 INFO - manifestparser == 1.1 10:13:12 INFO - mozInstall == 1.12 10:13:12 INFO - mozcrash == 0.17 10:13:12 INFO - mozdebug == 0.1 10:13:12 INFO - mozdevice == 0.48 10:13:12 INFO - mozfile == 1.2 10:13:12 INFO - mozhttpd == 0.7 10:13:12 INFO - mozinfo == 0.9 10:13:12 INFO - mozleak == 0.1 10:13:12 INFO - mozlog == 3.1 10:13:12 INFO - moznetwork == 0.27 10:13:12 INFO - mozprocess == 0.22 10:13:12 INFO - mozprofile == 0.28 10:13:12 INFO - mozrunner == 6.11 10:13:12 INFO - mozscreenshot == 0.1 10:13:12 INFO - mozsystemmonitor == 0.0 10:13:12 INFO - moztest == 0.7 10:13:12 INFO - mozversion == 1.4 10:13:12 INFO - psutil == 3.1.1 10:13:12 INFO - requests == 1.2.3 10:13:12 INFO - wsgiref == 0.1.2 10:13:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:12 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')]} 10:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:12 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')]} 10:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:12 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:13:12 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 10:13:12 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 10:13:12 INFO - Using env: {'DISPLAY': ':0', 10:13:12 INFO - 'HOME': '/home/cltbld', 10:13:12 INFO - 'LANG': 'en_US.UTF-8', 10:13:12 INFO - 'LANGUAGE': 'en_US:en', 10:13:12 INFO - 'LOGNAME': 'cltbld', 10:13:12 INFO - 'MAIL': '/var/mail/cltbld', 10:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:12 INFO - 'MOZ_NO_REMOTE': '1', 10:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:12 INFO - 'NO_EM_RESTART': '1', 10:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:12 INFO - 'PWD': '/builds/slave/test', 10:13:12 INFO - 'SHELL': '/bin/bash', 10:13:12 INFO - 'SHLVL': '1', 10:13:12 INFO - 'TERM': 'linux', 10:13:12 INFO - 'TMOUT': '86400', 10:13:12 INFO - 'USER': 'cltbld', 10:13:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:12 INFO - '_': '/tools/buildbot/bin/python'} 10:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 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)) 10:13:12 INFO - Cleaning up... 10:13:12 INFO - Return code: 0 10:13:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:12 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')]} 10:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:12 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')]} 10:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:12 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:13:12 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 10:13:12 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 10:13:12 INFO - Using env: {'DISPLAY': ':0', 10:13:12 INFO - 'HOME': '/home/cltbld', 10:13:12 INFO - 'LANG': 'en_US.UTF-8', 10:13:12 INFO - 'LANGUAGE': 'en_US:en', 10:13:12 INFO - 'LOGNAME': 'cltbld', 10:13:12 INFO - 'MAIL': '/var/mail/cltbld', 10:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:12 INFO - 'MOZ_NO_REMOTE': '1', 10:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:12 INFO - 'NO_EM_RESTART': '1', 10:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:12 INFO - 'PWD': '/builds/slave/test', 10:13:12 INFO - 'SHELL': '/bin/bash', 10:13:12 INFO - 'SHLVL': '1', 10:13:12 INFO - 'TERM': 'linux', 10:13:12 INFO - 'TMOUT': '86400', 10:13:12 INFO - 'USER': 'cltbld', 10:13:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:12 INFO - '_': '/tools/buildbot/bin/python'} 10:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:12 INFO - Downloading/unpacking jsonschema 10:13:12 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 10:13:12 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 10:13:12 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 10:13:12 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 10:13:12 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 10:13:12 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 10:13:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:14 INFO - Downloading/unpacking functools32 (from jsonschema) 10:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:14 INFO - warning: no files found matching '*.txt' 10:13:14 INFO - no previously-included directories found matching 'build' 10:13:14 INFO - no previously-included directories found matching 'dist' 10:13:14 INFO - no previously-included directories found matching '.git*' 10:13:14 INFO - Installing collected packages: jsonschema, functools32 10:13:14 INFO - Running setup.py install for functools32 10:13:15 INFO - warning: no files found matching '*.txt' 10:13:15 INFO - no previously-included directories found matching 'build' 10:13:15 INFO - no previously-included directories found matching 'dist' 10:13:15 INFO - no previously-included directories found matching '.git*' 10:13:15 INFO - Successfully installed jsonschema functools32 10:13:15 INFO - Cleaning up... 10:13:15 INFO - Return code: 0 10:13:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:15 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 0x7fb90e858f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', '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 10:13:15 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 10:13:15 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 10:13:15 INFO - Using env: {'DISPLAY': ':0', 10:13:15 INFO - 'HOME': '/home/cltbld', 10:13:15 INFO - 'LANG': 'en_US.UTF-8', 10:13:15 INFO - 'LANGUAGE': 'en_US:en', 10:13:15 INFO - 'LOGNAME': 'cltbld', 10:13:15 INFO - 'MAIL': '/var/mail/cltbld', 10:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:15 INFO - 'MOZ_NO_REMOTE': '1', 10:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:15 INFO - 'NO_EM_RESTART': '1', 10:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:15 INFO - 'PWD': '/builds/slave/test', 10:13:15 INFO - 'SHELL': '/bin/bash', 10:13:15 INFO - 'SHLVL': '1', 10:13:15 INFO - 'TERM': 'linux', 10:13:15 INFO - 'TMOUT': '86400', 10:13:15 INFO - 'USER': 'cltbld', 10:13:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:15 INFO - '_': '/tools/buildbot/bin/python'} 10:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:15 INFO - Downloading/unpacking flake8 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:13:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:13:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:13:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:17 INFO - no previously-included directories found matching 'docs/_build' 10:13:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:13:18 INFO - Running setup.py install for pep8 10:13:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:18 INFO - no previously-included directories found matching 'docs/_build' 10:13:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:13:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:13:18 INFO - Cleaning up... 10:13:18 INFO - Return code: 0 10:13:18 INFO - Running post-action listener: _resource_record_post_action 10:13:18 INFO - Running post-action listener: _start_resource_monitoring 10:13:18 INFO - Starting resource monitoring. 10:13:18 INFO - ##### 10:13:18 INFO - ##### Running install step. 10:13:18 INFO - ##### 10:13:18 INFO - Running pre-action listener: _resource_record_pre_action 10:13:18 INFO - Running main action method: install 10:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:18 INFO - Reading from file tmpfile_stdout 10:13:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:18 INFO - Reading from file tmpfile_stdout 10:13:18 INFO - Output received: 10:13:18 INFO - Usage: mozinstall [options] installer 10:13:18 INFO - Options: 10:13:18 INFO - -h, --help show this help message and exit 10:13:18 INFO - -d DEST, --destination=DEST 10:13:18 INFO - Directory to install application into. [default: 10:13:18 INFO - "/builds/slave/test"] 10:13:18 INFO - --app=APP Application being installed. [default: firefox] 10:13:18 INFO - mkdir: /builds/slave/test/build/application 10:13:18 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'] 10:13:18 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 10:13:31 INFO - Reading from file tmpfile_stdout 10:13:31 INFO - Output received: 10:13:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:31 INFO - Running post-action listener: _resource_record_post_action 10:13:31 INFO - ##### 10:13:31 INFO - ##### Running run-tests step. 10:13:31 INFO - ##### 10:13:31 INFO - Running pre-action listener: _resource_record_pre_action 10:13:31 INFO - Running main action method: run_tests 10:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:31 INFO - Python 2.7.3 10:13:31 INFO - Return code: 0 10:13:31 INFO - grabbing minidump binary from tooltool 10:13:31 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')]} 10:13:31 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 0x14cb410>, '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 0x14cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:31 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 10:13:31 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 10:13:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:31 INFO - Return code: 0 10:13:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:32 INFO - Return code: 0 10:13:32 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/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:13:32 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/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 10:13:32 INFO - Using env: {'DISPLAY': ':0', 10:13:32 INFO - 'HOME': '/home/cltbld', 10:13:32 INFO - 'LANG': 'en_US.UTF-8', 10:13:32 INFO - 'LANGUAGE': 'en_US:en', 10:13:32 INFO - 'LOGNAME': 'cltbld', 10:13:32 INFO - 'MAIL': '/var/mail/cltbld', 10:13:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:32 INFO - 'MOZ_NO_REMOTE': '1', 10:13:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:32 INFO - 'NO_EM_RESTART': '1', 10:13:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:32 INFO - 'PWD': '/builds/slave/test', 10:13:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:32 INFO - 'SHELL': '/bin/bash', 10:13:32 INFO - 'SHLVL': '1', 10:13:32 INFO - 'TERM': 'linux', 10:13:32 INFO - 'TMOUT': '86400', 10:13:32 INFO - 'USER': 'cltbld', 10:13:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783', 10:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:32 INFO - '_': '/tools/buildbot/bin/python'} 10:13:32 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/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:13:32 INFO - mozversion application_buildid: 20160714110442 10:13:32 INFO - mozversion application_changeset: 8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5 10:13:32 INFO - mozversion application_display_name: Firefox 10:13:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:32 INFO - mozversion application_name: Firefox 10:13:32 INFO - mozversion application_remotingname: firefox 10:13:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:32 INFO - mozversion application_vendor: Mozilla 10:13:32 INFO - mozversion application_version: 48.0 10:13:32 INFO - mozversion platform_buildid: 20160714110442 10:13:32 INFO - mozversion platform_changeset: 8139a58cc0c18b47b6945f2a26fc347ef6f3a0b5 10:13:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:32 INFO - mozversion platform_version: 48.0 10:13:32 INFO - using testdate: 1468602812 10:13:32 INFO - actual date: 1468602812 10:13:32 INFO - starting webserver on 'localhost:45620' 10:13:32 INFO - SUITE-START | Running 2 tests 10:13:32 INFO - TEST-START | dromaeo_css 10:13:32 INFO - operating with platform_type : linux_ 10:13:32 INFO - Initialising browser for dromaeo_css test... 10:13:32 INFO - TEST-INFO | started process 18377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVX9QYA/profile http://localhost:45620/getInfo.html) 10:13:36 INFO - PROCESS | 18377 | __metrics Screen width/height:1600/1200 10:13:36 INFO - PROCESS | 18377 | colorDepth:24 10:13:36 INFO - PROCESS | 18377 | Browser inner width/height: 1024/697 10:13:36 INFO - PROCESS | 18377 | __metrics 10:13:37 INFO - PROCESS | 18377 | 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" 10:13:37 ERROR - PROCESS | 18377 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:13:38 INFO - TEST-INFO | 18377: exit 0 10:13:38 INFO - Browser initialized. 10:13:38 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:38 INFO - TEST-INFO | started process 18465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVX9QYA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:50 INFO - PROCESS | 18465 | RSS: Main: 139902976 10:13:50 INFO - PROCESS | 18465 | 10:14:41 INFO - PROCESS | 18465 | 1468602881296 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] 10:16:48 INFO - PROCESS | 18465 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45620/tests/dromaeo/cssquery-ext.html) 10:16:49 INFO - PROCESS | 18465 | RSS: Main: 250105856 10:16:49 INFO - PROCESS | 18465 | 10:19:52 INFO - PROCESS | 18465 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-ext.html (next: http://localhost:45620/tests/dromaeo/cssquery-jquery.html) 10:19:52 INFO - PROCESS | 18465 | RSS: Main: 220311552 10:19:52 INFO - PROCESS | 18465 | 10:22:54 INFO - PROCESS | 18465 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45620/tests/dromaeo/cssquery-mootools.html) 10:22:55 INFO - PROCESS | 18465 | RSS: Main: 218128384 10:22:55 INFO - PROCESS | 18465 | 10:25:56 INFO - PROCESS | 18465 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45620/tests/dromaeo/cssquery-prototype.html) 10:25:57 INFO - PROCESS | 18465 | RSS: Main: 217804800 10:25:57 INFO - PROCESS | 18465 | 10:28:59 INFO - PROCESS | 18465 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45620/tests/dromaeo/cssquery-yui.html) 10:29:00 INFO - PROCESS | 18465 | RSS: Main: 184168448 10:29:00 INFO - PROCESS | 18465 | 10:32:02 INFO - PROCESS | 18465 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-yui.html (next: http://localhost:45620/tests/dromaeo/cssquery-dojo.html) 10:32:03 INFO - PROCESS | 18465 | RSS: Main: 244256768 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | __start_tp_report 10:32:03 INFO - PROCESS | 18465 | _x_x_mozilla_page_load 10:32:03 INFO - PROCESS | 18465 | _x_x_mozilla_page_load_details 10:32:03 INFO - PROCESS | 18465 | |i|pagename|runs| 10:32:03 INFO - PROCESS | 18465 | |0;dojo.html;3297.9175520612;3305.305885763989;3311.7681762276643;3349.012041447773;3352.966470335299;5482.616216864821;5484.149956756704;5484.890302193959;5497.312835895513;5500.862478438036;5481;5485.177223416479;5507.228987941681;5510.448955104487;5540.307461567304;4959.925601115986;4984.975075124628;5055.494450554952;5099.566536844372;5133.82031628893;4955.405351357824;5029.47190544993;5054.039732450822;5058.51944065315;5064.721440320781;5043.092243396187;5079.238114282869;5145.485451454862;5159.664621799571;5166.07010738067;5139.640225184238;5162.92255616166;5172.689638621695;5173.637845350827;5200.817971370984;4890.657653964224;4988.152014157602;5069.771860266297;5071.137906555894;5074.4671809460215;5486.067368547357;5509.559235261169;5551.306086739158;5559.416261292587;5566.4990150886615;5960.582759206857;5999.430054144849;5999.880002399927;6000.519958403317;6003.759849606055;5978.671173085479;6023.6385816851125;6081.4624278900355;6088.1476593276975;6108.908366374508;5633.521150702195;5674.971625141848;5680.573956953245;5682.602217844711;5684.516816070639;5947.881042379215;6157.7229024694;6173.444390004921;6177;6182.876342473215;5784.248047753765;5848.122781582797;5858.56060795442;5866.530677545786;5866.70666466675;5938.376470470538;5942.049272116527;5956.285245770535;5959.195508606369;5972.402759723993;5752.827415177551;5844.970775146097;5929.229200204032;5936.050231962865;5938.970305148533;5948.8810223796145;5971.641701497924;5975.163477113208;5988.9101663475085;6015.939840601625;4570.542945705402;4578.5650363215445;4579.084183163381;4579.450465944042;4608.539146085364;3998.420229066769;4019.537753158366;4091.85678501251;4115.6295933365545;4141.151064031867;5640.5487560995025;5667.971660141673;5675.517581005661;5676.829695109153;5686.175504551817;5969.940300597025;5970;5974.671393073336;5977.98374276374;5978.970105149447;5540.501354878081;5604.663720176803;5654.236678048411;5686.772529098873;5741.5406767459335;5152.9742351288005;5154.252633368141;5186.325777648882;5186.481351864859;5187.118189907725;6250.499960003189;6267.059941008885;6273.341299163613;6274.811755647338;6281.623102613858;5774.653520788766;5981.700914954322;6031.849203769941;6093.177421048279;6101.725422356093;6154.580389856348;6188.721507532262;6202.596831205957;6210.161628180138;6212.223472065992;5865.354810970875;5868.295804503487;5868.94131058701;5870.677112758839;5899.557533185114;5751.223584815996;6011;6079.939200608114;6086.6348019119;6109.450149486567;5763.279590051244;5812;5812.070068788974;5823.039198532195;5826.766929322949;5653.038983372919;5772.018756811268;5801.129830525286;5826.359100499027;5831.271091113611;5712.02895507773;5747.913781293368;5788.855278618068;5810.709464526842;5817.156512305776;5836.795712150054;5837.270341207349;5855.473007429352;5862.501687356623;5867.413258674099;5557.5831812613405;5756.2229099072765;5756.597038207286;5772.624779389326;5774.3648198697265 10:32:03 INFO - PROCESS | 18465 | |1;ext.html;657.2540166910555;665.1818263535848;675.1223409567561;735.2830989784957;743.9590822504764;31106.844465777667;31565;31626.683733162663;31674.524882126785;31679;30862.074137775846;38720.99999999993;39185.412218816666;39273.803630981805;39360.606393936054;9097.909020909805;9249.35254532183;9281.257499400066;9289.256859451261;9291.674791382304;8874.556272186364;9078.455292682427;9097.090290970884;9098.044705305947;9102.908970910272;9133.771655708593;9193.310501712398;9208.49353285569;9213.493257870814;9214.308926830481;9103.681371152012;9176.724698259062;9179.908200917973;9181.35730498862;9186.265098792113;9075.682351117679;9171.954140229323;9193.908060919372;9202;9206.079392060807;42386.364204536956;42762.78618606887;42958;43002.78498607518;43186.35220471695;3618.583862855779;3879.573246942834;4038.1318016626274;4298.656107511391;4603.631709463235;33500.66499335;34163.487547686804;34261.65738342609;34263.657363426544;34376.31247375038;4254.87235382939;4261.382099595541;4276.102018576103;4281.871543853689;4302.945778284309;313271;315777;315847;316699;317442;60330;61183.38816611866;61237.38762612406;61263.69368153131;61407;73583.63208183924;75089.62455187688;75108.62445687846;75320.24679753132;75375.62312188404;16270.511884643243;16295.348186072424;16307.83692163087;16308;16308.673826523403;15103.697926041417;15230.314635841414;15280.083195008336;15283.38866445352;15286.235688215545;20659.276925307542;20956.68564971496;21009.47476313074;21011;21071.78928210729;7421.888671669929;7452.366548843301;7530.6611202496015;7635.732749353857;7693.961530192425;1083.2579682917226;1115.3475216997986;1132.7564573616712;1134.6312448454285;1192.1476144556684;32353.35293294121;33101.503477447855;33239.66760332414;33434;33859;1198.4427241332821;1242.2484396939901;1242.3601845049807;1279.9808002879963;1303.5242136620066;17508.824911750973;17904.91047544754;17905.910470447565;17927.820721792614;18159;524659;525877;527764;533682;533839;61564.38435615676;62264;62365;62395;62580;1394.2262044565364;1510.6827566211;1533.363654083565;1605;1610.9597260068358;30107.63419344201;31964;32697.673023269464;32969.835150824096;32991.50512742263;41676.79161604172;41718.58281417147;41879.58120418757;41909.79045104755;41915.7904210477;256241;256303;257045;257063;257113;29969.850150749106;45840;46050.769746151054;46069.76965115153;46876.062478750915;42939.141217176104;43430.78284608557;43720.562794371646;43865.56134438615;43866.56133438752;36374;36497.635023649425;36593.45109823302;36722.63277367192;37113;35223.64776352306;36514.452283216306;36588.26823463463;36789;37308.25383492369;41782;41846.58153418548;41895.162096758504;42804.78597606992;42935.78532107444;34970;36407.63592364149;37339.6266037347;37347.253054938206;37498.8125059373;28272.1212783505;28689.56965645475;28799.848668129973;28836.855815721625;29012.709872901 10:32:03 INFO - PROCESS | 18465 | |2;jquery.html;429.51035819166134;430.9116631090625;437.1453807805738;440.00911730603417;442.7520588470457;18458.446246612606;18666.066696665148;18742.53143671409;19247.903760481197;19279.686437627504;18596;18858.245670173175;19828.107735151916;19911.104000319985;19932.70100948487;5615.157726341061;5787.392323805992;5877.382874798149;5884.499817515516;6052.334243233241;5821.126830975367;5839.445252700986;5846.590738648296;5872.823815285548;6321.1150438938585;6672.866542669144;6680.66596670167;6681.498887583451;6703.229128650194;6728.461723062168;5969.910451343233;6006.099085137221;6362.0774987627;6672.866542669168;6679.031540426635;5820.563457740686;5827.854303642401;5834.912476312858;5842.328132264802;5861.9706901465215;14254.14475131485;19825.30611428593;23711.407214819596;23946.52106957851;24124.87937560301;2513.2661084927736;2529.936751581207;2573.729758375381;2885.3075261937192;3071.692830716933;10245.077942985092;10344.275900686955;10358.378497290187;13577.642235776442;13795.896328293713;2047.4471892589067;2049.6105739909517;2070.606584748893;2106.24175296893;2173.6739489076763;61517;68481.31518684799;82322.17677823205;84376;86553.56723216343;11488.540458381738;11542.249753765978;11809.173357865038;11861.822072668916;12044.457999390048;13929.373178207004;15513.767293490606;16155.757663635055;16252.18739063042;16999.49001529956;8604.13958604147;8780.736577902673;8953.641854325884;9072.727818165333;9097.590608422504;8676.783080422914;8685.557122286345;8732.039475657673;8819.11808819113;8841.69054083104;5022.347094877642;5063.645544811901;5134.845954621367;5154.458781827854;5223.4515375884985;2092.884891330961;2131.1368895597307;2182.8690278583335;2185.715856938588;2193.473566344066;1022.3559157730582;1047.1151876664208;1076.278893141597;1115.6876074698935;1143.8684551276542;18832.587555933358;19602;19940.102695378744;20055.59888802245;20135.798642013393;1076.1337123615565;1077.1329080090445;1085.7991271614776;1105.6406667832825;1108.3793075877534;10915;11425.60010399632;11435.885641143648;11536;11556.133290003283;583130;588972;610936;619592;621062;57472;59557;107402;107822.46088769507;109686;1123;1124.685088175296;1148.661144962238;1162.7790719763218;1164.8660404053473;17926;17976.550586235448;17977.910110449364;18292.359767408077;18818.52953676169;41275.58724412838;41950.58049419467;42356.57643423526;42809.785951070044;43740;59882.706451145605;63301;63893.680531598904;63909;64413.677931611914;9237.630494780133;9296.535173241176;9337.112974267433;9402.52987350616;9449.669261575811;13181.802272966104;13843.377048032662;14034.087784293988;14070.507532236323;14382.496612618508;11686.532538698697;12200.816987745013;12341.853860057032;12359.443825028075;12500.687482813002;11672;11673.649790506299;11906.464209110438;11946.163768536466;12017;11825.172237943261;12244.877551224374;12385.071119665881;12428.875711243134;12899.548515801902;8709.956450217709;8875.822483550164;9087.09129087086;9136.908630913871;9379.249660027317;11443.713907152387;11974.820377694168;11986.820197696867;12081.57714479989;12371.69070773238 10:32:03 INFO - PROCESS | 18465 | |3;mootools.html;1392.7980442835783;1561.1257695690415;1596.872250219982;1788.946331610052;1891.2624076610116;7264.237255088212;8032.799180020503;8181.795455113618;8200.179982001797;8210.30212431944;8105.716299929503;8143.877841832377;8182.95908520458;8199.877001844978;8202.548859812709;2384.2966324934187;2402.0872068613903;2403.6034054381007;2412.348665860217;2418.9153379631716;2384.201292566992;2401.5317013182434;2423.3456966619;2432.0514999150346;2442.46265821519;2425.369403954967;2459.56957532432;2459.8524088554655;2461.1509029384833;2480.851148931061;2390.2470721722602;2396.197273913241;2403.158894386959;2404.1104791227185;2441.414060625455;2377.9048838046456;2434.7686969737847;2443.511297740459;2447.4737931344666;2455.373879660693;7990;8254.54599997;8317;8318.209770071893;8328.167183281623;5220.295260139908;5293.920591191135;5296.046711591912;5324.520793128599;5339.866503337409;3643.8542458301636;3719.516462859838;3730.1047748540427;3746.082209858575;3779.9055023624355;1157.7568710570706;1208;1211.8666946635863;1214.489914236023;1278.603632873812;11183.83224251637;11288.604898828584;11590.072794176445;11625.24435911663;11660.59187928427;4439.245328294133;4525.660575456854;4601.7699115044115;4607.170709272296;4706.294055891643;9372.90627093734;9390.577424015935;9395.671151509665;9413;9416.576254068446;5173.715445650525;5179.04187725272;5208.348956380452;5216.921746173811;5220.347456567929;4222.978885105555;4577.244754615518;4720.079584480994;4732.834350797705;4836.202026665561;3856.0745421098736;3871.3031654302495;3934.2918274710255;3963.405489176589;3972.2055588881763;1197.7245233596148;1201.3152503073338;1201.615483045417;1212;1226.1110694746237;954.665866946577;1047.701405099543;1056.5192837259028;1064.7763969566322;1077.1490522487304;5983.521318294526;5993.640381577119;6020.09698545213;6084.817455476343;6124.418180272867;489.82611173033774;493.26257245418327;495.9330490383824;496.83604410544433;503.7833731495492;4111.938320925188;4225.9577404226175;4242.724222925562;4255.574442555781;4292.356146577976;10042.246831487668;10060.446675432922;10255.128314093387;10312.175025997902;10323;10210.897891021143;10289.125424338865;10340.638077667245;10357.171426285879;10362.948185259176;7897.091834438998;7979.441439099207;8006.239407256301;8025.7993550160545;8036.839263214703;5861.3845546217035;5867.210500797298;5963.314218864886;6015.969920150371;6064.818055458343;8773.780655483664;8838.64645414202;8934.329925255503;8943.463392196489;8973.955130224307;8717.389782715149;9083;9091.227245683926;9096.135867092615;9110.90889091127;6458.38645328693;6583.341665833378;6591.274959754519;7339.77980660581;7442.255774422514;7616.276453736886;7846.725364612211;7849.293563579077;7849.372050236082;7858.253465920729;6846.383825455733;7016.087908571853;7073.823154420975;7117.3238542338395;7154.928450715426;6927.653617319214;7030.578165310098;7049.2950704931145;7091.1490621125795;7165.24764899678;6689.297623749436;6720.1599800025;6742.258351581224;6887.552309099892;6901.275366086488;5204.193350030751;5229.712365819764;5244.580433565382;5248.475152484721;5254.290670759551;5149.536541711264;5169.4830516948;5194.532492075731;5225.477452254744;5323.1749078892835 10:32:03 INFO - PROCESS | 18465 | |4;prototype.html;347.57595733205494;358.2852209841367;360.04946940078213;361.34235691042295;361.87696183297675;5888.735006924688;6039.365866584011;6049.5160387169035;6110.908336374958;6134.938650613492;6024.728887200075;6111.1138884861775;6112.908306375408;6120.755169793214;6138.079288106786;4716.1982462981205;4729.739864307453;4752.59602933751;4758.476567577563;4768.094062128202;4448.154850578396;4527.547245275463;4688.062387522492;4714.834980775673;4716.764161791897;4668.36977008103;4682.344471773954;4702.412198475191;4708.270218116198;4709.081729062834;4686.039361930796;4689.624830013608;4689.929651055237;4694.718316900963;4699.365585645963;4095.447114639545;4104.979475102636;4130.731502452331;4137.234611596864;4147.04617937876;5813.302403711539;5816.331121920991;5822;5837.299524057098;5840.240768700041;5385.865353366158;5435.374931882805;5440.700761458118;5441;5441.83674489766;6179.814605561795;6361.872762544769;6370.936290637081;6405.135306733578;6415.518836087265;4498.50516443191;4511.729296242236;4513.954860451419;4517.728936263802;4520.141173177086;6644.036614690843;6719.193696756421;6723.394894459522;6726.327367263283;6728;4606.677532572755;4607.493175750665;4609.446866376056;4609.884752881205;4610.423697037871;4671.85984420468;4673.345731597579;4673.883152921204;4674.509176536482;4676.742779147179;5193.169092945111;5346.652467589594;5353.250544923714;5354.196870469461;5390.51485366319;6390.360963903572;6446.838829029218;6474.611523308617;6503;6523.18460192476;1541.992290038565;1596.728556145458;1624.1473226556152;1631.820499745027;1636.2473262299475;1075.3440401355167;1091.4270008245576;1097.8023955688052;1102.525913857049;1109.0351394287022;6214.689265536705;6223.782167624202;6236.345183755731;6240.032794916795;6242.812715618538;6574;6580.835479112965;6583.539152259392;6587.571807832475;6587.934120658828;6217.440430361289;6220.937790622126;6221.253449586078;6222;6223.408776166348;3525.383057964846;3556.395412779834;3557.075160458248;3557.679808817219;3558.5551806024246;6650.600963942179;6835.760748373783;6861.2795656455355;6877.518573699793;6888.793336199922;6649.3018233085795;6663.766768163188;6670.433013193836;6682.231543372477;6694.330566943364;6816.931830681629;6846.965765171142;6851;6857.142857142758;6861.142357205349;6560.639164845788;6563.704633291418;6566.4418524424045;6574.3754343337305;6577.112089867998;6258.968705156445;6402.935970640234;6420.26166990802;6430.742770289136;6460.773872914426;6795.3204679531655;6818.727250910107;6822.795316140524;6827.897581536182;6832.145981752281;4587.63298936091;4594.47163576193;4597.057603191404;4600.21796294624;4602.493725690105;6397.840053998687;6490.870182596227;6538.444232240123;6539.574927629879;6540.313267106885;6329.936700633119;6395.328490508429;6406.519511036598;6445.581037232752;6491.935080649133;6439.7424103035355;6475.09348691193;6480.57876238043;6510.869782604416;6515.250746164252;6402.6158430494315;6411.0383442484;6418.390252925965;6418.6469744164515;6421.646809425526;6408.102865598913;6538;6543.5419520633095;6554.344565543408;6567.835804104936;6380.776672816429;6388.840278993062;6399.2640846303275;6413;6422.3577642235405 10:32:03 INFO - PROCESS | 18465 | |5;yui.html;911.5715613661578;912.9589168487415;923.5705396990402;928.4104593583073;953.6042542344927;13964.092333998296;14165.78751318731;14175.71648567028;14183.929080354597;14185.71628567428;13553.186808791479;13621.591352259424;13629.795553066711;13635.113717608348;13646.2494562799;725.2095216214325;865.1780808232173;889.0575989451203;889.9243564297043;894.1639567004838;880.8502554565707;881.5151666583386;887.2591386192537;887.2813021452644;889.2041622747637;762.9618519074052;934.9252059835231;937.357909831764;937.7655586103474;938.3431597881477;922.5940586142076;932.9393589416666;934.3786382055924;934.7008957133754;935.6210734652477;684.3122661724984;688.7245101959206;688.7761477519776;689.2693744630658;689.9206591242021;14440.277986100758;14508.927455362762;14544;14565.635859103608;14572.198529081003;13757.587272381845;13973.790393144009;14018.92990535051;14371.928140359336;14561.78157327641;11526.654200374001;11624.476898539586;11632.651020469399;11836.171467997243;11896;3969.7221194516396;3997.8600748973936;4004.4193591929006;4012.478377810895;4094.1402305515876;52838.47161528374;52985;53038;53077;53265.46734532644;11403.543858245577;11589.420528973518;11715.76568468626;11716.648500544998;11961.222520536137;19686.70469942952;19796.802031979783;19821.900890495453;19863.503412414517;19890.50273743139;8000.5599692017495;8089.676412943534;8263.380246481538;8277.917220827836;8520.616572254263;5037.823676171316;5106.591472682177;5125.897482050338;5166.302549155891;5400.0819860623005;3446.5691788526433;3493.406120959443;3495.3708332500396;3500.632433594487;3501.2122272488486;633.740166531729;648.0829626079045;650.2976785072111;655.3872129558878;665.5308007854451;782.7456076774957;808.6765293882494;811.6509900742619;812.3176531713389;822.5804839531762;9385.296102792317;9580.76048098803;9600.183984361267;9924.553395097239;9954;654.8853950558633;752.751591974647;778.2334400615389;818.4925346285341;849.9872501912477;4296.570342965679;4314.870553883388;4346.434963454793;4391.560843915583;4549.7042692224895;60936;62249.68875155595;67411;67475.32524674789;68042.65978670075;49903.75048124736;50326.24510632343;50825.23762143571;51002;52159.47840521622;48162.51837481651;50252;51819;52128.218076728124;52332;10138.847917281098;10321.63874264397;10339.121174699934;10370.377777333384;10426.27016108865;37488.62511374961;38256.80871595624;38301.61698382981;38376.6162338373;39170.41244381393;46103.53896460992;48649.270260946825;48793.756031219615;49839.50160498349;50343.244851326526;12369.752604948031;12524.686882827638;12858.742825143632;12946.287954162612;13108.147970381895;13577.389017494039;13729.313534323044;13854.099483533539;14220.928895355457;14376.209308488134;13117.475300987853;13236.801447978096;13254.867451325748;13309.267990260629;13367.732645347232;12691.492340306653;13166.934165329112;13369.39837707325;13464.394102265618;13551.52569660057;12692.746145076862;13284.402201901132;13390;13428.798568021291;13431.731365372832;10881.183911206534;11108.666739997812;11499.770004600028;11585.88414115848;11608.6517404478;11349.54601815918;11434.512473695602;11515.154532915749;11574.768504629692;11598.768024639628 10:32:03 INFO - PROCESS | 18465 | __end_tp_report 10:32:03 INFO - PROCESS | 18465 | __start_cc_report 10:32:03 INFO - PROCESS | 18465 | _x_x_mozilla_cycle_collect,811 10:32:03 INFO - PROCESS | 18465 | __end_cc_report 10:32:03 INFO - PROCESS | 18465 | __startTimestamp1468603923175__endTimestamp 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | ------- Summary: start ------- 10:32:03 INFO - PROCESS | 18465 | Number of tests: 6 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | [#0] dojo.html Cycles:165 Average:5549.78 Median:5756.60 stddev:622.91 (10.8%) stddev-sans-first:599.25 10:32:03 INFO - PROCESS | 18465 | Values: 3297.9 3305.3 3311.8 3349.0 3353.0 5482.6 5484.1 5484.9 5497.3 5500.9 5481.0 5485.2 5507.2 5510.4 5540.3 4959.9 4985.0 5055.5 5099.6 5133.8 4955.4 5029.5 5054.0 5058.5 5064.7 5043.1 5079.2 5145.5 5159.7 5166.1 5139.6 5162.9 5172.7 5173.6 5200.8 4890.7 4988.2 5069.8 5071.1 5074.5 5486.1 5509.6 5551.3 5559.4 5566.5 5960.6 5999.4 5999.9 6000.5 6003.8 5978.7 6023.6 6081.5 6088.1 6108.9 5633.5 5675.0 5680.6 5682.6 5684.5 5947.9 6157.7 6173.4 6177.0 6182.9 5784.2 5848.1 5858.6 5866.5 5866.7 5938.4 5942.0 5956.3 5959.2 5972.4 5752.8 5845.0 5929.2 5936.1 5939.0 5948.9 5971.6 5975.2 5988.9 6015.9 4570.5 4578.6 4579.1 4579.5 4608.5 3998.4 4019.5 4091.9 4115.6 4141.2 5640.5 5668.0 5675.5 5676.8 5686.2 5969.9 5970.0 5974.7 5978.0 5979.0 5540.5 5604.7 5654.2 5686.8 5741.5 5153.0 5154.3 5186.3 5186.5 5187.1 6250.5 6267.1 6273.3 6274.8 6281.6 5774.7 5981.7 6031.8 6093.2 6101.7 6154.6 6188.7 6202.6 6210.2 6212.2 5865.4 5868.3 5868.9 5870.7 5899.6 5751.2 6011.0 6079.9 6086.6 6109.5 5763.3 5812.0 5812.1 5823.0 5826.8 5653.0 5772.0 5801.1 5826.4 5831.3 5712.0 5747.9 5788.9 5810.7 5817.2 5836.8 5837.3 5855.5 5862.5 5867.4 5557.6 5756.2 5756.6 5772.6 5774.4 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | [#1] ext.html Cycles:180 Average:54365.08 Median:39229.61 stddev:102209.36 (260.5%) stddev-sans-first:102416.54 10:32:03 INFO - PROCESS | 18465 | Values: 657.3 665.2 675.1 735.3 744.0 31106.8 31565.0 31626.7 31674.5 31679.0 30862.1 38721.0 39185.4 39273.8 39360.6 9097.9 9249.4 9281.3 9289.3 9291.7 8874.6 9078.5 9097.1 9098.0 9102.9 9133.8 9193.3 9208.5 9213.5 9214.3 9103.7 9176.7 9179.9 9181.4 9186.3 9075.7 9172.0 9193.9 9202.0 9206.1 42386.4 42762.8 42958.0 43002.8 43186.4 3618.6 3879.6 4038.1 4298.7 4603.6 33500.7 34163.5 34261.7 34263.7 34376.3 4254.9 4261.4 4276.1 4281.9 4302.9 313271.0 315777.0 315847.0 316699.0 317442.0 60330.0 61183.4 61237.4 61263.7 61407.0 73583.6 75089.6 75108.6 75320.2 75375.6 16270.5 16295.3 16307.8 16308.0 16308.7 15103.7 15230.3 15280.1 15283.4 15286.2 20659.3 20956.7 21009.5 21011.0 21071.8 7421.9 7452.4 7530.7 7635.7 7694.0 1083.3 1115.3 1132.8 1134.6 1192.1 32353.4 33101.5 33239.7 33434.0 33859.0 1198.4 1242.2 1242.4 1280.0 1303.5 17508.8 17904.9 17905.9 17927.8 18159.0 524659.0 525877.0 527764.0 533682.0 533839.0 61564.4 62264.0 62365.0 62395.0 62580.0 1394.2 1510.7 1533.4 1605.0 1611.0 30107.6 31964.0 32697.7 32969.8 32991.5 41676.8 41718.6 41879.6 41909.8 41915.8 256241.0 256303.0 257045.0 257063.0 257113.0 29969.9 45840.0 46050.8 46069.8 46876.1 42939.1 43430.8 43720.6 43865.6 43866.6 36374.0 36497.6 36593.5 36722.6 37113.0 35223.6 36514.5 36588.3 36789.0 37308.3 41782.0 41846.6 41895.2 42804.8 42935.8 34970.0 36407.6 37339.6 37347.3 37498.8 28272.1 28689.6 28799.8 28836.9 29012.7 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | [#2] jquery.html Cycles:180 Average:32445.60 Median:2152.41 stddev:99177.44 (4607.7%) stddev-sans-first:99426.52 10:32:03 INFO - PROCESS | 18465 | Values: 429.5 430.9 437.1 440.0 442.8 18458.4 18666.1 18742.5 19247.9 19279.7 18596.0 18858.2 19828.1 19911.1 19932.7 5615.2 5787.4 5877.4 5884.5 6052.3 5821.1 5839.4 5846.6 5872.8 6321.1 6672.9 6680.7 6681.5 6703.2 6728.5 5969.9 6006.1 6362.1 6672.9 6679.0 5820.6 5827.9 5834.9 5842.3 5862.0 14254.1 19825.3 23711.4 23946.5 24124.9 2513.3 2529.9 2573.7 2885.3 3071.7 10245.1 10344.3 10358.4 13577.6 13795.9 2047.4 2049.6 2070.6 2106.2 2173.7 61517.0 68481.3 82322.2 84376.0 86553.6 11488.5 11542.2 11809.2 11861.8 12044.5 13929.4 15513.8 16155.8 16252.2 16999.5 8604.1 8780.7 8953.6 9072.7 9097.6 8676.8 8685.6 8732.0 8819.1 8841.7 5022.3 5063.6 5134.8 5154.5 5223.5 2092.9 2131.1 2182.9 2185.7 2193.5 1022.4 1047.1 1076.3 1115.7 1143.9 18832.6 19602.0 19940.1 20055.6 20135.8 1076.1 1077.1 1085.8 1105.6 1108.4 10915.0 11425.6 11435.9 11536.0 11556.1 583130.0 588972.0 610936.0 619592.0 621062.0 57472.0 59557.0 107402.0 107822.5 109686.0 1123.0 1124.7 1148.7 1162.8 1164.9 17926.0 17976.6 17977.9 18292.4 18818.5 41275.6 41950.6 42356.6 42809.8 43740.0 59882.7 63301.0 63893.7 63909.0 64413.7 9237.6 9296.5 9337.1 9402.5 9449.7 13181.8 13843.4 14034.1 14070.5 14382.5 11686.5 12200.8 12341.9 12359.4 12500.7 11672.0 11673.6 11906.5 11946.2 12017.0 11825.2 12244.9 12385.1 12428.9 12899.5 8710.0 8875.8 9087.1 9136.9 9379.2 11443.7 11974.8 11986.8 12081.6 12371.7 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | [#3] mootools.html Cycles:180 Average:5526.65 Median:5171.60 stddev:2965.00 (57.3%) stddev-sans-first:2957.04 10:32:03 INFO - PROCESS | 18465 | Values: 1392.8 1561.1 1596.9 1788.9 1891.3 7264.2 8032.8 8181.8 8200.2 8210.3 8105.7 8143.9 8183.0 8199.9 8202.5 2384.3 2402.1 2403.6 2412.3 2418.9 2384.2 2401.5 2423.3 2432.1 2442.5 2425.4 2459.6 2459.9 2461.2 2480.9 2390.2 2396.2 2403.2 2404.1 2441.4 2377.9 2434.8 2443.5 2447.5 2455.4 7990.0 8254.5 8317.0 8318.2 8328.2 5220.3 5293.9 5296.0 5324.5 5339.9 3643.9 3719.5 3730.1 3746.1 3779.9 1157.8 1208.0 1211.9 1214.5 1278.6 11183.8 11288.6 11590.1 11625.2 11660.6 4439.2 4525.7 4601.8 4607.2 4706.3 9372.9 9390.6 9395.7 9413.0 9416.6 5173.7 5179.0 5208.3 5216.9 5220.3 4223.0 4577.2 4720.1 4732.8 4836.2 3856.1 3871.3 3934.3 3963.4 3972.2 1197.7 1201.3 1201.6 1212.0 1226.1 954.7 1047.7 1056.5 1064.8 1077.1 5983.5 5993.6 6020.1 6084.8 6124.4 489.8 493.3 495.9 496.8 503.8 4111.9 4226.0 4242.7 4255.6 4292.4 10042.2 10060.4 10255.1 10312.2 10323.0 10210.9 10289.1 10340.6 10357.2 10362.9 7897.1 7979.4 8006.2 8025.8 8036.8 5861.4 5867.2 5963.3 6016.0 6064.8 8773.8 8838.6 8934.3 8943.5 8974.0 8717.4 9083.0 9091.2 9096.1 9110.9 6458.4 6583.3 6591.3 7339.8 7442.3 7616.3 7846.7 7849.3 7849.4 7858.3 6846.4 7016.1 7073.8 7117.3 7154.9 6927.7 7030.6 7049.3 7091.1 7165.2 6689.3 6720.2 6742.3 6887.6 6901.3 5204.2 5229.7 5244.6 5248.5 5254.3 5149.5 5169.5 5194.5 5225.5 5323.2 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | [#4] prototype.html Cycles:180 Average:5389.52 Median:6197.25 stddev:1607.42 (25.9%) stddev-sans-first:1566.75 10:32:03 INFO - PROCESS | 18465 | Values: 347.6 358.3 360.0 361.3 361.9 5888.7 6039.4 6049.5 6110.9 6134.9 6024.7 6111.1 6112.9 6120.8 6138.1 4716.2 4729.7 4752.6 4758.5 4768.1 4448.2 4527.5 4688.1 4714.8 4716.8 4668.4 4682.3 4702.4 4708.3 4709.1 4686.0 4689.6 4689.9 4694.7 4699.4 4095.4 4105.0 4130.7 4137.2 4147.0 5813.3 5816.3 5822.0 5837.3 5840.2 5385.9 5435.4 5440.7 5441.0 5441.8 6179.8 6361.9 6370.9 6405.1 6415.5 4498.5 4511.7 4514.0 4517.7 4520.1 6644.0 6719.2 6723.4 6726.3 6728.0 4606.7 4607.5 4609.4 4609.9 4610.4 4671.9 4673.3 4673.9 4674.5 4676.7 5193.2 5346.7 5353.3 5354.2 5390.5 6390.4 6446.8 6474.6 6503.0 6523.2 1542.0 1596.7 1624.1 1631.8 1636.2 1075.3 1091.4 1097.8 1102.5 1109.0 6214.7 6223.8 6236.3 6240.0 6242.8 6574.0 6580.8 6583.5 6587.6 6587.9 6217.4 6220.9 6221.3 6222.0 6223.4 3525.4 3556.4 3557.1 3557.7 3558.6 6650.6 6835.8 6861.3 6877.5 6888.8 6649.3 6663.8 6670.4 6682.2 6694.3 6816.9 6847.0 6851.0 6857.1 6861.1 6560.6 6563.7 6566.4 6574.4 6577.1 6259.0 6402.9 6420.3 6430.7 6460.8 6795.3 6818.7 6822.8 6827.9 6832.1 4587.6 4594.5 4597.1 4600.2 4602.5 6397.8 6490.9 6538.4 6539.6 6540.3 6329.9 6395.3 6406.5 6445.6 6491.9 6439.7 6475.1 6480.6 6510.9 6515.3 6402.6 6411.0 6418.4 6418.6 6421.6 6408.1 6538.0 6543.5 6554.3 6567.8 6380.8 6388.8 6399.3 6413.0 6422.4 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - PROCESS | 18465 | [#5] yui.html Cycles:180 Average:15242.18 Median:4305.72 stddev:17286.99 (401.5%) stddev-sans-first:17301.98 10:32:03 INFO - PROCESS | 18465 | Values: 911.6 913.0 923.6 928.4 953.6 13964.1 14165.8 14175.7 14183.9 14185.7 13553.2 13621.6 13629.8 13635.1 13646.2 725.2 865.2 889.1 889.9 894.2 880.9 881.5 887.3 887.3 889.2 763.0 934.9 937.4 937.8 938.3 922.6 932.9 934.4 934.7 935.6 684.3 688.7 688.8 689.3 689.9 14440.3 14508.9 14544.0 14565.6 14572.2 13757.6 13973.8 14018.9 14371.9 14561.8 11526.7 11624.5 11632.7 11836.2 11896.0 3969.7 3997.9 4004.4 4012.5 4094.1 52838.5 52985.0 53038.0 53077.0 53265.5 11403.5 11589.4 11715.8 11716.6 11961.2 19686.7 19796.8 19821.9 19863.5 19890.5 8000.6 8089.7 8263.4 8277.9 8520.6 5037.8 5106.6 5125.9 5166.3 5400.1 3446.6 3493.4 3495.4 3500.6 3501.2 633.7 648.1 650.3 655.4 665.5 782.7 808.7 811.7 812.3 822.6 9385.3 9580.8 9600.2 9924.6 9954.0 654.9 752.8 778.2 818.5 850.0 4296.6 4314.9 4346.4 4391.6 4549.7 60936.0 62249.7 67411.0 67475.3 68042.7 49903.8 50326.2 50825.2 51002.0 52159.5 48162.5 50252.0 51819.0 52128.2 52332.0 10138.8 10321.6 10339.1 10370.4 10426.3 37488.6 38256.8 38301.6 38376.6 39170.4 46103.5 48649.3 48793.8 49839.5 50343.2 12369.8 12524.7 12858.7 12946.3 13108.1 13577.4 13729.3 13854.1 14220.9 14376.2 13117.5 13236.8 13254.9 13309.3 13367.7 12691.5 13166.9 13369.4 13464.4 13551.5 12692.7 13284.4 13390.0 13428.8 13431.7 10881.2 11108.7 11499.8 11585.9 11608.7 11349.5 11434.5 11515.2 11574.8 11598.8 10:32:03 INFO - PROCESS | 18465 | -------- Summary: end -------- 10:32:03 INFO - PROCESS | 18465 | 10:32:03 INFO - TEST-INFO | 18465: exit 0 10:32:03 INFO - TEST-OK | dromaeo_css | took 1110908ms 10:32:03 INFO - TEST-START | kraken 10:32:03 INFO - operating with platform_type : linux_ 10:32:03 INFO - Initialising browser for kraken test... 10:32:03 INFO - TEST-INFO | started process 18669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvr2wZv/profile http://localhost:45620/getInfo.html) 10:32:07 INFO - PROCESS | 18669 | __metrics Screen width/height:1600/1200 10:32:07 INFO - PROCESS | 18669 | colorDepth:24 10:32:07 INFO - PROCESS | 18669 | Browser inner width/height: 1024/697 10:32:07 INFO - PROCESS | 18669 | __metrics 10:32:08 INFO - PROCESS | 18669 | 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" 10:32:08 ERROR - PROCESS | 18669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:32:09 INFO - TEST-INFO | 18669: exit 0 10:32:09 INFO - Browser initialized. 10:32:09 INFO - Running cycle 1/1 for kraken test... 10:32:09 INFO - TEST-INFO | started process 18759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvr2wZv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:21 INFO - PROCESS | 18759 | RSS: Main: 139665408 10:32:21 INFO - PROCESS | 18759 | 10:32:23 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:24 INFO - PROCESS | 18759 | RSS: Main: 197562368 10:32:24 INFO - PROCESS | 18759 | 10:32:27 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-dft) 10:32:27 INFO - PROCESS | 18759 | RSS: Main: 183513088 10:32:27 INFO - PROCESS | 18759 | 10:32:30 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-fft) 10:32:31 INFO - PROCESS | 18759 | RSS: Main: 273178624 10:32:31 INFO - PROCESS | 18759 | 10:32:33 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-oscillator) 10:32:33 INFO - PROCESS | 18759 | RSS: Main: 179888128 10:32:33 INFO - PROCESS | 18759 | 10:32:36 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:36 INFO - PROCESS | 18759 | RSS: Main: 177885184 10:32:36 INFO - PROCESS | 18759 | 10:32:39 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45620/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:40 INFO - PROCESS | 18759 | RSS: Main: 213508096 10:32:40 INFO - PROCESS | 18759 | 10:32:43 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45620/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:44 INFO - PROCESS | 18759 | RSS: Main: 213245952 10:32:44 INFO - PROCESS | 18759 | 10:32:46 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45620/tests/kraken/driver.html?testName=json-parse-financial) 10:32:47 INFO - PROCESS | 18759 | RSS: Main: 212586496 10:32:47 INFO - PROCESS | 18759 | 10:32:48 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:49 INFO - PROCESS | 18759 | RSS: Main: 192311296 10:32:49 INFO - PROCESS | 18759 | 10:32:51 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:51 INFO - PROCESS | 18759 | RSS: Main: 196915200 10:32:51 INFO - PROCESS | 18759 | 10:32:53 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:54 INFO - PROCESS | 18759 | RSS: Main: 209903616 10:32:54 INFO - PROCESS | 18759 | 10:32:56 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:57 INFO - PROCESS | 18759 | RSS: Main: 218308608 10:32:57 INFO - PROCESS | 18759 | 10:33:00 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:00 INFO - PROCESS | 18759 | RSS: Main: 213991424 10:33:00 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45620/tests/kraken/driver.html?testName=ai-astar) 10:33:02 INFO - PROCESS | 18759 | RSS: Main: 274292736 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | __start_tp_report 10:33:02 INFO - PROCESS | 18759 | _x_x_mozilla_page_load 10:33:02 INFO - PROCESS | 18759 | _x_x_mozilla_page_load_details 10:33:02 INFO - PROCESS | 18759 | |i|pagename|runs| 10:33:02 INFO - PROCESS | 18759 | |0;ai-astar;112;112;109;109;110;111;105;109;110;110 10:33:02 INFO - PROCESS | 18759 | |1;audio-beat-detection;163;126;153;183;129;153;162;127;192;127 10:33:02 INFO - PROCESS | 18759 | |2;audio-dft;161;161;162;160;161;160;161;161;160;159 10:33:02 INFO - PROCESS | 18759 | |3;audio-fft;76;76;76;169;75;72;75;77;162;76 10:33:02 INFO - PROCESS | 18759 | |4;audio-oscillator;92;92;167;93;92;94;154;92;91;144 10:33:02 INFO - PROCESS | 18759 | |5;imaging-gaussian-blur;116;116;116;117;117;117;117;117;124;117 10:33:02 INFO - PROCESS | 18759 | |6;imaging-darkroom;145;146;145;146;147;146;146;146;146;145 10:33:02 INFO - PROCESS | 18759 | |7;imaging-desaturate;95;95;95;95;94;95;94;94;95;95 10:33:02 INFO - PROCESS | 18759 | |8;json-parse-financial;57;57;53;54;55;56;55;77;53;52 10:33:02 INFO - PROCESS | 18759 | |9;json-stringify-tinderbox;58;68;58;58;58;58;61;59;58;59 10:33:02 INFO - PROCESS | 18759 | |10;stanford-crypto-aes;72;70;71;80;71;72;72;72;71;72 10:33:02 INFO - PROCESS | 18759 | |11;stanford-crypto-ccm;112;113;110;112;120;115;114;113;129;129 10:33:02 INFO - PROCESS | 18759 | |12;stanford-crypto-pbkdf2;161;157;159;165;157;162;158;161;156;163 10:33:02 INFO - PROCESS | 18759 | |13;stanford-crypto-sha256-iterative;67;67;66;66;67;67;66;67;67;66 10:33:02 INFO - PROCESS | 18759 | __end_tp_report 10:33:02 INFO - PROCESS | 18759 | __start_cc_report 10:33:02 INFO - PROCESS | 18759 | _x_x_mozilla_cycle_collect,1568 10:33:02 INFO - PROCESS | 18759 | __end_cc_report 10:33:02 INFO - PROCESS | 18759 | __startTimestamp1468603982625__endTimestamp 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | ------- Summary: start ------- 10:33:02 INFO - PROCESS | 18759 | Number of tests: 14 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:1.94 10:33:02 INFO - PROCESS | 18759 | Values: 112.0 112.0 109.0 109.0 110.0 111.0 105.0 109.0 110.0 110.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.50 stddev:24.12 (15.3%) stddev-sans-first:25.22 10:33:02 INFO - PROCESS | 18759 | Values: 163.0 126.0 153.0 183.0 129.0 153.0 162.0 127.0 192.0 127.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 10:33:02 INFO - PROCESS | 18759 | Values: 161.0 161.0 162.0 160.0 161.0 160.0 161.0 161.0 160.0 159.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:38.06 (50.1%) stddev-sans-first:39.84 10:33:02 INFO - PROCESS | 18759 | Values: 76.0 76.0 76.0 169.0 75.0 72.0 75.0 77.0 162.0 76.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:92.00 stddev:30.79 (33.5%) stddev-sans-first:31.87 10:33:02 INFO - PROCESS | 18759 | Values: 92.0 92.0 167.0 93.0 92.0 94.0 154.0 92.0 91.0 144.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:2.37 (2.0%) stddev-sans-first:2.46 10:33:02 INFO - PROCESS | 18759 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 124.0 117.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:33:02 INFO - PROCESS | 18759 | Values: 145.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:33:02 INFO - PROCESS | 18759 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:55.50 stddev:7.26 (13.1%) stddev-sans-first:7.70 10:33:02 INFO - PROCESS | 18759 | Values: 57.0 57.0 53.0 54.0 55.0 56.0 55.0 77.0 53.0 52.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:58.50 stddev:3.14 (5.4%) stddev-sans-first:3.28 10:33:02 INFO - PROCESS | 18759 | Values: 58.0 68.0 58.0 58.0 58.0 58.0 61.0 59.0 58.0 59.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:2.79 (3.9%) stddev-sans-first:2.96 10:33:02 INFO - PROCESS | 18759 | Values: 72.0 70.0 71.0 80.0 71.0 72.0 72.0 72.0 71.0 72.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:114.50 stddev:6.99 (6.1%) stddev-sans-first:7.21 10:33:02 INFO - PROCESS | 18759 | Values: 112.0 113.0 110.0 112.0 120.0 115.0 114.0 113.0 129.0 129.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:161.00 stddev:2.96 (1.8%) stddev-sans-first:3.11 10:33:02 INFO - PROCESS | 18759 | Values: 161.0 157.0 159.0 165.0 157.0 162.0 158.0 161.0 156.0 163.0 10:33:02 INFO - PROCESS | 18759 | 10:33:02 INFO - PROCESS | 18759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:33:02 INFO - PROCESS | 18759 | Values: 67.0 67.0 66.0 66.0 67.0 67.0 66.0 67.0 67.0 66.0 10:33:02 INFO - PROCESS | 18759 | -------- Summary: end -------- 10:33:02 INFO - PROCESS | 18759 | 10:33:03 INFO - TEST-INFO | 18759: exit 0 10:33:03 INFO - TEST-OK | kraken | took 59925ms 10:33:03 INFO - SUITE-END | took 1170s 10:33:04 INFO - Completed test suite (00:19:31) 10:33:04 INFO - javascript benchmark 10:33:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.9175520612, 3305.305885763989, 3311.7681762276643, 3349.012041447773, 3352.966470335299, 5482.616216864821, 5484.149956756704, 5484.890302193959, 5497.312835895513, 5500.862478438036, 5481.0, 5485.177223416479, 5507.228987941681, 5510.448955104487, 5540.307461567304, 4959.925601115986, 4984.975075124628, 5055.494450554952, 5099.566536844372, 5133.82031628893, 4955.405351357824, 5029.47190544993, 5054.039732450822, 5058.51944065315, 5064.721440320781, 5043.092243396187, 5079.238114282869, 5145.485451454862, 5159.664621799571, 5166.07010738067, 5139.640225184238, 5162.92255616166, 5172.689638621695, 5173.637845350827, 5200.817971370984, 4890.657653964224, 4988.152014157602, 5069.771860266297, 5071.137906555894, 5074.4671809460215, 5486.067368547357, 5509.559235261169, 5551.306086739158, 5559.416261292587, 5566.4990150886615, 5960.582759206857, 5999.430054144849, 5999.880002399927, 6000.519958403317, 6003.759849606055, 5978.671173085479, 6023.6385816851125, 6081.4624278900355, 6088.1476593276975, 6108.908366374508, 5633.521150702195, 5674.971625141848, 5680.573956953245, 5682.602217844711, 5684.516816070639, 5947.881042379215, 6157.7229024694, 6173.444390004921, 6177.0, 6182.876342473215, 5784.248047753765, 5848.122781582797, 5858.56060795442, 5866.530677545786, 5866.70666466675, 5938.376470470538, 5942.049272116527, 5956.285245770535, 5959.195508606369, 5972.402759723993, 5752.827415177551, 5844.970775146097, 5929.229200204032, 5936.050231962865, 5938.970305148533, 5948.8810223796145, 5971.641701497924, 5975.163477113208, 5988.9101663475085, 6015.939840601625, 4570.542945705402, 4578.5650363215445, 4579.084183163381, 4579.450465944042, 4608.539146085364, 3998.420229066769, 4019.537753158366, 4091.85678501251, 4115.6295933365545, 4141.151064031867, 5640.5487560995025, 5667.971660141673, 5675.517581005661, 5676.829695109153, 5686.175504551817, 5969.940300597025, 5970.0, 5974.671393073336, 5977.98374276374, 5978.970105149447, 5540.501354878081, 5604.663720176803, 5654.236678048411, 5686.772529098873, 5741.5406767459335, 5152.9742351288005, 5154.252633368141, 5186.325777648882, 5186.481351864859, 5187.118189907725, 6250.499960003189, 6267.059941008885, 6273.341299163613, 6274.811755647338, 6281.623102613858, 5774.653520788766, 5981.700914954322, 6031.849203769941, 6093.177421048279, 6101.725422356093, 6154.580389856348, 6188.721507532262, 6202.596831205957, 6210.161628180138, 6212.223472065992, 5865.354810970875, 5868.295804503487, 5868.94131058701, 5870.677112758839, 5899.557533185114, 5751.223584815996, 6011.0, 6079.939200608114, 6086.6348019119, 6109.450149486567, 5763.279590051244, 5812.0, 5812.070068788974, 5823.039198532195, 5826.766929322949, 5653.038983372919, 5772.018756811268, 5801.129830525286, 5826.359100499027, 5831.271091113611, 5712.02895507773, 5747.913781293368, 5788.855278618068, 5810.709464526842, 5817.156512305776, 5836.795712150054, 5837.270341207349, 5855.473007429352, 5862.501687356623, 5867.413258674099, 5557.5831812613405, 5756.2229099072765, 5756.597038207286, 5772.624779389326, 5774.3648198697265], "value": 5508.8165086971085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.2540166910555, 665.1818263535848, 675.1223409567561, 735.2830989784957, 743.9590822504764, 31106.844465777667, 31565.0, 31626.683733162663, 31674.524882126785, 31679.0, 30862.074137775846, 38720.99999999993, 39185.412218816666, 39273.803630981805, 39360.606393936054, 9097.909020909805, 9249.35254532183, 9281.257499400066, 9289.256859451261, 9291.674791382304, 8874.556272186364, 9078.455292682427, 9097.090290970884, 9098.044705305947, 9102.908970910272, 9133.771655708593, 9193.310501712398, 9208.49353285569, 9213.493257870814, 9214.308926830481, 9103.681371152012, 9176.724698259062, 9179.908200917973, 9181.35730498862, 9186.265098792113, 9075.682351117679, 9171.954140229323, 9193.908060919372, 9202.0, 9206.079392060807, 42386.364204536956, 42762.78618606887, 42958.0, 43002.78498607518, 43186.35220471695, 3618.583862855779, 3879.573246942834, 4038.1318016626274, 4298.656107511391, 4603.631709463235, 33500.66499335, 34163.487547686804, 34261.65738342609, 34263.657363426544, 34376.31247375038, 4254.87235382939, 4261.382099595541, 4276.102018576103, 4281.871543853689, 4302.945778284309, 313271.0, 315777.0, 315847.0, 316699.0, 317442.0, 60330.0, 61183.38816611866, 61237.38762612406, 61263.69368153131, 61407.0, 73583.63208183924, 75089.62455187688, 75108.62445687846, 75320.24679753132, 75375.62312188404, 16270.511884643243, 16295.348186072424, 16307.83692163087, 16308.0, 16308.673826523403, 15103.697926041417, 15230.314635841414, 15280.083195008336, 15283.38866445352, 15286.235688215545, 20659.276925307542, 20956.68564971496, 21009.47476313074, 21011.0, 21071.78928210729, 7421.888671669929, 7452.366548843301, 7530.6611202496015, 7635.732749353857, 7693.961530192425, 1083.2579682917226, 1115.3475216997986, 1132.7564573616712, 1134.6312448454285, 1192.1476144556684, 32353.35293294121, 33101.503477447855, 33239.66760332414, 33434.0, 33859.0, 1198.4427241332821, 1242.2484396939901, 1242.3601845049807, 1279.9808002879963, 1303.5242136620066, 17508.824911750973, 17904.91047544754, 17905.910470447565, 17927.820721792614, 18159.0, 524659.0, 525877.0, 527764.0, 533682.0, 533839.0, 61564.38435615676, 62264.0, 62365.0, 62395.0, 62580.0, 1394.2262044565364, 1510.6827566211, 1533.363654083565, 1605.0, 1610.9597260068358, 30107.63419344201, 31964.0, 32697.673023269464, 32969.835150824096, 32991.50512742263, 41676.79161604172, 41718.58281417147, 41879.58120418757, 41909.79045104755, 41915.7904210477, 256241.0, 256303.0, 257045.0, 257063.0, 257113.0, 29969.850150749106, 45840.0, 46050.769746151054, 46069.76965115153, 46876.062478750915, 42939.141217176104, 43430.78284608557, 43720.562794371646, 43865.56134438615, 43866.56133438752, 36374.0, 36497.635023649425, 36593.45109823302, 36722.63277367192, 37113.0, 35223.64776352306, 36514.452283216306, 36588.26823463463, 36789.0, 37308.25383492369, 41782.0, 41846.58153418548, 41895.162096758504, 42804.78597606992, 42935.78532107444, 34970.0, 36407.63592364149, 37339.6266037347, 37347.253054938206, 37498.8125059373, 28272.1212783505, 28689.56965645475, 28799.848668129973, 28836.855815721625, 29012.709872901], "value": 20340.591139030814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.51035819166134, 430.9116631090625, 437.1453807805738, 440.00911730603417, 442.7520588470457, 18458.446246612606, 18666.066696665148, 18742.53143671409, 19247.903760481197, 19279.686437627504, 18596.0, 18858.245670173175, 19828.107735151916, 19911.104000319985, 19932.70100948487, 5615.157726341061, 5787.392323805992, 5877.382874798149, 5884.499817515516, 6052.334243233241, 5821.126830975367, 5839.445252700986, 5846.590738648296, 5872.823815285548, 6321.1150438938585, 6672.866542669144, 6680.66596670167, 6681.498887583451, 6703.229128650194, 6728.461723062168, 5969.910451343233, 6006.099085137221, 6362.0774987627, 6672.866542669168, 6679.031540426635, 5820.563457740686, 5827.854303642401, 5834.912476312858, 5842.328132264802, 5861.9706901465215, 14254.14475131485, 19825.30611428593, 23711.407214819596, 23946.52106957851, 24124.87937560301, 2513.2661084927736, 2529.936751581207, 2573.729758375381, 2885.3075261937192, 3071.692830716933, 10245.077942985092, 10344.275900686955, 10358.378497290187, 13577.642235776442, 13795.896328293713, 2047.4471892589067, 2049.6105739909517, 2070.606584748893, 2106.24175296893, 2173.6739489076763, 61517.0, 68481.31518684799, 82322.17677823205, 84376.0, 86553.56723216343, 11488.540458381738, 11542.249753765978, 11809.173357865038, 11861.822072668916, 12044.457999390048, 13929.373178207004, 15513.767293490606, 16155.757663635055, 16252.18739063042, 16999.49001529956, 8604.13958604147, 8780.736577902673, 8953.641854325884, 9072.727818165333, 9097.590608422504, 8676.783080422914, 8685.557122286345, 8732.039475657673, 8819.11808819113, 8841.69054083104, 5022.347094877642, 5063.645544811901, 5134.845954621367, 5154.458781827854, 5223.4515375884985, 2092.884891330961, 2131.1368895597307, 2182.8690278583335, 2185.715856938588, 2193.473566344066, 1022.3559157730582, 1047.1151876664208, 1076.278893141597, 1115.6876074698935, 1143.8684551276542, 18832.587555933358, 19602.0, 19940.102695378744, 20055.59888802245, 20135.798642013393, 1076.1337123615565, 1077.1329080090445, 1085.7991271614776, 1105.6406667832825, 1108.3793075877534, 10915.0, 11425.60010399632, 11435.885641143648, 11536.0, 11556.133290003283, 583130.0, 588972.0, 610936.0, 619592.0, 621062.0, 57472.0, 59557.0, 107402.0, 107822.46088769507, 109686.0, 1123.0, 1124.685088175296, 1148.661144962238, 1162.7790719763218, 1164.8660404053473, 17926.0, 17976.550586235448, 17977.910110449364, 18292.359767408077, 18818.52953676169, 41275.58724412838, 41950.58049419467, 42356.57643423526, 42809.785951070044, 43740.0, 59882.706451145605, 63301.0, 63893.680531598904, 63909.0, 64413.677931611914, 9237.630494780133, 9296.535173241176, 9337.112974267433, 9402.52987350616, 9449.669261575811, 13181.802272966104, 13843.377048032662, 14034.087784293988, 14070.507532236323, 14382.496612618508, 11686.532538698697, 12200.816987745013, 12341.853860057032, 12359.443825028075, 12500.687482813002, 11672.0, 11673.649790506299, 11906.464209110438, 11946.163768536466, 12017.0, 11825.172237943261, 12244.877551224374, 12385.071119665881, 12428.875711243134, 12899.548515801902, 8709.956450217709, 8875.822483550164, 9087.09129087086, 9136.908630913871, 9379.249660027317, 11443.713907152387, 11974.820377694168, 11986.820197696867, 12081.57714479989, 12371.69070773238], "value": 9791.475097243765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.7980442835783, 1561.1257695690415, 1596.872250219982, 1788.946331610052, 1891.2624076610116, 7264.237255088212, 8032.799180020503, 8181.795455113618, 8200.179982001797, 8210.30212431944, 8105.716299929503, 8143.877841832377, 8182.95908520458, 8199.877001844978, 8202.548859812709, 2384.2966324934187, 2402.0872068613903, 2403.6034054381007, 2412.348665860217, 2418.9153379631716, 2384.201292566992, 2401.5317013182434, 2423.3456966619, 2432.0514999150346, 2442.46265821519, 2425.369403954967, 2459.56957532432, 2459.8524088554655, 2461.1509029384833, 2480.851148931061, 2390.2470721722602, 2396.197273913241, 2403.158894386959, 2404.1104791227185, 2441.414060625455, 2377.9048838046456, 2434.7686969737847, 2443.511297740459, 2447.4737931344666, 2455.373879660693, 7990.0, 8254.54599997, 8317.0, 8318.209770071893, 8328.167183281623, 5220.295260139908, 5293.920591191135, 5296.046711591912, 5324.520793128599, 5339.866503337409, 3643.8542458301636, 3719.516462859838, 3730.1047748540427, 3746.082209858575, 3779.9055023624355, 1157.7568710570706, 1208.0, 1211.8666946635863, 1214.489914236023, 1278.603632873812, 11183.83224251637, 11288.604898828584, 11590.072794176445, 11625.24435911663, 11660.59187928427, 4439.245328294133, 4525.660575456854, 4601.7699115044115, 4607.170709272296, 4706.294055891643, 9372.90627093734, 9390.577424015935, 9395.671151509665, 9413.0, 9416.576254068446, 5173.715445650525, 5179.04187725272, 5208.348956380452, 5216.921746173811, 5220.347456567929, 4222.978885105555, 4577.244754615518, 4720.079584480994, 4732.834350797705, 4836.202026665561, 3856.0745421098736, 3871.3031654302495, 3934.2918274710255, 3963.405489176589, 3972.2055588881763, 1197.7245233596148, 1201.3152503073338, 1201.615483045417, 1212.0, 1226.1110694746237, 954.665866946577, 1047.701405099543, 1056.5192837259028, 1064.7763969566322, 1077.1490522487304, 5983.521318294526, 5993.640381577119, 6020.09698545213, 6084.817455476343, 6124.418180272867, 489.82611173033774, 493.26257245418327, 495.9330490383824, 496.83604410544433, 503.7833731495492, 4111.938320925188, 4225.9577404226175, 4242.724222925562, 4255.574442555781, 4292.356146577976, 10042.246831487668, 10060.446675432922, 10255.128314093387, 10312.175025997902, 10323.0, 10210.897891021143, 10289.125424338865, 10340.638077667245, 10357.171426285879, 10362.948185259176, 7897.091834438998, 7979.441439099207, 8006.239407256301, 8025.7993550160545, 8036.839263214703, 5861.3845546217035, 5867.210500797298, 5963.314218864886, 6015.969920150371, 6064.818055458343, 8773.780655483664, 8838.64645414202, 8934.329925255503, 8943.463392196489, 8973.955130224307, 8717.389782715149, 9083.0, 9091.227245683926, 9096.135867092615, 9110.90889091127, 6458.38645328693, 6583.341665833378, 6591.274959754519, 7339.77980660581, 7442.255774422514, 7616.276453736886, 7846.725364612211, 7849.293563579077, 7849.372050236082, 7858.253465920729, 6846.383825455733, 7016.087908571853, 7073.823154420975, 7117.3238542338395, 7154.928450715426, 6927.653617319214, 7030.578165310098, 7049.2950704931145, 7091.1490621125795, 7165.24764899678, 6689.297623749436, 6720.1599800025, 6742.258351581224, 6887.552309099892, 6901.275366086488, 5204.193350030751, 5229.712365819764, 5244.580433565382, 5248.475152484721, 5254.290670759551, 5149.536541711264, 5169.4830516948, 5194.532492075731, 5225.477452254744, 5323.1749078892835], "value": 4471.053713824105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.57595733205494, 358.2852209841367, 360.04946940078213, 361.34235691042295, 361.87696183297675, 5888.735006924688, 6039.365866584011, 6049.5160387169035, 6110.908336374958, 6134.938650613492, 6024.728887200075, 6111.1138884861775, 6112.908306375408, 6120.755169793214, 6138.079288106786, 4716.1982462981205, 4729.739864307453, 4752.59602933751, 4758.476567577563, 4768.094062128202, 4448.154850578396, 4527.547245275463, 4688.062387522492, 4714.834980775673, 4716.764161791897, 4668.36977008103, 4682.344471773954, 4702.412198475191, 4708.270218116198, 4709.081729062834, 4686.039361930796, 4689.624830013608, 4689.929651055237, 4694.718316900963, 4699.365585645963, 4095.447114639545, 4104.979475102636, 4130.731502452331, 4137.234611596864, 4147.04617937876, 5813.302403711539, 5816.331121920991, 5822.0, 5837.299524057098, 5840.240768700041, 5385.865353366158, 5435.374931882805, 5440.700761458118, 5441.0, 5441.83674489766, 6179.814605561795, 6361.872762544769, 6370.936290637081, 6405.135306733578, 6415.518836087265, 4498.50516443191, 4511.729296242236, 4513.954860451419, 4517.728936263802, 4520.141173177086, 6644.036614690843, 6719.193696756421, 6723.394894459522, 6726.327367263283, 6728.0, 4606.677532572755, 4607.493175750665, 4609.446866376056, 4609.884752881205, 4610.423697037871, 4671.85984420468, 4673.345731597579, 4673.883152921204, 4674.509176536482, 4676.742779147179, 5193.169092945111, 5346.652467589594, 5353.250544923714, 5354.196870469461, 5390.51485366319, 6390.360963903572, 6446.838829029218, 6474.611523308617, 6503.0, 6523.18460192476, 1541.992290038565, 1596.728556145458, 1624.1473226556152, 1631.820499745027, 1636.2473262299475, 1075.3440401355167, 1091.4270008245576, 1097.8023955688052, 1102.525913857049, 1109.0351394287022, 6214.689265536705, 6223.782167624202, 6236.345183755731, 6240.032794916795, 6242.812715618538, 6574.0, 6580.835479112965, 6583.539152259392, 6587.571807832475, 6587.934120658828, 6217.440430361289, 6220.937790622126, 6221.253449586078, 6222.0, 6223.408776166348, 3525.383057964846, 3556.395412779834, 3557.075160458248, 3557.679808817219, 3558.5551806024246, 6650.600963942179, 6835.760748373783, 6861.2795656455355, 6877.518573699793, 6888.793336199922, 6649.3018233085795, 6663.766768163188, 6670.433013193836, 6682.231543372477, 6694.330566943364, 6816.931830681629, 6846.965765171142, 6851.0, 6857.142857142758, 6861.142357205349, 6560.639164845788, 6563.704633291418, 6566.4418524424045, 6574.3754343337305, 6577.112089867998, 6258.968705156445, 6402.935970640234, 6420.26166990802, 6430.742770289136, 6460.773872914426, 6795.3204679531655, 6818.727250910107, 6822.795316140524, 6827.897581536182, 6832.145981752281, 4587.63298936091, 4594.47163576193, 4597.057603191404, 4600.21796294624, 4602.493725690105, 6397.840053998687, 6490.870182596227, 6538.444232240123, 6539.574927629879, 6540.313267106885, 6329.936700633119, 6395.328490508429, 6406.519511036598, 6445.581037232752, 6491.935080649133, 6439.7424103035355, 6475.09348691193, 6480.57876238043, 6510.869782604416, 6515.250746164252, 6402.6158430494315, 6411.0383442484, 6418.390252925965, 6418.6469744164515, 6421.646809425526, 6408.102865598913, 6538.0, 6543.5419520633095, 6554.344565543408, 6567.835804104936, 6380.776672816429, 6388.840278993062, 6399.2640846303275, 6413.0, 6422.3577642235405], "value": 4869.758147922997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.5715613661578, 912.9589168487415, 923.5705396990402, 928.4104593583073, 953.6042542344927, 13964.092333998296, 14165.78751318731, 14175.71648567028, 14183.929080354597, 14185.71628567428, 13553.186808791479, 13621.591352259424, 13629.795553066711, 13635.113717608348, 13646.2494562799, 725.2095216214325, 865.1780808232173, 889.0575989451203, 889.9243564297043, 894.1639567004838, 880.8502554565707, 881.5151666583386, 887.2591386192537, 887.2813021452644, 889.2041622747637, 762.9618519074052, 934.9252059835231, 937.357909831764, 937.7655586103474, 938.3431597881477, 922.5940586142076, 932.9393589416666, 934.3786382055924, 934.7008957133754, 935.6210734652477, 684.3122661724984, 688.7245101959206, 688.7761477519776, 689.2693744630658, 689.9206591242021, 14440.277986100758, 14508.927455362762, 14544.0, 14565.635859103608, 14572.198529081003, 13757.587272381845, 13973.790393144009, 14018.92990535051, 14371.928140359336, 14561.78157327641, 11526.654200374001, 11624.476898539586, 11632.651020469399, 11836.171467997243, 11896.0, 3969.7221194516396, 3997.8600748973936, 4004.4193591929006, 4012.478377810895, 4094.1402305515876, 52838.47161528374, 52985.0, 53038.0, 53077.0, 53265.46734532644, 11403.543858245577, 11589.420528973518, 11715.76568468626, 11716.648500544998, 11961.222520536137, 19686.70469942952, 19796.802031979783, 19821.900890495453, 19863.503412414517, 19890.50273743139, 8000.5599692017495, 8089.676412943534, 8263.380246481538, 8277.917220827836, 8520.616572254263, 5037.823676171316, 5106.591472682177, 5125.897482050338, 5166.302549155891, 5400.0819860623005, 3446.5691788526433, 3493.406120959443, 3495.3708332500396, 3500.632433594487, 3501.2122272488486, 633.740166531729, 648.0829626079045, 650.2976785072111, 655.3872129558878, 665.5308007854451, 782.7456076774957, 808.6765293882494, 811.6509900742619, 812.3176531713389, 822.5804839531762, 9385.296102792317, 9580.76048098803, 9600.183984361267, 9924.553395097239, 9954.0, 654.8853950558633, 752.751591974647, 778.2334400615389, 818.4925346285341, 849.9872501912477, 4296.570342965679, 4314.870553883388, 4346.434963454793, 4391.560843915583, 4549.7042692224895, 60936.0, 62249.68875155595, 67411.0, 67475.32524674789, 68042.65978670075, 49903.75048124736, 50326.24510632343, 50825.23762143571, 51002.0, 52159.47840521622, 48162.51837481651, 50252.0, 51819.0, 52128.218076728124, 52332.0, 10138.847917281098, 10321.63874264397, 10339.121174699934, 10370.377777333384, 10426.27016108865, 37488.62511374961, 38256.80871595624, 38301.61698382981, 38376.6162338373, 39170.41244381393, 46103.53896460992, 48649.270260946825, 48793.756031219615, 49839.50160498349, 50343.244851326526, 12369.752604948031, 12524.686882827638, 12858.742825143632, 12946.287954162612, 13108.147970381895, 13577.389017494039, 13729.313534323044, 13854.099483533539, 14220.928895355457, 14376.209308488134, 13117.475300987853, 13236.801447978096, 13254.867451325748, 13309.267990260629, 13367.732645347232, 12691.492340306653, 13166.934165329112, 13369.39837707325, 13464.394102265618, 13551.52569660057, 12692.746145076862, 13284.402201901132, 13390.0, 13428.798568021291, 13431.731365372832, 10881.183911206534, 11108.666739997812, 11499.770004600028, 11585.88414115848, 11608.6517404478, 11349.54601815918, 11434.512473695602, 11515.154532915749, 11574.768504629692, 11598.768024639628], "value": 7088.421950198411, "unit": "score"}], "name": "dromaeo_css", "value": 7438.118712541907, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 109.0, 109.0, 110.0, 111.0, 105.0, 109.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 153.0, 183.0, 129.0, 153.0, 162.0, 127.0, 192.0, 127.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 169.0, 75.0, 72.0, 75.0, 77.0, 162.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 167.0, 93.0, 92.0, 94.0, 154.0, 92.0, 91.0, 144.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 124.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 53.0, 54.0, 55.0, 56.0, 55.0, 77.0, 53.0, 52.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 68.0, 58.0, 58.0, 58.0, 58.0, 61.0, 59.0, 58.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 80.0, 71.0, 72.0, 72.0, 72.0, 71.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 110.0, 112.0, 120.0, 115.0, 114.0, 113.0, 129.0, 129.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 159.0, 165.0, 157.0, 162.0, 158.0, 161.0, 156.0, 163.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1516.1000000000001, "alertThreshold": 2.0}]} 10:33:04 INFO - Return code: 0 10:33:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:33:04 ERROR - # TBPL SUCCESS # 10:33:04 INFO - Running post-action listener: _resource_record_post_action 10:33:04 INFO - Running post-run listener: _resource_record_post_run 10:33:05 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 464392192; Read time: 156; Write time: 330768 10:33:05 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241750016; Read time: 0; Write time: 220200 10:33:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 222642176; Read time: 156; Write time: 110568 10:33:05 INFO - Running post-run listener: _upload_blobber_files 10:33:05 INFO - Blob upload gear active. 10:33:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:05 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 10:33:05 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'] 10:33:05 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 10:33:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:08 INFO - (blobuploader) - INFO - Done attempting. 10:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:09 INFO - (blobuploader) - INFO - Done attempting. 10:33:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:09 INFO - Return code: 0 10:33:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f116e054c695d1832ce78966b30210b0c4e336bf7c5de9140e4cc199f692f8758ad3d6012134100571266cc8af0e520d66b6b056532b6d19dcbcf51d9d8944a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93e95e854e754e8f77582f0b2a3d18408d6c0c7361e2debb956754a3b08e51aaba15faa607e8625cf769db63815e549cb1a07d86003058353bd1efdc0823b450"} 10:33:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:09 INFO - Contents: 10:33:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f116e054c695d1832ce78966b30210b0c4e336bf7c5de9140e4cc199f692f8758ad3d6012134100571266cc8af0e520d66b6b056532b6d19dcbcf51d9d8944a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93e95e854e754e8f77582f0b2a3d18408d6c0c7361e2debb956754a3b08e51aaba15faa607e8625cf769db63815e549cb1a07d86003058353bd1efdc0823b450"} 10:33:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:09 INFO - Copying logs to upload dir... 10:33:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.922873 ========= master_lag: 43.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-15 10:33:52.405471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 10:33:52.409327) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783 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/f116e054c695d1832ce78966b30210b0c4e336bf7c5de9140e4cc199f692f8758ad3d6012134100571266cc8af0e520d66b6b056532b6d19dcbcf51d9d8944a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93e95e854e754e8f77582f0b2a3d18408d6c0c7361e2debb956754a3b08e51aaba15faa607e8625cf769db63815e549cb1a07d86003058353bd1efdc0823b450"} build_url:https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/PsAZZVcpQlyruhHPGXGixw/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/f116e054c695d1832ce78966b30210b0c4e336bf7c5de9140e4cc199f692f8758ad3d6012134100571266cc8af0e520d66b6b056532b6d19dcbcf51d9d8944a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93e95e854e754e8f77582f0b2a3d18408d6c0c7361e2debb956754a3b08e51aaba15faa607e8625cf769db63815e549cb1a07d86003058353bd1efdc0823b450"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 10:33:52.586408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:33:52.586765) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468601489.260414-1284845783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:33:52.968300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 10:33:52.968642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 10:33:52.970808) ========= ========= Total master_lag: 44.52 =========