builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1467741457.89 results: success (0) buildid: 20160705080222 builduid: d8f172d1295a49149a1d56034bc9c957 revision: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:37.891136) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:37.891676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:37.892028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:37.908018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:37.908368) ========= 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=4300f881736b422476174874000001bc-1467741457.302544-1835123630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:57:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-05 10:57:38 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.011632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.012034) ========= 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=4300f881736b422476174874000001bc-1467741457.302544-1835123630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.062856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.063287) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f --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 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f --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=4300f881736b422476174874000001bc-1467741457.302544-1835123630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:57:38,391 truncating revision to first 12 chars 2016-07-05 10:57:38,391 Setting DEBUG logging. 2016-07-05 10:57:38,391 attempt 1/10 2016-07-05 10:57:38,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4e1aa4b6f7b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:57:38,697 unpacking tar archive at: mozilla-beta-4e1aa4b6f7b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.724330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.724715) ========= script_repo_revision: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.725206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.725576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:38.735474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-05 10:57:38.735795) ========= /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=4300f881736b422476174874000001bc-1467741457.302544-1835123630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:57:39 INFO - MultiFileLogger online at 20160705 10:57:39 in /builds/slave/test 10:57: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:57:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:57:39 INFO - {'append_to_log': False, 10:57:39 INFO - 'base_work_dir': '/builds/slave/test', 10:57:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:57:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:57:39 INFO - 'branch': 'Mozilla-Beta', 10:57:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:57:39 INFO - 'config_files': ('talos/linux_config.py',), 10:57:39 INFO - 'default_actions': ('clobber', 10:57:39 INFO - 'read-buildbot-config', 10:57:39 INFO - 'download-and-extract', 10:57:39 INFO - 'populate-webroot', 10:57:39 INFO - 'create-virtualenv', 10:57:39 INFO - 'install', 10:57:39 INFO - 'run-tests'), 10:57:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:57:39 INFO - 'download_minidump_stackwalk': True, 10:57:39 INFO - 'download_symbols': 'ondemand', 10:57:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:57:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:57:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:57:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:57:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:57:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:57:39 INFO - 'installer_path': 'installer.exe', 10:57:39 INFO - 'log_level': 'info', 10:57:39 INFO - 'log_name': 'talos', 10:57:39 INFO - 'log_to_console': True, 10:57:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:57:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:57:39 INFO - 'opt_config_files': (), 10:57:39 INFO - 'pip_index': False, 10:57:39 INFO - 'sps_profile': False, 10:57:39 INFO - 'sps_profile_interval': 0, 10:57:39 INFO - 'suite': 'dromaeojs', 10:57:39 INFO - 'system_bits': '32', 10:57:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:57:39 INFO - 'title': 'talos-linux64-ix-045', 10:57:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:57:39 INFO - 'use_talos_json': True, 10:57:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:57:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:57:39 INFO - 'work_dir': 'build'} 10:57:39 INFO - ##### 10:57:39 INFO - ##### Running clobber step. 10:57:39 INFO - ##### 10:57:39 INFO - Running pre-action listener: _resource_record_pre_action 10:57:39 INFO - Running main action method: clobber 10:57:39 INFO - rmtree: /builds/slave/test/build 10:57:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:57:39 INFO - Running post-action listener: _resource_record_post_action 10:57:39 INFO - ##### 10:57:39 INFO - ##### Running read-buildbot-config step. 10:57:39 INFO - ##### 10:57:39 INFO - Running pre-action listener: _resource_record_pre_action 10:57:39 INFO - Running main action method: read_buildbot_config 10:57:39 INFO - Using buildbot properties: 10:57:39 INFO - { 10:57:39 INFO - "project": "", 10:57:39 INFO - "product": "firefox", 10:57:39 INFO - "script_repo_revision": "production", 10:57:39 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:57:39 INFO - "repository": "", 10:57:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:57:39 INFO - "buildid": "20160705080222", 10:57:39 INFO - "pgo_build": "True", 10:57:39 INFO - "basedir": "/builds/slave/test", 10:57:39 INFO - "buildnumber": 154, 10:57:39 INFO - "slavename": "talos-linux64-ix-045", 10:57:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:57:39 INFO - "platform": "ubuntu64_hw", 10:57:39 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:57:39 INFO - "branch": "mozilla-beta", 10:57:39 INFO - "repo_path": "releases/mozilla-beta", 10:57:39 INFO - "revision": "4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f", 10:57:39 INFO - "stage_platform": "linux64-pgo", 10:57:39 INFO - "builduid": "d8f172d1295a49149a1d56034bc9c957", 10:57:39 INFO - "slavebuilddir": "test" 10:57:39 INFO - } 10:57:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:57:39 INFO - Running post-action listener: _resource_record_post_action 10:57:39 INFO - ##### 10:57:39 INFO - ##### Running download-and-extract step. 10:57:39 INFO - ##### 10:57:39 INFO - Running pre-action listener: _resource_record_pre_action 10:57:39 INFO - Running main action method: download_and_extract 10:57:39 INFO - mkdir: /builds/slave/test/build/tests 10:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:39 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:40 INFO - Downloaded 1327 bytes. 10:57:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:57:40 INFO - Using the following test package requirements: 10:57:40 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:57:40 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:57:40 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:57:40 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'jsshell-linux-x86_64.zip'], 10:57:40 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:57:40 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:57:40 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:57:40 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:57:40 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:57:40 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:57:40 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:57:40 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:57: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:57:40 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:41 INFO - Downloaded 24235782 bytes. 10:57:41 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:57:41 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:57:42 INFO - Return code: 0 10:57:42 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:57: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:57:42 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:43 INFO - Downloaded 24235782 bytes. 10:57:43 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:57:43 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:57:45 INFO - Return code: 0 10:57:45 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:57:45 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:46 INFO - Downloaded 10840145 bytes. 10:57:46 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:57:46 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:57:47 INFO - Return code: 0 10:57:47 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:57:47 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/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:57:48 INFO - Downloaded 56023777 bytes. 10:57:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:57:48 INFO - mkdir: /builds/slave/test/properties 10:57:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:57:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:57:48 INFO - Contents: 10:57:48 INFO - build_url:https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:57:49 INFO - Running post-action listener: _resource_record_post_action 10:57:49 INFO - Running post-action listener: set_extra_try_arguments 10:57:49 INFO - ##### 10:57:49 INFO - ##### Running populate-webroot step. 10:57:49 INFO - ##### 10:57:49 INFO - Running pre-action listener: _resource_record_pre_action 10:57:49 INFO - Running main action method: populate_webroot 10:57:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:49 INFO - '--tppagecycles', 10:57:49 INFO - '7'], 10:57:49 INFO - 'tests': ['tsvgm']}}, 10:57:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:57:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:57:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:57:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['damp', 'tps']}, 10:57:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'tests': ['damp', 'tps']}, 10:57:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['dromaeo_dom']}, 10:57:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['a11yr', 10:57:49 INFO - 'ts_paint', 10:57:49 INFO - 'tpaint', 10:57:49 INFO - 'sessionrestore', 10:57:49 INFO - 'sessionrestore_no_auto_restore', 10:57:49 INFO - 'tabpaint']}, 10:57:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:57:49 INFO - 'ts_paint', 10:57:49 INFO - 'tpaint', 10:57:49 INFO - 'sessionrestore', 10:57:49 INFO - 'sessionrestore_no_auto_restore', 10:57:49 INFO - 'tabpaint']}, 10:57:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:57:49 INFO - 'ts_paint', 10:57:49 INFO - 'tpaint', 10:57:49 INFO - 'sessionrestore', 10:57:49 INFO - 'sessionrestore_no_auto_restore', 10:57:49 INFO - 'tabpaint']}, 10:57:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:57:49 INFO - 'ts_paint', 10:57:49 INFO - 'tpaint', 10:57:49 INFO - 'sessionrestore', 10:57:49 INFO - 'sessionrestore_no_auto_restore', 10:57:49 INFO - 'tabpaint']}, 10:57:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['a11yr', 10:57:49 INFO - 'ts_paint', 10:57:49 INFO - 'tpaint', 10:57:49 INFO - 'sessionrestore', 10:57:49 INFO - 'sessionrestore_no_auto_restore', 10:57:49 INFO - 'tabpaint']}, 10:57:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['a11yr', 10:57:49 INFO - 'ts_paint', 10:57:49 INFO - 'tpaint', 10:57:49 INFO - 'sessionrestore', 10:57:49 INFO - 'sessionrestore_no_auto_restore', 10:57:49 INFO - 'tabpaint']}, 10:57:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['tsvgx', 10:57:49 INFO - 'tsvgr_opacity', 10:57:49 INFO - 'tart', 10:57:49 INFO - 'tscrollx', 10:57:49 INFO - 'cart']}, 10:57:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:57:49 INFO - 'tsvgr_opacity', 10:57:49 INFO - 'tart', 10:57:49 INFO - 'tscrollx', 10:57:49 INFO - 'cart']}, 10:57:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'talos_options': ['--disable-e10s'], 10:57:49 INFO - 'tests': ['tp5o']}, 10:57:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'tests': ['tp5o']}, 10:57:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'talos_options': ['--disable-e10s', 10:57:49 INFO - '--xperf_path', 10:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:49 INFO - 'tests': ['tp5n']}, 10:57:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:49 INFO - 'talos_options': ['--xperf_path', 10:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:49 INFO - 'tests': ['tp5n']}}, 10:57:49 INFO - 'talos.zip': {'path': '', 10:57:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:49 INFO - Running post-action listener: _resource_record_post_action 10:57:49 INFO - ##### 10:57:49 INFO - ##### Running create-virtualenv step. 10:57:49 INFO - ##### 10:57:49 INFO - Running pre-action listener: _resource_record_pre_action 10:57:49 INFO - Running main action method: create_virtualenv 10:57:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:57:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:57:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:57:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:49 INFO - Using real prefix '/usr' 10:57:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:57:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:51 INFO - Installing pip.................done. 10:57:51 INFO - Return code: 0 10:57:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:57: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:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:57:51 INFO - Using env: {'DISPLAY': ':0', 10:57:51 INFO - 'HOME': '/home/cltbld', 10:57:51 INFO - 'LANG': 'en_US.UTF-8', 10:57:51 INFO - 'LANGUAGE': 'en_US:en', 10:57:51 INFO - 'LOGNAME': 'cltbld', 10:57:51 INFO - 'MAIL': '/var/mail/cltbld', 10:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:51 INFO - 'MOZ_NO_REMOTE': '1', 10:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:51 INFO - 'NO_EM_RESTART': '1', 10:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:51 INFO - 'PWD': '/builds/slave/test', 10:57:51 INFO - 'SHELL': '/bin/bash', 10:57:51 INFO - 'SHLVL': '1', 10:57:51 INFO - 'TERM': 'linux', 10:57:51 INFO - 'TMOUT': '86400', 10:57:51 INFO - 'USER': 'cltbld', 10:57:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:51 INFO - '_': '/tools/buildbot/bin/python'} 10:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:51 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:57:51 INFO - Cleaning up... 10:57:51 INFO - Return code: 0 10:57:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:57: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:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:57:51 INFO - Using env: {'DISPLAY': ':0', 10:57:51 INFO - 'HOME': '/home/cltbld', 10:57:51 INFO - 'LANG': 'en_US.UTF-8', 10:57:51 INFO - 'LANGUAGE': 'en_US:en', 10:57:51 INFO - 'LOGNAME': 'cltbld', 10:57:51 INFO - 'MAIL': '/var/mail/cltbld', 10:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:51 INFO - 'MOZ_NO_REMOTE': '1', 10:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:51 INFO - 'NO_EM_RESTART': '1', 10:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:51 INFO - 'PWD': '/builds/slave/test', 10:57:51 INFO - 'SHELL': '/bin/bash', 10:57:51 INFO - 'SHLVL': '1', 10:57:51 INFO - 'TERM': 'linux', 10:57:51 INFO - 'TMOUT': '86400', 10:57:51 INFO - 'USER': 'cltbld', 10:57:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:51 INFO - '_': '/tools/buildbot/bin/python'} 10:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:52 INFO - Downloading/unpacking psutil>=0.7.1 10:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:54 INFO - Installing collected packages: psutil 10:57:54 INFO - Running setup.py install for psutil 10:57:54 INFO - building 'psutil._psutil_linux' extension 10:57:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:57:54 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:57:54 INFO - building 'psutil._psutil_posix' extension 10:57:54 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:57:54 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:57:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:54 INFO - Successfully installed psutil 10:57:54 INFO - Cleaning up... 10:57:54 INFO - Return code: 0 10:57:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:57:54 INFO - Using env: {'DISPLAY': ':0', 10:57:54 INFO - 'HOME': '/home/cltbld', 10:57:54 INFO - 'LANG': 'en_US.UTF-8', 10:57:54 INFO - 'LANGUAGE': 'en_US:en', 10:57:54 INFO - 'LOGNAME': 'cltbld', 10:57:54 INFO - 'MAIL': '/var/mail/cltbld', 10:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:54 INFO - 'MOZ_NO_REMOTE': '1', 10:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:54 INFO - 'NO_EM_RESTART': '1', 10:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:54 INFO - 'PWD': '/builds/slave/test', 10:57:54 INFO - 'SHELL': '/bin/bash', 10:57:54 INFO - 'SHLVL': '1', 10:57:54 INFO - 'TERM': 'linux', 10:57:54 INFO - 'TMOUT': '86400', 10:57:54 INFO - 'USER': 'cltbld', 10:57:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:54 INFO - '_': '/tools/buildbot/bin/python'} 10:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:56 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:57:56 INFO - Installing collected packages: mozsystemmonitor 10:57:56 INFO - Running setup.py install for mozsystemmonitor 10:57:56 INFO - Successfully installed mozsystemmonitor 10:57:56 INFO - Cleaning up... 10:57:57 INFO - Return code: 0 10:57:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:57:57 INFO - Using env: {'DISPLAY': ':0', 10:57:57 INFO - 'HOME': '/home/cltbld', 10:57:57 INFO - 'LANG': 'en_US.UTF-8', 10:57:57 INFO - 'LANGUAGE': 'en_US:en', 10:57:57 INFO - 'LOGNAME': 'cltbld', 10:57:57 INFO - 'MAIL': '/var/mail/cltbld', 10:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:57 INFO - 'MOZ_NO_REMOTE': '1', 10:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:57 INFO - 'NO_EM_RESTART': '1', 10:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:57 INFO - 'PWD': '/builds/slave/test', 10:57:57 INFO - 'SHELL': '/bin/bash', 10:57:57 INFO - 'SHLVL': '1', 10:57:57 INFO - 'TERM': 'linux', 10:57:57 INFO - 'TMOUT': '86400', 10:57:57 INFO - 'USER': 'cltbld', 10:57:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:57 INFO - '_': '/tools/buildbot/bin/python'} 10:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57: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:57: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:57: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:57: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:57: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:57: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:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57: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:57: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:57: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:57: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:57: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:57: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:57:59 INFO - Downloading docopt-0.6.1.tar.gz 10:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:59 INFO - Running setup.py install for blobuploader 10:57:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:58:00 INFO - Running setup.py install for requests 10:58:00 INFO - Running setup.py install for docopt 10:58:00 INFO - Successfully installed blobuploader requests docopt 10:58:00 INFO - Cleaning up... 10:58:00 INFO - Return code: 0 10:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:00 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 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:58:00 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:58:00 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:58:00 INFO - Using env: {'DISPLAY': ':0', 10:58:00 INFO - 'HOME': '/home/cltbld', 10:58:00 INFO - 'LANG': 'en_US.UTF-8', 10:58:00 INFO - 'LANGUAGE': 'en_US:en', 10:58:00 INFO - 'LOGNAME': 'cltbld', 10:58:00 INFO - 'MAIL': '/var/mail/cltbld', 10:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:00 INFO - 'MOZ_NO_REMOTE': '1', 10:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:00 INFO - 'NO_EM_RESTART': '1', 10:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:00 INFO - 'PWD': '/builds/slave/test', 10:58:00 INFO - 'SHELL': '/bin/bash', 10:58:00 INFO - 'SHLVL': '1', 10:58:00 INFO - 'TERM': 'linux', 10:58:00 INFO - 'TMOUT': '86400', 10:58:00 INFO - 'USER': 'cltbld', 10:58:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:00 INFO - '_': '/tools/buildbot/bin/python'} 10:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:58:00 INFO - Running setup.py (path:/tmp/pip-wEYo0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:58:00 INFO - Running setup.py (path:/tmp/pip-CLQ3lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:58:00 INFO - Running setup.py (path:/tmp/pip-duKAzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:58:00 INFO - Running setup.py (path:/tmp/pip-iG1ARD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:58:01 INFO - Running setup.py (path:/tmp/pip-NnoWpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:58:01 INFO - Running setup.py (path:/tmp/pip-OkpHUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:58:01 INFO - Running setup.py (path:/tmp/pip-dz5bCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:58:01 INFO - Running setup.py (path:/tmp/pip-ILibdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:58:01 INFO - Running setup.py (path:/tmp/pip-w6bQvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:58:01 INFO - Running setup.py (path:/tmp/pip-aZ8gAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:58:01 INFO - Running setup.py (path:/tmp/pip-JGwZdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:58:01 INFO - Running setup.py (path:/tmp/pip-t4nqPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:58:01 INFO - Running setup.py (path:/tmp/pip-z1H4ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:58:01 INFO - Running setup.py (path:/tmp/pip-OytknH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:01 INFO - Running setup.py (path:/tmp/pip-yw2iGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:58:01 INFO - Running setup.py (path:/tmp/pip-bYJPnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:58:01 INFO - Running setup.py (path:/tmp/pip-qr9QTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:58:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:58:01 INFO - Running setup.py install for manifestparser 10:58:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Running setup.py install for mozcrash 10:58:02 INFO - Running setup.py install for mozdebug 10:58:02 INFO - Running setup.py install for mozdevice 10:58:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Running setup.py install for mozfile 10:58:02 INFO - Running setup.py install for mozhttpd 10:58:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Running setup.py install for mozinfo 10:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Running setup.py install for mozInstall 10:58:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:58:02 INFO - Running setup.py install for mozleak 10:58:02 INFO - Running setup.py install for mozlog 10:58:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Running setup.py install for moznetwork 10:58:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Running setup.py install for mozprocess 10:58:03 INFO - Running setup.py install for mozprofile 10:58:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Running setup.py install for mozrunner 10:58:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Running setup.py install for mozscreenshot 10:58:03 INFO - Running setup.py install for moztest 10:58:03 INFO - Running setup.py install for mozversion 10:58:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:58:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:58:03 INFO - Cleaning up... 10:58:03 INFO - Return code: 0 10:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:58:03 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:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:03 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:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:03 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 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:58:03 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:58:03 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:58:03 INFO - Using env: {'DISPLAY': ':0', 10:58:03 INFO - 'HOME': '/home/cltbld', 10:58:03 INFO - 'LANG': 'en_US.UTF-8', 10:58:03 INFO - 'LANGUAGE': 'en_US:en', 10:58:03 INFO - 'LOGNAME': 'cltbld', 10:58:03 INFO - 'MAIL': '/var/mail/cltbld', 10:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:03 INFO - 'MOZ_NO_REMOTE': '1', 10:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:03 INFO - 'NO_EM_RESTART': '1', 10:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:03 INFO - 'PWD': '/builds/slave/test', 10:58:03 INFO - 'SHELL': '/bin/bash', 10:58:03 INFO - 'SHLVL': '1', 10:58:03 INFO - 'TERM': 'linux', 10:58:03 INFO - 'TMOUT': '86400', 10:58:03 INFO - 'USER': 'cltbld', 10:58:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:03 INFO - '_': '/tools/buildbot/bin/python'} 10:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:58:03 INFO - Running setup.py (path:/tmp/pip-UGVWYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:58:04 INFO - Running setup.py (path:/tmp/pip-_L6HtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:58:04 INFO - Running setup.py (path:/tmp/pip-ynrcEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:58:04 INFO - Running setup.py (path:/tmp/pip-Eb5fUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:58:04 INFO - Running setup.py (path:/tmp/pip-_fhDqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:58:04 INFO - Running setup.py (path:/tmp/pip-YSbC3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:58:04 INFO - Running setup.py (path:/tmp/pip-LtGWi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:58:04 INFO - Running setup.py (path:/tmp/pip-3uwjtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:58:04 INFO - Running setup.py (path:/tmp/pip-rWcIX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:58:04 INFO - Running setup.py (path:/tmp/pip-wagC1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:58:04 INFO - Running setup.py (path:/tmp/pip-ywJQ9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:58:04 INFO - Running setup.py (path:/tmp/pip-HRGycD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:58:04 INFO - Running setup.py (path:/tmp/pip-tGUDkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:58:04 INFO - Running setup.py (path:/tmp/pip-ZPtUuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:05 INFO - Running setup.py (path:/tmp/pip-VBshYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:58:05 INFO - Running setup.py (path:/tmp/pip-5HTWU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:58:05 INFO - Running setup.py (path:/tmp/pip-wIZpTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:58:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:07 INFO - Downloading blessings-1.6.tar.gz 10:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:58:07 INFO - Installing collected packages: blessings 10:58:07 INFO - Running setup.py install for blessings 10:58:07 INFO - Successfully installed blessings 10:58:07 INFO - Cleaning up... 10:58:07 INFO - Return code: 0 10:58:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:58:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:58:07 INFO - Reading from file tmpfile_stdout 10:58:07 INFO - Current package versions: 10:58:07 INFO - argparse == 1.2.1 10:58:07 INFO - blessings == 1.6 10:58:07 INFO - blobuploader == 1.2.4 10:58:07 INFO - docopt == 0.6.1 10:58:07 INFO - manifestparser == 1.1 10:58:07 INFO - mozInstall == 1.12 10:58:07 INFO - mozcrash == 0.17 10:58:07 INFO - mozdebug == 0.1 10:58:07 INFO - mozdevice == 0.48 10:58:07 INFO - mozfile == 1.2 10:58:07 INFO - mozhttpd == 0.7 10:58:07 INFO - mozinfo == 0.9 10:58:07 INFO - mozleak == 0.1 10:58:07 INFO - mozlog == 3.1 10:58:07 INFO - moznetwork == 0.27 10:58:07 INFO - mozprocess == 0.22 10:58:07 INFO - mozprofile == 0.28 10:58:07 INFO - mozrunner == 6.11 10:58:07 INFO - mozscreenshot == 0.1 10:58:07 INFO - mozsystemmonitor == 0.0 10:58:07 INFO - moztest == 0.7 10:58:07 INFO - mozversion == 1.4 10:58:07 INFO - psutil == 3.1.1 10:58:07 INFO - requests == 1.2.3 10:58:07 INFO - wsgiref == 0.1.2 10:58:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:07 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 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:58:07 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:58:07 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:58:07 INFO - Using env: {'DISPLAY': ':0', 10:58:07 INFO - 'HOME': '/home/cltbld', 10:58:07 INFO - 'LANG': 'en_US.UTF-8', 10:58:07 INFO - 'LANGUAGE': 'en_US:en', 10:58:07 INFO - 'LOGNAME': 'cltbld', 10:58:07 INFO - 'MAIL': '/var/mail/cltbld', 10:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:07 INFO - 'MOZ_NO_REMOTE': '1', 10:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:07 INFO - 'NO_EM_RESTART': '1', 10:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:07 INFO - 'PWD': '/builds/slave/test', 10:58:07 INFO - 'SHELL': '/bin/bash', 10:58:07 INFO - 'SHLVL': '1', 10:58:07 INFO - 'TERM': 'linux', 10:58:07 INFO - 'TMOUT': '86400', 10:58:07 INFO - 'USER': 'cltbld', 10:58:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:07 INFO - '_': '/tools/buildbot/bin/python'} 10:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 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:58:07 INFO - Cleaning up... 10:58:07 INFO - Return code: 0 10:58:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:58:07 INFO - Using env: {'DISPLAY': ':0', 10:58:07 INFO - 'HOME': '/home/cltbld', 10:58:07 INFO - 'LANG': 'en_US.UTF-8', 10:58:07 INFO - 'LANGUAGE': 'en_US:en', 10:58:07 INFO - 'LOGNAME': 'cltbld', 10:58:07 INFO - 'MAIL': '/var/mail/cltbld', 10:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:07 INFO - 'MOZ_NO_REMOTE': '1', 10:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:07 INFO - 'NO_EM_RESTART': '1', 10:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:07 INFO - 'PWD': '/builds/slave/test', 10:58:07 INFO - 'SHELL': '/bin/bash', 10:58:07 INFO - 'SHLVL': '1', 10:58:07 INFO - 'TERM': 'linux', 10:58:07 INFO - 'TMOUT': '86400', 10:58:07 INFO - 'USER': 'cltbld', 10:58:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:07 INFO - '_': '/tools/buildbot/bin/python'} 10:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:08 INFO - Downloading/unpacking jsonschema 10:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:58:09 INFO - Downloading/unpacking functools32 (from jsonschema) 10:58: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:58: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:58: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:58: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:58: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:58: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:58:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:58:10 INFO - warning: no files found matching '*.txt' 10:58:10 INFO - no previously-included directories found matching 'build' 10:58:10 INFO - no previously-included directories found matching 'dist' 10:58:10 INFO - no previously-included directories found matching '.git*' 10:58:10 INFO - Installing collected packages: jsonschema, functools32 10:58:10 INFO - Running setup.py install for functools32 10:58:10 INFO - warning: no files found matching '*.txt' 10:58:10 INFO - no previously-included directories found matching 'build' 10:58:10 INFO - no previously-included directories found matching 'dist' 10:58:10 INFO - no previously-included directories found matching '.git*' 10:58:10 INFO - Successfully installed jsonschema functools32 10:58:10 INFO - Cleaning up... 10:58:10 INFO - Return code: 0 10:58:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe853c10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, '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': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', '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:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:58:10 INFO - Using env: {'DISPLAY': ':0', 10:58:10 INFO - 'HOME': '/home/cltbld', 10:58:10 INFO - 'LANG': 'en_US.UTF-8', 10:58:10 INFO - 'LANGUAGE': 'en_US:en', 10:58:10 INFO - 'LOGNAME': 'cltbld', 10:58:10 INFO - 'MAIL': '/var/mail/cltbld', 10:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:10 INFO - 'MOZ_NO_REMOTE': '1', 10:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:10 INFO - 'NO_EM_RESTART': '1', 10:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:10 INFO - 'PWD': '/builds/slave/test', 10:58:10 INFO - 'SHELL': '/bin/bash', 10:58:10 INFO - 'SHLVL': '1', 10:58:10 INFO - 'TERM': 'linux', 10:58:10 INFO - 'TMOUT': '86400', 10:58:10 INFO - 'USER': 'cltbld', 10:58:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:10 INFO - '_': '/tools/buildbot/bin/python'} 10:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:10 INFO - Downloading/unpacking flake8 10:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:58:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:58: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:58: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:58: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:58: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:58: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:58: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:58:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:58:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:58: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:58: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:58: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:58: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:58: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:58: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:58:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:58: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:58: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:58: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:58: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:58: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:58: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:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:13 INFO - no previously-included directories found matching 'docs/_build' 10:58:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:58:13 INFO - Running setup.py install for pep8 10:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:13 INFO - no previously-included directories found matching 'docs/_build' 10:58:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:58:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:58:13 INFO - Cleaning up... 10:58:13 INFO - Return code: 0 10:58:13 INFO - Running post-action listener: _resource_record_post_action 10:58:13 INFO - Running post-action listener: _start_resource_monitoring 10:58:13 INFO - Starting resource monitoring. 10:58:13 INFO - ##### 10:58:13 INFO - ##### Running install step. 10:58:13 INFO - ##### 10:58:13 INFO - Running pre-action listener: _resource_record_pre_action 10:58:13 INFO - Running main action method: install 10:58:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:58:13 INFO - Reading from file tmpfile_stdout 10:58:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:58:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:58:13 INFO - Reading from file tmpfile_stdout 10:58:13 INFO - Output received: 10:58:13 INFO - Usage: mozinstall [options] installer 10:58:13 INFO - Options: 10:58:13 INFO - -h, --help show this help message and exit 10:58:13 INFO - -d DEST, --destination=DEST 10:58:13 INFO - Directory to install application into. [default: 10:58:13 INFO - "/builds/slave/test"] 10:58:13 INFO - --app=APP Application being installed. [default: firefox] 10:58:13 INFO - mkdir: /builds/slave/test/build/application 10:58:13 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:58:13 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:58:27 INFO - Reading from file tmpfile_stdout 10:58:27 INFO - Output received: 10:58:27 INFO - /builds/slave/test/build/application/firefox/firefox 10:58:27 INFO - Running post-action listener: _resource_record_post_action 10:58:27 INFO - ##### 10:58:27 INFO - ##### Running run-tests step. 10:58:27 INFO - ##### 10:58:27 INFO - Running pre-action listener: _resource_record_pre_action 10:58:27 INFO - Running main action method: run_tests 10:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:58:27 INFO - Python 2.7.3 10:58:27 INFO - Return code: 0 10:58:27 INFO - grabbing minidump binary from tooltool 10:58:27 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:58:27 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 0x260a410>, '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 0x260b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:58:27 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:58:27 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:58:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:58:27 INFO - Return code: 0 10:58:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:58:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:58:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:58:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:58:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:58:28 INFO - Return code: 0 10:58:28 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/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:58:28 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/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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:58:28 INFO - Using env: {'DISPLAY': ':0', 10:58:28 INFO - 'HOME': '/home/cltbld', 10:58:28 INFO - 'LANG': 'en_US.UTF-8', 10:58:28 INFO - 'LANGUAGE': 'en_US:en', 10:58:28 INFO - 'LOGNAME': 'cltbld', 10:58:28 INFO - 'MAIL': '/var/mail/cltbld', 10:58:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:58:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:28 INFO - 'MOZ_NO_REMOTE': '1', 10:58:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:28 INFO - 'NO_EM_RESTART': '1', 10:58:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:28 INFO - 'PWD': '/builds/slave/test', 10:58:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:58:28 INFO - 'SHELL': '/bin/bash', 10:58:28 INFO - 'SHLVL': '1', 10:58:28 INFO - 'TERM': 'linux', 10:58:28 INFO - 'TMOUT': '86400', 10:58:28 INFO - 'USER': 'cltbld', 10:58:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467741457.302544-1835123630', 10:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:28 INFO - '_': '/tools/buildbot/bin/python'} 10:58:28 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/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:58:28 INFO - mozversion application_buildid: 20160705080222 10:58:28 INFO - mozversion application_changeset: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f 10:58:28 INFO - mozversion application_display_name: Firefox 10:58:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:58:28 INFO - mozversion application_name: Firefox 10:58:28 INFO - mozversion application_remotingname: firefox 10:58:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:58:28 INFO - mozversion application_vendor: Mozilla 10:58:28 INFO - mozversion application_version: 48.0 10:58:28 INFO - mozversion platform_buildid: 20160705080222 10:58:28 INFO - mozversion platform_changeset: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f 10:58:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:58:28 INFO - mozversion platform_version: 48.0 10:58:28 INFO - using testdate: 1467741508 10:58:28 INFO - actual date: 1467741508 10:58:28 INFO - starting webserver on 'localhost:34926' 10:58:28 INFO - SUITE-START | Running 2 tests 10:58:28 INFO - TEST-START | dromaeo_css 10:58:28 INFO - operating with platform_type : linux_ 10:58:28 INFO - Initialising browser for dromaeo_css test... 10:58:28 INFO - TEST-INFO | started process 15800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMfNa8/profile http://localhost:34926/getInfo.html) 10:58:32 INFO - PROCESS | 15800 | __metrics Screen width/height:1600/1200 10:58:32 INFO - PROCESS | 15800 | colorDepth:24 10:58:32 INFO - PROCESS | 15800 | Browser inner width/height: 1024/697 10:58:32 INFO - PROCESS | 15800 | __metrics 10:58:33 ERROR - PROCESS | 15800 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:58:34 INFO - TEST-INFO | 15800: exit 0 10:58:34 INFO - Browser initialized. 10:58:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:58:34 INFO - TEST-INFO | started process 15889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMfNa8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:45 INFO - PROCESS | 15889 | RSS: Main: 139194368 10:58:45 INFO - PROCESS | 15889 | 10:59:37 INFO - PROCESS | 15889 | 1467741577004 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] 11:01:44 INFO - PROCESS | 15889 | Cycle 1(1): loaded http://localhost:34926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34926/tests/dromaeo/cssquery-ext.html) 11:01:45 INFO - PROCESS | 15889 | RSS: Main: 244674560 11:01:45 INFO - PROCESS | 15889 | 11:04:47 INFO - PROCESS | 15889 | Cycle 1(1): loaded http://localhost:34926/tests/dromaeo/cssquery-ext.html (next: http://localhost:34926/tests/dromaeo/cssquery-jquery.html) 11:04:48 INFO - PROCESS | 15889 | RSS: Main: 218783744 11:04:48 INFO - PROCESS | 15889 | 11:07:50 INFO - PROCESS | 15889 | Cycle 1(1): loaded http://localhost:34926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34926/tests/dromaeo/cssquery-mootools.html) 11:07:50 INFO - PROCESS | 15889 | RSS: Main: 225882112 11:07:50 INFO - PROCESS | 15889 | 11:10:52 INFO - PROCESS | 15889 | Cycle 1(1): loaded http://localhost:34926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34926/tests/dromaeo/cssquery-prototype.html) 11:10:52 INFO - PROCESS | 15889 | RSS: Main: 211488768 11:10:52 INFO - PROCESS | 15889 | 11:13:55 INFO - PROCESS | 15889 | Cycle 1(1): loaded http://localhost:34926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34926/tests/dromaeo/cssquery-yui.html) 11:13:56 INFO - PROCESS | 15889 | RSS: Main: 212422656 11:13:56 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | Cycle 1(1): loaded http://localhost:34926/tests/dromaeo/cssquery-yui.html (next: http://localhost:34926/tests/dromaeo/cssquery-dojo.html) 11:16:58 INFO - PROCESS | 15889 | RSS: Main: 253714432 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | __start_tp_report 11:16:58 INFO - PROCESS | 15889 | _x_x_mozilla_page_load 11:16:58 INFO - PROCESS | 15889 | _x_x_mozilla_page_load_details 11:16:58 INFO - PROCESS | 15889 | |i|pagename|runs| 11:16:58 INFO - PROCESS | 15889 | |0;dojo.html;3297.5548300979367;3386.3227354529095;3390.9321813563715;3407.3526030054304;3424.5376874121985;5536.224928510007;5541.9168712469345;5551.500364967153;5564.137558678402;5588.524975377088;5552.805651802188;5617.859553511164;5621.437856214377;5627.915581266274;5670.036093864042;4932.8520144395725;5015.423226328982;5148.047611191922;5197.454267301936;5230.529252367286;4998.750062496879;5033.043721692885;5070.74646267687;5072.619553533481;5076.923846142311;4993.275974983625;5020.924686129711;5083.618728595352;5105.361829771278;5106.463821298766;5060.873478163038;5074.720890351029;5091.363579552556;5093.439721630618;5119.539241468267;4934.728589927553;4938.185199442088;4944.98627781304;4972.453030166679;5057.5701065409485;5354.973225133888;5361.356637203521;5388.245645609618;5391.757370918318;5402.567794576425;5863.5309175265875;5908.409159084057;5908.8227353179045;5910.497607703307;5911.497522710575;5867.911981320283;5937.465628093449;5943.494802941756;5961.880762384728;5992.9700351498395;5496.395396506381;5512.6968016759065;5538.418466061086;5550.389457159709;5564.1931919871395;5994.610350327215;6008.429199226067;6009.609375390673;6014.879702405928;6037.54718396122;5759.22250496186;5787.131930210502;5787.334456537468;5805.10020946754;5814.592978491465;5843.590948633555;5845.795397161079;5850.882982340415;5852.4440178183;5860.589758716934;5728.398518155617;5803.071508558611;5808.39011903744;5827.825165245049;5923.703814809242;5926.555508336892;5929.644221346647;5935.347111817697;5936.406359364116;5972.432618901197;4526.547345265447;4529.38853254813;4535;4539.659525535598;4557.270836666117;3917.040325120364;4024.335984562573;4054.3715724062818;4080.816363263601;4093.9795301023305;5712.0860662293835;5723.856903577361;5730.111832665943;5732.369439361751;5735.340435849931;6010.038393856962;6024.487918526975;6025.638461692225;6026.0659597762415;6039.577229593974;5570.303712035996;5591.944080559224;5597.972010139923;5635.802746903839;5699.572532060112;4995.850124496271;5023.648344615842;5024.49755024502;5028.120078986163;5030.195168772979;6161.229846269216;6177.135201071854;6177.62934223948;6182.1345011698395;6182.227221597301;5808.448197421239;5870.7945221917025;5954.672493012839;5958.285005799332;5985.910211346921;6151.205492575522;6163.907541386972;6197.659128747962;6206.410391012847;6208.2239720034995;5848.795292164754;5850.23946886919;5852.882942341214;5855.385184555731;5868.823935281948;5818.7090645466715;5924.229850119457;5994.400559943971;6077.027675571887;6092.786752463642;5798.76804927815;5848.94151058501;5860.882782344414;5861.824145275648;5865.5600829937075;5776.364599894092;5847.736851841592;5852.707364631666;5862.560307976833;5863.1791549184;5562.415946325577;5593.860153496195;5619.943800561942;5632;5635.88728225425;5830;5863.73613187399;5883.117532370179;5885.646861188342;5886.882262354643;5619.438056194512;5776.855578610568;5777.306723193244;5782.826515204551;5795.681237531976 11:16:58 INFO - PROCESS | 15889 | |1;ext.html;657.4707360574738;678.3928384096231;688.366702633577;725.956442613443;743.0266351080083;31852.36295274096;32483.187920301974;38077.619223807786;38673.419898701475;38908.41637375434;42729.14541709164;43033.7848310758;43128.353074703904;43201.135977280435;43230.35154472685;8044.637991290406;8749.300055995505;8907.955460222722;8926.062763409846;10266.384016959006;10235.181185505142;10358.637447689294;10359.067683908446;10370;10384.169266458664;10531.894681053207;10639;10656.680299591024;10659.413732244724;10660.30708003981;10687.679369618923;10757.83863242052;10766.892331076668;10774;10774.353538787658;10587.205959552988;10651.84022239667;10688.14494840411;10689.46552672371;10702.571897124106;41675.1664966702;42129.36805947913;42131.57868421307;42191.312347506064;42237.78881105605;3884.883453496371;4070.328395814687;4488.887777805581;4598.931016034762;4604.6776725629215;31979.52030719541;33231.66768332334;33403.83298083494;33437.665623343695;34843;4396.758178300192;4429.069895321986;4448.488423831236;4484;4502.459704835408;330547;330679;332370;332553;334298;62598.37401626017;63101.16044777996;63145.68427157835;63178;63182.68408658019;67197;68226.317736823;68228.31771682319;68279;68289;17904.194311256026;19804.40586782399;20046.198152074045;20145.597088058155;20167.19331226764;13594.796078058836;13711.725765484634;15043.247837608295;15404.691906161814;15450.30473628667;19707.704384434244;19857.801421985885;20147.496312592302;20562.355011599037;20640.27759028427;7406;7415.40676745859;7462.141853686787;7465.29079737424;7701.576413297323;1120.0871289898707;1153.6827372472637;1173.178774857603;1208.4018410886492;1281.2824818101892;32269.35461290761;32717.509237361457;33158.17104572405;33421.3315733684;33822;1274.9171303865405;1301.4859130643342;1310.462710288777;1329.9135556188817;1352.5401363536446;17497.47507574775;17661.646767064845;17828.197731102133;17910.283588656308;18009.819901800813;458994;460550;465298;465327;466437;61856.38143618596;62594.37405625977;62657;62718;62781.68609157016;1459.6934643724937;1495.0954672423245;1526.885483588713;1542.1286972860523;1611.8710503159718;30011.399772004876;30460.246864224144;32498.187545311557;32678.275124447315;32829.83585082059;48241.517584823705;48767.512324877716;49500.75249623729;49503;49514.75242623764;293027;294960;295137;295610;296668;27237.72762272352;30509.54235686511;30574.84712576423;30855.382892342477;30916.227094321923;44178.33732493951;44223.77888110539;44676.10647787091;45245;45311.77344113258;37519;37809.243815122994;38173.42739858849;39674.801625991684;40370.79814600908;38823.805880970416;39400.226989786104;40126.19747604973;40527.59472405238;40731;37588.62411375961;37686;37732.62267377401;38018.42972355472;41969.580304197785;35152.29695406129;36050;36578.634213657526;37022.259554809294;37305.25389492141;27854.442911141257;28383.574246386735;28684.85657571699;29479.557806633347;30388.544171837 11:16:58 INFO - PROCESS | 15889 | |2;jquery.html;407.83890363306483;412.3443724478081;418.2408927796052;423.3438170835205;428.1009879253568;18106.728399074025;18507.5373115672;19085.809141908576;19168.233270669174;19172.233110675574;18261.36085237017;18555.72166417505;18862.43412697621;19268.3256086037;19269.71095433566;5578.135389014709;5632.098864181732;5820.796272130455;5830.300363956331;5844.912326315109;5735.799247026355;5785.913211301834;5822.068469044953;5823.650580965134;5828.388019257981;5623.887522249553;5672.347680016789;5778.566607504454;5798.188253644493;5801.47786699197;5681.886362272752;5702.885942281131;5721.885562288772;5725.856853578653;5746.339170995348;5148.588112950993;5156.845294641167;5158.200478925773;5165.896682066337;5255.658382205144;13946.51187208453;14137.222452765094;14145.646358841008;14169.858301416956;15478.845211547852;2316.7219933607907;2342.332435255944;2507.8119141064494;2541.2503311523146;2713.3894873653467;10277.075063244269;10356.119729822974;12199.451024703909;14002.369893354824;14066.2966851657;1974.9506262343414;1978.7229787829715;1997.1412292714126;1998.3405476192822;2246.651768975795;89409.55295223548;91664.54167729118;93623.53188234015;96919.51540242325;97324.51337743337;18174.5456363592;18197.7244096064;18261.178246978918;18490.537736556424;18818;33618.327633447196;33952.83023584866;34359.484607730905;34396.48405273923;34624;10646;10695.197860160519;10993.900609938943;11216.719582010515;11257.324560526395;9534.9988251234;9570.282228832866;9672.903270967341;9685.70942871715;9773.07155820196;9310.115539023782;9336.766580835534;9444;9509.191718703849;9654.372465789702;3223.903872683299;3427.869417352085;3663.5970043295215;3703.2408356287438;3864.3623802072907;1000.979001418549;1074.9408782517037;1103.0734183286079;1130.0676941523277;1164.5923926625612;18860.717089243673;19160.520986975436;19319.710204346946;19459.4162175135;19548.511287217934;1060.4326685223368;1086.7337502311984;1126.3523474002482;1131.055568600228;1161.5992482593492;10579.047885690325;11025.61410350634;11148.944255278671;11198.104151667847;11225.214235003472;492052;494021;496888;497619;502320;95559.52220238854;100857;101738.49130754446;103677.48161259145;104239.95760042302;1135.2847705945367;1146.4095990564865;1157.3750174905624;1178.7465694875643;1180.2682336950973;18134.32761422473;18356.908215458836;18382.540436489195;18392.63214735671;18475.538111547317;30584.388312234074;34846.825765871006;42220.577794222896;43420.348694768974;43781.56218437902;58689.4131058701;64009.35990640034;64366;64749.35250647433;65436.34563654493;8895.332850036144;8934.642614295355;8976.41653292534;9009.819803604023;9056.773580660536;9770.609175632895;13636.386362613508;13722.519711810039;14056.718865622835;14227.857721422653;12037.518499259932;12099.81850272229;12206.267623942236;12299.87700123023;12413.44139513706;11787.233829801036;11833.763324733629;11855.822162667739;12172.45223964906;12436.440360183995;12220.51117955272;12312.445939932546;12454.065945054339;12660.620181394574;12836.679083022998;8620.224179823846;8939.553022348986;8940.46357218569;9146.268298535968;9151.222146117389;12416.255024698547;12560;12624.368781561068;12694.492220311084;12707.110502264753 11:16:58 INFO - PROCESS | 15889 | |3;mootools.html;1401.782723677829;1518.14224962896;1524.3521503361071;1752.3779058434257;1895.488218181092;8340.666373345066;8532.23209911108;8548.743537693872;8551.786205344853;8555.57222138893;8339.62471688774;8515.23362897339;8521.531315777629;8538.573071346438;8546.700865469695;2305.0203663443012;2310.514791893696;2327.4995875886766;2330.021391015777;2342.02805835578;2306.642470417088;2375.904963801446;2387.259949415678;2388.2118900762707;2391.7129944406697;2288.9198878039274;2298.8620682759006;2308.6075367187536;2330.5222429401933;2332.183735692511;2294.6443301288327;2323.140438037928;2337.9415514612188;2338.462153704649;2345.144022431817;2339.4385347516472;2354.2348736660656;2357.752435994213;2358.375030616871;2374.4894847607675;8228.711995080144;8420.915790842075;8590.441621294658;8628.870566941501;8631.136886311318;5100.413452452941;5230.424653288135;5231.319928409321;5235.816746413857;5236.136037553799;3363.5122907178566;3383.509391138296;3429.9142521437166;3470.0630829676097;3478.5477887874667;1111.6387174168347;1139.0545846947014;1161.5469966712988;1167.2937872587133;1194.3908606610605;11970.281783093042;12047.578334758242;12074.034077273885;12076.939615301955;12085.274883507018;4113.9794301028305;4217.072244106292;4287.249731297073;4385.824567017347;4385.890352741207;9595.42427454355;9613.51932403391;9670.806583868283;9688.224942004763;9701.854472182922;4992.475790041994;5010.423801262828;5017.598592112695;5029.2958985742025;5033.6224783141415;4217;4656.231721765938;4685.20351540239;4729.834455794031;4791.401074865642;3832.2527107214382;3938.448617193595;3969.027588240842;3969.106950936074;4082.8366865325056;1191.6782468733568;1219.3354621731178;1220.9450574724158;1230.2864338683542;1232.125191114301;943.8253923024263;1051.4269723000982;1065.6909496246158;1073.4793625091825;1076.9461526923778;5878.794242201588;5924;5984.102384642339;6082.847928801815;6145.84635384119;425.857337791837;431.78195011518983;434.4374035623875;442.263631054291;458.7293496836882;4109.0959988802415;4150.169966006811;4158.854440094643;4163.2298024865495;4170.562090980464;10486.528106235237;10596.576136954589;10624;10733.83899241512;10764.838527422095;10547.050765430995;10610.09814165789;10613.73465663349;10617.469126543641;10632.627858025087;8219.301359384399;8301.211384918422;8303.792405189919;8307.376946728898;8321.500709957421;5646.237757902631;5717.17101020358;5757.91363129545;5768.798092066758;5904;9435.669751558662;9445.52772361393;9515.096065873731;9578.760530986503;9669.27480438984;9262.259019278576;9333.626654933998;9653.2277417805;9679.806403871742;9721.756956076155;6805.89791153143;7392.22381649919;7618.314351708373;7633.885491717518;7722.034745656793;7868.803279918048;7870.055593328837;7894;7922.762317130495;7930.524168549906;7404.96297518509;7514.323710866049;7545.132309784225;7600.771976840703;7682.961585192038;7196.172440169447;7378.667959941923;7395.852082958203;7464;7483.588402637907;6725.697343619451;6735.966320168368;6748.156480439945;6785.558938668971;6789.388954994074;4915.164422048332;5003.724795136302;5038;5076.213186956028;5108.693478391308;4819.566239038503;4938.975305123451;4961.3798275215595;4973.452920178705;5047.2429135629945 11:16:58 INFO - PROCESS | 15889 | |4;prototype.html;330.444852647552;341.7761366305069;341.7966310045523;345.1733099227352;347.98260086995657;6059.727312270948;6073.301570319414;6157;6163.137160797486;6193.349698281683;6064.272287325527;6077.635341879491;6078.513718902488;6088.543359248063;6096.878062438748;4411.84558540452;4577.198990176722;4705.882352941187;4714.2928560716;4722.64580156488;4687.578117969382;4706.058788242348;4714.952850471503;4718.41019872516;4723.197056500403;4438.068005718803;4683.344331793552;4688.812447502096;4693.9061218775605;4697.765111744417;4533.773311334437;4546.431696037996;4576.542345765413;4672.229082201433;4675.625949923998;4102.118044620421;4111.321631930728;4112.91774164518;4114.876553703364;4121.196366708463;5889.528837692974;5906.143609176645;5908.261467316585;5916.1421593868645;5916.201312822757;5438.592105592096;5446.264754258164;5446.863828404282;5451.863703407407;5453.618246722731;6465.709043093072;6467.482601391877;6478.902816457757;6483.319251478574;6491.610503369813;4326.870193894157;4466.307722303049;4467.262901621229;4468.218061839165;4488.730676159441;6715.496337774637;6823.829404264883;6826.5904045756915;6826.658667066627;6834.316568343126;4551.158035763395;4551.590356867898;4555.043440877386;4555.385023021916;4561.908761824745;4605.078984203105;4609.53904609543;4617.792199351037;4618.1918164321105;4620.399348084795;5361.383440904346;5367.892642147135;5368.9731551342775;5369.4898984597185;5379.004884096455;6447.954798663067;6500.5449618526245;6553.803385898431;6567.573107747981;6573.5069869759;1595.4814685227116;1607.5418505726045;1617.9110148941686;1617.9757303640454;1620.813606435275;972.8783902012249;1040.3341861208833;1052.2686732720686;1062.914966802654;1074.7420619051527;6279.277883043508;6441.613503189824;6454.935450645527;6459.483241340776;6463.644499552475;6817.5227734059135;6819.897701534481;6820.181578210647;6831.487638427137;6874.862502749917;6393.264774550986;6431.807045788634;6432.421082102634;6440.098386225932;6450.516211284079;3621.8008009559726;3655.7440979131206;3664.6518580734787;3664.9083772905356;3671.687906527975;6920.065791118235;7130.3939165170505;7185.784426467214;7197.208307086216;7199.352058314672;6909.239983601799;6909.827254318682;6918.377346038881;6919.965400173068;6926.099607051051;7101.183363913113;7132;7133.89299160513;7140.571565706075;7165.7850264492145;6809.761658341934;6817.147856517935;6819.113515242987;6819.931800682129;6822.317768223138;6508.772192973223;6698.5980841149685;6711.161104861892;6732;6733.528652994243;7146.785596432115;7156.713731450684;7163.7492687755675;7167.677454514664;7173.784786456415;4531.637469002538;4573.199690054294;4574.634029277583;4580.473245576802;4586.151561961048;6813.8977915330315;6814.386705196556;6816.2842901496615;6818.795436136924;6823.624700641314;6391.392817682313;6593.241777195684;6603.471722262304;6605.801825945229;6609.173853268341;6568.1789776277965;6586.4401525870835;6596.30738772422;6610.239822420291;6617.933820661732;6475.3200913903365;6477.643729594917;6482.124913136666;6485.254195767358;6492.415682588589;6631.171103612049;6689.431398331002;6692.732290708317;6701.229358623821;6701.463882889455;6364.299927008118;6472.093906852951;6474.2878283387845;6480.740770369321;6492.902606460812 11:16:58 INFO - PROCESS | 15889 | |5;yui.html;868.8436081505326;915.0666320353239;918.3663272342084;923.219879202074;935.9251259899205;14997.325120369582;15192.468263610775;15229.086254824704;15237.69524609507;15279.465218717347;14547.127172369665;14639.268036598181;14640.560783176496;14658.780118298235;14661.340239689212;746.4103358346927;861.9525926074064;883.730462209026;888.0852721696647;888.373696543935;892.5849479991803;901.8827552418177;902.4089221559856;904.4618452021069;904.651709092001;935.6257497001186;937.0254934867729;939.3377668743519;939.3706216834703;939.7415710679584;776.1733753552477;923.5474617437475;933.3373304953525;940.1350757303229;940.9388389754644;684.7671791590833;685.2530741491798;685.3626127701236;689.5449003657612;689.6792991259089;13930.37313320903;13950.441982320695;14004.71990560183;14018.579442616738;14022.509212177525;14503;15136.621584460476;15218.619534511616;15293;15298.311575978996;12287.631371058882;12521.812172817416;12644.873551264462;12741.617751467378;12757.42591583381;4129.112240868198;4129.421880936671;4159.8960025999595;4161.958380416218;4210.410542524049;53321;53493.73253133748;53575.464245357434;53594;53954.46045539534;10560.911916275276;11195.664130075947;11281.548738050386;11489.540418383338;11567.479463423997;20045.498862528555;20083.899580502002;20104.195832166843;20127.798722012885;20136.093875775627;8353.122922093215;8617.69838055665;8728.345374096842;8773;8949.59726812295;4657.068586282757;4976.328195693607;5050.3182070420025;5053.519915608012;5069.188929771219;3582.426811710166;3658.9451158232114;3661.4324779659196;3665.9450108248398;3672.6878215351994;550.9421510741395;645.5803727577113;670.299536983853;677.2516369411827;677.2584020497547;595.8838026584774;661.9801405957829;698.8078278473358;711.2531841566334;816.2775943290231;9377.15605595486;10000.549975251131;10089.697309080739;10125.443100629389;10190.720182180456;613.6195558753512;661.6625520984333;707.3563057617544;723.5550136665912;807.1444269074799;4503.347014682852;4608.769561521911;4635.930461043087;4711.411073615798;4729.456112547101;67225;68020;68295.65852170707;68945.65527172331;68947.31052689509;58329.66681332699;58844;60103.69948150231;60464.09303860446;60608.696956515814;53234.20148697773;53754.999999999214;53874.7306263474;54152.45847541553;54732.452675473534;9074.364794464589;9201.263898888206;9263.120003599648;9301.767455813388;9317.72046838596;38688.6131138685;39218.80390598029;40561.59438405578;40960.59039409687;41629.79185104055;46229.76885115553;46337;49068.50931490639;50660;50974.490255098455;11597.362145082101;11649.650510484698;11729.648110556696;12021.519139234333;12603.117781755189;13009.869901300866;13051.151675141085;13140.737185256432;13669;13748.243846588533;12368.75262494727;12398.62804115878;12658.43037063316;12708.745825083262;12713.364331783188;12205.145639805129;12241.20432171906;12244.142909996215;12413.813792793297;12557.93721031389;11990.760184796081;12125.393730313626;12395.62813115608;12601.810972835598;12831.615051548468;10378.792424151627;10463.372197668165;10466.738331541468;10567.365958042543;11183.552657893919;10325.690229293134;10340.948295258777;10358.533865975898;10393.428361440194;10407.84388234162 11:16:58 INFO - PROCESS | 15889 | __end_tp_report 11:16:58 INFO - PROCESS | 15889 | __start_cc_report 11:16:58 INFO - PROCESS | 15889 | _x_x_mozilla_cycle_collect,807 11:16:58 INFO - PROCESS | 15889 | __end_cc_report 11:16:58 INFO - PROCESS | 15889 | __startTimestamp1467742618543__endTimestamp 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | ------- Summary: start ------- 11:16:58 INFO - PROCESS | 15889 | Number of tests: 6 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | [#0] dojo.html Cycles:165 Average:5514.87 Median:5759.22 stddev:611.04 (10.6%) stddev-sans-first:587.63 11:16:58 INFO - PROCESS | 15889 | Values: 3297.6 3386.3 3390.9 3407.4 3424.5 5536.2 5541.9 5551.5 5564.1 5588.5 5552.8 5617.9 5621.4 5627.9 5670.0 4932.9 5015.4 5148.0 5197.5 5230.5 4998.8 5033.0 5070.7 5072.6 5076.9 4993.3 5020.9 5083.6 5105.4 5106.5 5060.9 5074.7 5091.4 5093.4 5119.5 4934.7 4938.2 4945.0 4972.5 5057.6 5355.0 5361.4 5388.2 5391.8 5402.6 5863.5 5908.4 5908.8 5910.5 5911.5 5867.9 5937.5 5943.5 5961.9 5993.0 5496.4 5512.7 5538.4 5550.4 5564.2 5994.6 6008.4 6009.6 6014.9 6037.5 5759.2 5787.1 5787.3 5805.1 5814.6 5843.6 5845.8 5850.9 5852.4 5860.6 5728.4 5803.1 5808.4 5827.8 5923.7 5926.6 5929.6 5935.3 5936.4 5972.4 4526.5 4529.4 4535.0 4539.7 4557.3 3917.0 4024.3 4054.4 4080.8 4094.0 5712.1 5723.9 5730.1 5732.4 5735.3 6010.0 6024.5 6025.6 6026.1 6039.6 5570.3 5591.9 5598.0 5635.8 5699.6 4995.9 5023.6 5024.5 5028.1 5030.2 6161.2 6177.1 6177.6 6182.1 6182.2 5808.4 5870.8 5954.7 5958.3 5985.9 6151.2 6163.9 6197.7 6206.4 6208.2 5848.8 5850.2 5852.9 5855.4 5868.8 5818.7 5924.2 5994.4 6077.0 6092.8 5798.8 5848.9 5860.9 5861.8 5865.6 5776.4 5847.7 5852.7 5862.6 5863.2 5562.4 5593.9 5619.9 5632.0 5635.9 5830.0 5863.7 5883.1 5885.6 5886.9 5619.4 5776.9 5777.3 5782.8 5795.7 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | [#1] ext.html Cycles:180 Average:54289.77 Median:33629.83 stddev:97541.32 (290.0%) stddev-sans-first:97731.83 11:16:58 INFO - PROCESS | 15889 | Values: 657.5 678.4 688.4 726.0 743.0 31852.4 32483.2 38077.6 38673.4 38908.4 42729.1 43033.8 43128.4 43201.1 43230.4 8044.6 8749.3 8908.0 8926.1 10266.4 10235.2 10358.6 10359.1 10370.0 10384.2 10531.9 10639.0 10656.7 10659.4 10660.3 10687.7 10757.8 10766.9 10774.0 10774.4 10587.2 10651.8 10688.1 10689.5 10702.6 41675.2 42129.4 42131.6 42191.3 42237.8 3884.9 4070.3 4488.9 4598.9 4604.7 31979.5 33231.7 33403.8 33437.7 34843.0 4396.8 4429.1 4448.5 4484.0 4502.5 330547.0 330679.0 332370.0 332553.0 334298.0 62598.4 63101.2 63145.7 63178.0 63182.7 67197.0 68226.3 68228.3 68279.0 68289.0 17904.2 19804.4 20046.2 20145.6 20167.2 13594.8 13711.7 15043.2 15404.7 15450.3 19707.7 19857.8 20147.5 20562.4 20640.3 7406.0 7415.4 7462.1 7465.3 7701.6 1120.1 1153.7 1173.2 1208.4 1281.3 32269.4 32717.5 33158.2 33421.3 33822.0 1274.9 1301.5 1310.5 1329.9 1352.5 17497.5 17661.6 17828.2 17910.3 18009.8 458994.0 460550.0 465298.0 465327.0 466437.0 61856.4 62594.4 62657.0 62718.0 62781.7 1459.7 1495.1 1526.9 1542.1 1611.9 30011.4 30460.2 32498.2 32678.3 32829.8 48241.5 48767.5 49500.8 49503.0 49514.8 293027.0 294960.0 295137.0 295610.0 296668.0 27237.7 30509.5 30574.8 30855.4 30916.2 44178.3 44223.8 44676.1 45245.0 45311.8 37519.0 37809.2 38173.4 39674.8 40370.8 38823.8 39400.2 40126.2 40527.6 40731.0 37588.6 37686.0 37732.6 38018.4 41969.6 35152.3 36050.0 36578.6 37022.3 37305.3 27854.4 28383.6 28684.9 29479.6 30388.5 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | [#2] jquery.html Cycles:180 Average:30830.55 Median:1997.74 stddev:82194.04 (4114.3%) stddev-sans-first:82392.87 11:16:58 INFO - PROCESS | 15889 | Values: 407.8 412.3 418.2 423.3 428.1 18106.7 18507.5 19085.8 19168.2 19172.2 18261.4 18555.7 18862.4 19268.3 19269.7 5578.1 5632.1 5820.8 5830.3 5844.9 5735.8 5785.9 5822.1 5823.7 5828.4 5623.9 5672.3 5778.6 5798.2 5801.5 5681.9 5702.9 5721.9 5725.9 5746.3 5148.6 5156.8 5158.2 5165.9 5255.7 13946.5 14137.2 14145.6 14169.9 15478.8 2316.7 2342.3 2507.8 2541.3 2713.4 10277.1 10356.1 12199.5 14002.4 14066.3 1975.0 1978.7 1997.1 1998.3 2246.7 89409.6 91664.5 93623.5 96919.5 97324.5 18174.5 18197.7 18261.2 18490.5 18818.0 33618.3 33952.8 34359.5 34396.5 34624.0 10646.0 10695.2 10993.9 11216.7 11257.3 9535.0 9570.3 9672.9 9685.7 9773.1 9310.1 9336.8 9444.0 9509.2 9654.4 3223.9 3427.9 3663.6 3703.2 3864.4 1001.0 1074.9 1103.1 1130.1 1164.6 18860.7 19160.5 19319.7 19459.4 19548.5 1060.4 1086.7 1126.4 1131.1 1161.6 10579.0 11025.6 11148.9 11198.1 11225.2 492052.0 494021.0 496888.0 497619.0 502320.0 95559.5 100857.0 101738.5 103677.5 104240.0 1135.3 1146.4 1157.4 1178.7 1180.3 18134.3 18356.9 18382.5 18392.6 18475.5 30584.4 34846.8 42220.6 43420.3 43781.6 58689.4 64009.4 64366.0 64749.4 65436.3 8895.3 8934.6 8976.4 9009.8 9056.8 9770.6 13636.4 13722.5 14056.7 14227.9 12037.5 12099.8 12206.3 12299.9 12413.4 11787.2 11833.8 11855.8 12172.5 12436.4 12220.5 12312.4 12454.1 12660.6 12836.7 8620.2 8939.6 8940.5 9146.3 9151.2 12416.3 12560.0 12624.4 12694.5 12707.1 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | [#3] mootools.html Cycles:180 Average:5621.45 Median:4927.07 stddev:3163.40 (64.2%) stddev-sans-first:3156.38 11:16:58 INFO - PROCESS | 15889 | Values: 1401.8 1518.1 1524.4 1752.4 1895.5 8340.7 8532.2 8548.7 8551.8 8555.6 8339.6 8515.2 8521.5 8538.6 8546.7 2305.0 2310.5 2327.5 2330.0 2342.0 2306.6 2375.9 2387.3 2388.2 2391.7 2288.9 2298.9 2308.6 2330.5 2332.2 2294.6 2323.1 2337.9 2338.5 2345.1 2339.4 2354.2 2357.8 2358.4 2374.5 8228.7 8420.9 8590.4 8628.9 8631.1 5100.4 5230.4 5231.3 5235.8 5236.1 3363.5 3383.5 3429.9 3470.1 3478.5 1111.6 1139.1 1161.5 1167.3 1194.4 11970.3 12047.6 12074.0 12076.9 12085.3 4114.0 4217.1 4287.2 4385.8 4385.9 9595.4 9613.5 9670.8 9688.2 9701.9 4992.5 5010.4 5017.6 5029.3 5033.6 4217.0 4656.2 4685.2 4729.8 4791.4 3832.3 3938.4 3969.0 3969.1 4082.8 1191.7 1219.3 1220.9 1230.3 1232.1 943.8 1051.4 1065.7 1073.5 1076.9 5878.8 5924.0 5984.1 6082.8 6145.8 425.9 431.8 434.4 442.3 458.7 4109.1 4150.2 4158.9 4163.2 4170.6 10486.5 10596.6 10624.0 10733.8 10764.8 10547.1 10610.1 10613.7 10617.5 10632.6 8219.3 8301.2 8303.8 8307.4 8321.5 5646.2 5717.2 5757.9 5768.8 5904.0 9435.7 9445.5 9515.1 9578.8 9669.3 9262.3 9333.6 9653.2 9679.8 9721.8 6805.9 7392.2 7618.3 7633.9 7722.0 7868.8 7870.1 7894.0 7922.8 7930.5 7405.0 7514.3 7545.1 7600.8 7683.0 7196.2 7378.7 7395.9 7464.0 7483.6 6725.7 6736.0 6748.2 6785.6 6789.4 4915.2 5003.7 5038.0 5076.2 5108.7 4819.6 4939.0 4961.4 4973.5 5047.2 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | [#4] prototype.html Cycles:180 Average:5482.80 Median:6377.85 stddev:1690.22 (26.5%) stddev-sans-first:1650.12 11:16:58 INFO - PROCESS | 15889 | Values: 330.4 341.8 341.8 345.2 348.0 6059.7 6073.3 6157.0 6163.1 6193.3 6064.3 6077.6 6078.5 6088.5 6096.9 4411.8 4577.2 4705.9 4714.3 4722.6 4687.6 4706.1 4715.0 4718.4 4723.2 4438.1 4683.3 4688.8 4693.9 4697.8 4533.8 4546.4 4576.5 4672.2 4675.6 4102.1 4111.3 4112.9 4114.9 4121.2 5889.5 5906.1 5908.3 5916.1 5916.2 5438.6 5446.3 5446.9 5451.9 5453.6 6465.7 6467.5 6478.9 6483.3 6491.6 4326.9 4466.3 4467.3 4468.2 4488.7 6715.5 6823.8 6826.6 6826.7 6834.3 4551.2 4551.6 4555.0 4555.4 4561.9 4605.1 4609.5 4617.8 4618.2 4620.4 5361.4 5367.9 5369.0 5369.5 5379.0 6448.0 6500.5 6553.8 6567.6 6573.5 1595.5 1607.5 1617.9 1618.0 1620.8 972.9 1040.3 1052.3 1062.9 1074.7 6279.3 6441.6 6454.9 6459.5 6463.6 6817.5 6819.9 6820.2 6831.5 6874.9 6393.3 6431.8 6432.4 6440.1 6450.5 3621.8 3655.7 3664.7 3664.9 3671.7 6920.1 7130.4 7185.8 7197.2 7199.4 6909.2 6909.8 6918.4 6920.0 6926.1 7101.2 7132.0 7133.9 7140.6 7165.8 6809.8 6817.1 6819.1 6819.9 6822.3 6508.8 6698.6 6711.2 6732.0 6733.5 7146.8 7156.7 7163.7 7167.7 7173.8 4531.6 4573.2 4574.6 4580.5 4586.2 6813.9 6814.4 6816.3 6818.8 6823.6 6391.4 6593.2 6603.5 6605.8 6609.2 6568.2 6586.4 6596.3 6610.2 6617.9 6475.3 6477.6 6482.1 6485.3 6492.4 6631.2 6689.4 6692.7 6701.2 6701.5 6364.3 6472.1 6474.3 6480.7 6492.9 11:16:58 INFO - PROCESS | 15889 | 11:16:58 INFO - PROCESS | 15889 | [#5] yui.html Cycles:180 Average:15644.19 Median:25419.27 stddev:18376.25 (72.3%) stddev-sans-first:18394.31 11:16:58 INFO - PROCESS | 15889 | Values: 868.8 915.1 918.4 923.2 935.9 14997.3 15192.5 15229.1 15237.7 15279.5 14547.1 14639.3 14640.6 14658.8 14661.3 746.4 862.0 883.7 888.1 888.4 892.6 901.9 902.4 904.5 904.7 935.6 937.0 939.3 939.4 939.7 776.2 923.5 933.3 940.1 940.9 684.8 685.3 685.4 689.5 689.7 13930.4 13950.4 14004.7 14018.6 14022.5 14503.0 15136.6 15218.6 15293.0 15298.3 12287.6 12521.8 12644.9 12741.6 12757.4 4129.1 4129.4 4159.9 4162.0 4210.4 53321.0 53493.7 53575.5 53594.0 53954.5 10560.9 11195.7 11281.5 11489.5 11567.5 20045.5 20083.9 20104.2 20127.8 20136.1 8353.1 8617.7 8728.3 8773.0 8949.6 4657.1 4976.3 5050.3 5053.5 5069.2 3582.4 3658.9 3661.4 3665.9 3672.7 550.9 645.6 670.3 677.3 677.3 595.9 662.0 698.8 711.3 816.3 9377.2 10000.5 10089.7 10125.4 10190.7 613.6 661.7 707.4 723.6 807.1 4503.3 4608.8 4635.9 4711.4 4729.5 67225.0 68020.0 68295.7 68945.7 68947.3 58329.7 58844.0 60103.7 60464.1 60608.7 53234.2 53755.0 53874.7 54152.5 54732.5 9074.4 9201.3 9263.1 9301.8 9317.7 38688.6 39218.8 40561.6 40960.6 41629.8 46229.8 46337.0 49068.5 50660.0 50974.5 11597.4 11649.7 11729.6 12021.5 12603.1 13009.9 13051.2 13140.7 13669.0 13748.2 12368.8 12398.6 12658.4 12708.7 12713.4 12205.1 12241.2 12244.1 12413.8 12557.9 11990.8 12125.4 12395.6 12601.8 12831.6 10378.8 10463.4 10466.7 10567.4 11183.6 10325.7 10340.9 10358.5 10393.4 10407.8 11:16:58 INFO - PROCESS | 15889 | -------- Summary: end -------- 11:16:58 INFO - PROCESS | 15889 | 11:16:59 INFO - TEST-INFO | 15889: exit 0 11:16:59 INFO - TEST-OK | dromaeo_css | took 1110936ms 11:16:59 INFO - TEST-START | kraken 11:16:59 INFO - operating with platform_type : linux_ 11:16:59 INFO - Initialising browser for kraken test... 11:16:59 INFO - TEST-INFO | started process 16082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRqLSu/profile http://localhost:34926/getInfo.html) 11:17:03 INFO - PROCESS | 16082 | __metrics Screen width/height:1600/1200 11:17:03 INFO - PROCESS | 16082 | colorDepth:24 11:17:03 INFO - PROCESS | 16082 | Browser inner width/height: 1024/697 11:17:03 INFO - PROCESS | 16082 | __metrics 11:17:04 ERROR - PROCESS | 16082 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:17:04 INFO - TEST-INFO | 16082: exit 0 11:17:04 INFO - Browser initialized. 11:17:04 INFO - Running cycle 1/1 for kraken test... 11:17:04 INFO - TEST-INFO | started process 16177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRqLSu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:16 INFO - PROCESS | 16177 | RSS: Main: 139264000 11:17:16 INFO - PROCESS | 16177 | 11:17:19 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34926/tests/kraken/driver.html?testName=audio-beat-detection) 11:17:19 INFO - PROCESS | 16177 | RSS: Main: 197775360 11:17:19 INFO - PROCESS | 16177 | 11:17:22 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34926/tests/kraken/driver.html?testName=audio-dft) 11:17:23 INFO - PROCESS | 16177 | RSS: Main: 184053760 11:17:23 INFO - PROCESS | 16177 | 11:17:26 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34926/tests/kraken/driver.html?testName=audio-fft) 11:17:26 INFO - PROCESS | 16177 | RSS: Main: 274681856 11:17:26 INFO - PROCESS | 16177 | 11:17:28 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34926/tests/kraken/driver.html?testName=audio-oscillator) 11:17:29 INFO - PROCESS | 16177 | RSS: Main: 180260864 11:17:29 INFO - PROCESS | 16177 | 11:17:31 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:17:32 INFO - PROCESS | 16177 | RSS: Main: 178651136 11:17:32 INFO - PROCESS | 16177 | 11:17:35 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34926/tests/kraken/driver.html?testName=imaging-darkroom) 11:17:35 INFO - PROCESS | 16177 | RSS: Main: 213266432 11:17:35 INFO - PROCESS | 16177 | 11:17:38 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34926/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:39 INFO - PROCESS | 16177 | RSS: Main: 213364736 11:17:39 INFO - PROCESS | 16177 | 11:17:42 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34926/tests/kraken/driver.html?testName=json-parse-financial) 11:17:42 INFO - PROCESS | 16177 | RSS: Main: 213684224 11:17:42 INFO - PROCESS | 16177 | 11:17:44 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:44 INFO - PROCESS | 16177 | RSS: Main: 194248704 11:17:44 INFO - PROCESS | 16177 | 11:17:46 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:47 INFO - PROCESS | 16177 | RSS: Main: 199553024 11:17:47 INFO - PROCESS | 16177 | 11:17:49 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:49 INFO - PROCESS | 16177 | RSS: Main: 208932864 11:17:49 INFO - PROCESS | 16177 | 11:17:52 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:52 INFO - PROCESS | 16177 | RSS: Main: 216567808 11:17:52 INFO - PROCESS | 16177 | 11:17:55 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:56 INFO - PROCESS | 16177 | RSS: Main: 213803008 11:17:56 INFO - PROCESS | 16177 | 11:17:57 INFO - PROCESS | 16177 | Cycle 1(1): loaded http://localhost:34926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34926/tests/kraken/driver.html?testName=ai-astar) 11:17:58 INFO - PROCESS | 16177 | RSS: Main: 273231872 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | __start_tp_report 11:17:58 INFO - PROCESS | 16177 | _x_x_mozilla_page_load 11:17:58 INFO - PROCESS | 16177 | _x_x_mozilla_page_load_details 11:17:58 INFO - PROCESS | 16177 | |i|pagename|runs| 11:17:58 INFO - PROCESS | 16177 | |0;ai-astar;111;112;110;111;112;111;106;112;111;111 11:17:58 INFO - PROCESS | 16177 | |1;audio-beat-detection;158;127;152;183;127;155;153;139;189;128 11:17:58 INFO - PROCESS | 16177 | |2;audio-dft;162;160;163;162;161;161;162;163;160;161 11:17:58 INFO - PROCESS | 16177 | |3;audio-fft;75;76;75;170;75;73;83;76;166;74 11:17:58 INFO - PROCESS | 16177 | |4;audio-oscillator;92;93;150;92;93;91;143;92;92;159 11:17:58 INFO - PROCESS | 16177 | |5;imaging-gaussian-blur;117;121;117;117;116;116;117;116;117;116 11:17:58 INFO - PROCESS | 16177 | |6;imaging-darkroom;146;145;145;144;145;145;145;145;146;145 11:17:58 INFO - PROCESS | 16177 | |7;imaging-desaturate;94;94;95;95;94;95;95;94;94;95 11:17:58 INFO - PROCESS | 16177 | |8;json-parse-financial;58;68;56;55;54;56;57;75;55;53 11:17:58 INFO - PROCESS | 16177 | |9;json-stringify-tinderbox;57;59;58;58;59;58;58;58;59;58 11:17:58 INFO - PROCESS | 16177 | |10;stanford-crypto-aes;77;73;72;72;73;74;73;73;72;73 11:17:58 INFO - PROCESS | 16177 | |11;stanford-crypto-ccm;115;124;113;127;113;112;113;114;136;126 11:17:58 INFO - PROCESS | 16177 | |12;stanford-crypto-pbkdf2;164;165;156;161;159;163;158;163;161;162 11:17:58 INFO - PROCESS | 16177 | |13;stanford-crypto-sha256-iterative;67;68;68;65;68;67;67;66;66;66 11:17:58 INFO - PROCESS | 16177 | __end_tp_report 11:17:58 INFO - PROCESS | 16177 | __start_cc_report 11:17:58 INFO - PROCESS | 16177 | _x_x_mozilla_cycle_collect,1544 11:17:58 INFO - PROCESS | 16177 | __end_cc_report 11:17:58 INFO - PROCESS | 16177 | __startTimestamp1467742678086__endTimestamp 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | ------- Summary: start ------- 11:17:58 INFO - PROCESS | 16177 | Number of tests: 14 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.77 (1.6%) stddev-sans-first:1.87 11:17:58 INFO - PROCESS | 16177 | Values: 111.0 112.0 110.0 111.0 112.0 111.0 106.0 112.0 111.0 111.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:154.00 stddev:22.02 (14.3%) stddev-sans-first:23.21 11:17:58 INFO - PROCESS | 16177 | Values: 158.0 127.0 152.0 183.0 127.0 155.0 153.0 139.0 189.0 128.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 11:17:58 INFO - PROCESS | 16177 | Values: 162.0 160.0 163.0 162.0 161.0 161.0 162.0 163.0 160.0 161.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.00 stddev:38.95 (51.9%) stddev-sans-first:40.68 11:17:58 INFO - PROCESS | 16177 | Values: 75.0 76.0 75.0 170.0 75.0 73.0 83.0 76.0 166.0 74.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:28.53 (31.0%) stddev-sans-first:29.53 11:17:58 INFO - PROCESS | 16177 | Values: 92.0 93.0 150.0 92.0 93.0 91.0 143.0 92.0 92.0 159.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:1.49 (1.3%) stddev-sans-first:1.58 11:17:58 INFO - PROCESS | 16177 | Values: 117.0 121.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 11:17:58 INFO - PROCESS | 16177 | Values: 146.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 146.0 145.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:17:58 INFO - PROCESS | 16177 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:56.50 stddev:7.09 (12.5%) stddev-sans-first:7.51 11:17:58 INFO - PROCESS | 16177 | Values: 58.0 68.0 56.0 55.0 54.0 56.0 57.0 75.0 55.0 53.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 11:17:58 INFO - PROCESS | 16177 | Values: 57.0 59.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.48 (2.0%) stddev-sans-first:0.67 11:17:58 INFO - PROCESS | 16177 | Values: 77.0 73.0 72.0 72.0 73.0 74.0 73.0 73.0 72.0 73.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:119.50 stddev:8.33 (7.0%) stddev-sans-first:8.69 11:17:58 INFO - PROCESS | 16177 | Values: 115.0 124.0 113.0 127.0 113.0 112.0 113.0 114.0 136.0 126.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.50 stddev:2.82 (1.7%) stddev-sans-first:2.80 11:17:58 INFO - PROCESS | 16177 | Values: 164.0 165.0 156.0 161.0 159.0 163.0 158.0 163.0 161.0 162.0 11:17:58 INFO - PROCESS | 16177 | 11:17:58 INFO - PROCESS | 16177 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 11:17:58 INFO - PROCESS | 16177 | Values: 67.0 68.0 68.0 65.0 68.0 67.0 67.0 66.0 66.0 66.0 11:17:58 INFO - PROCESS | 16177 | -------- Summary: end -------- 11:17:58 INFO - PROCESS | 16177 | 11:17:59 INFO - TEST-INFO | 16177: exit 0 11:17:59 INFO - TEST-OK | kraken | took 59915ms 11:17:59 INFO - SUITE-END | took 1170s 11:17:59 INFO - Completed test suite (00:19:30) 11:17:59 INFO - javascript benchmark 11:17:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.5548300979367, 3386.3227354529095, 3390.9321813563715, 3407.3526030054304, 3424.5376874121985, 5536.224928510007, 5541.9168712469345, 5551.500364967153, 5564.137558678402, 5588.524975377088, 5552.805651802188, 5617.859553511164, 5621.437856214377, 5627.915581266274, 5670.036093864042, 4932.8520144395725, 5015.423226328982, 5148.047611191922, 5197.454267301936, 5230.529252367286, 4998.750062496879, 5033.043721692885, 5070.74646267687, 5072.619553533481, 5076.923846142311, 4993.275974983625, 5020.924686129711, 5083.618728595352, 5105.361829771278, 5106.463821298766, 5060.873478163038, 5074.720890351029, 5091.363579552556, 5093.439721630618, 5119.539241468267, 4934.728589927553, 4938.185199442088, 4944.98627781304, 4972.453030166679, 5057.5701065409485, 5354.973225133888, 5361.356637203521, 5388.245645609618, 5391.757370918318, 5402.567794576425, 5863.5309175265875, 5908.409159084057, 5908.8227353179045, 5910.497607703307, 5911.497522710575, 5867.911981320283, 5937.465628093449, 5943.494802941756, 5961.880762384728, 5992.9700351498395, 5496.395396506381, 5512.6968016759065, 5538.418466061086, 5550.389457159709, 5564.1931919871395, 5994.610350327215, 6008.429199226067, 6009.609375390673, 6014.879702405928, 6037.54718396122, 5759.22250496186, 5787.131930210502, 5787.334456537468, 5805.10020946754, 5814.592978491465, 5843.590948633555, 5845.795397161079, 5850.882982340415, 5852.4440178183, 5860.589758716934, 5728.398518155617, 5803.071508558611, 5808.39011903744, 5827.825165245049, 5923.703814809242, 5926.555508336892, 5929.644221346647, 5935.347111817697, 5936.406359364116, 5972.432618901197, 4526.547345265447, 4529.38853254813, 4535.0, 4539.659525535598, 4557.270836666117, 3917.040325120364, 4024.335984562573, 4054.3715724062818, 4080.816363263601, 4093.9795301023305, 5712.0860662293835, 5723.856903577361, 5730.111832665943, 5732.369439361751, 5735.340435849931, 6010.038393856962, 6024.487918526975, 6025.638461692225, 6026.0659597762415, 6039.577229593974, 5570.303712035996, 5591.944080559224, 5597.972010139923, 5635.802746903839, 5699.572532060112, 4995.850124496271, 5023.648344615842, 5024.49755024502, 5028.120078986163, 5030.195168772979, 6161.229846269216, 6177.135201071854, 6177.62934223948, 6182.1345011698395, 6182.227221597301, 5808.448197421239, 5870.7945221917025, 5954.672493012839, 5958.285005799332, 5985.910211346921, 6151.205492575522, 6163.907541386972, 6197.659128747962, 6206.410391012847, 6208.2239720034995, 5848.795292164754, 5850.23946886919, 5852.882942341214, 5855.385184555731, 5868.823935281948, 5818.7090645466715, 5924.229850119457, 5994.400559943971, 6077.027675571887, 6092.786752463642, 5798.76804927815, 5848.94151058501, 5860.882782344414, 5861.824145275648, 5865.5600829937075, 5776.364599894092, 5847.736851841592, 5852.707364631666, 5862.560307976833, 5863.1791549184, 5562.415946325577, 5593.860153496195, 5619.943800561942, 5632.0, 5635.88728225425, 5830.0, 5863.73613187399, 5883.117532370179, 5885.646861188342, 5886.882262354643, 5619.438056194512, 5776.855578610568, 5777.306723193244, 5782.826515204551, 5795.681237531976], "value": 5475.469711193472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.4707360574738, 678.3928384096231, 688.366702633577, 725.956442613443, 743.0266351080083, 31852.36295274096, 32483.187920301974, 38077.619223807786, 38673.419898701475, 38908.41637375434, 42729.14541709164, 43033.7848310758, 43128.353074703904, 43201.135977280435, 43230.35154472685, 8044.637991290406, 8749.300055995505, 8907.955460222722, 8926.062763409846, 10266.384016959006, 10235.181185505142, 10358.637447689294, 10359.067683908446, 10370.0, 10384.169266458664, 10531.894681053207, 10639.0, 10656.680299591024, 10659.413732244724, 10660.30708003981, 10687.679369618923, 10757.83863242052, 10766.892331076668, 10774.0, 10774.353538787658, 10587.205959552988, 10651.84022239667, 10688.14494840411, 10689.46552672371, 10702.571897124106, 41675.1664966702, 42129.36805947913, 42131.57868421307, 42191.312347506064, 42237.78881105605, 3884.883453496371, 4070.328395814687, 4488.887777805581, 4598.931016034762, 4604.6776725629215, 31979.52030719541, 33231.66768332334, 33403.83298083494, 33437.665623343695, 34843.0, 4396.758178300192, 4429.069895321986, 4448.488423831236, 4484.0, 4502.459704835408, 330547.0, 330679.0, 332370.0, 332553.0, 334298.0, 62598.37401626017, 63101.16044777996, 63145.68427157835, 63178.0, 63182.68408658019, 67197.0, 68226.317736823, 68228.31771682319, 68279.0, 68289.0, 17904.194311256026, 19804.40586782399, 20046.198152074045, 20145.597088058155, 20167.19331226764, 13594.796078058836, 13711.725765484634, 15043.247837608295, 15404.691906161814, 15450.30473628667, 19707.704384434244, 19857.801421985885, 20147.496312592302, 20562.355011599037, 20640.27759028427, 7406.0, 7415.40676745859, 7462.141853686787, 7465.29079737424, 7701.576413297323, 1120.0871289898707, 1153.6827372472637, 1173.178774857603, 1208.4018410886492, 1281.2824818101892, 32269.35461290761, 32717.509237361457, 33158.17104572405, 33421.3315733684, 33822.0, 1274.9171303865405, 1301.4859130643342, 1310.462710288777, 1329.9135556188817, 1352.5401363536446, 17497.47507574775, 17661.646767064845, 17828.197731102133, 17910.283588656308, 18009.819901800813, 458994.0, 460550.0, 465298.0, 465327.0, 466437.0, 61856.38143618596, 62594.37405625977, 62657.0, 62718.0, 62781.68609157016, 1459.6934643724937, 1495.0954672423245, 1526.885483588713, 1542.1286972860523, 1611.8710503159718, 30011.399772004876, 30460.246864224144, 32498.187545311557, 32678.275124447315, 32829.83585082059, 48241.517584823705, 48767.512324877716, 49500.75249623729, 49503.0, 49514.75242623764, 293027.0, 294960.0, 295137.0, 295610.0, 296668.0, 27237.72762272352, 30509.54235686511, 30574.84712576423, 30855.382892342477, 30916.227094321923, 44178.33732493951, 44223.77888110539, 44676.10647787091, 45245.0, 45311.77344113258, 37519.0, 37809.243815122994, 38173.42739858849, 39674.801625991684, 40370.79814600908, 38823.805880970416, 39400.226989786104, 40126.19747604973, 40527.59472405238, 40731.0, 37588.62411375961, 37686.0, 37732.62267377401, 38018.42972355472, 41969.580304197785, 35152.29695406129, 36050.0, 36578.634213657526, 37022.259554809294, 37305.25389492141, 27854.442911141257, 28383.574246386735, 28684.85657571699, 29479.557806633347, 30388.544171837], "value": 20880.85040890138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.83890363306483, 412.3443724478081, 418.2408927796052, 423.3438170835205, 428.1009879253568, 18106.728399074025, 18507.5373115672, 19085.809141908576, 19168.233270669174, 19172.233110675574, 18261.36085237017, 18555.72166417505, 18862.43412697621, 19268.3256086037, 19269.71095433566, 5578.135389014709, 5632.098864181732, 5820.796272130455, 5830.300363956331, 5844.912326315109, 5735.799247026355, 5785.913211301834, 5822.068469044953, 5823.650580965134, 5828.388019257981, 5623.887522249553, 5672.347680016789, 5778.566607504454, 5798.188253644493, 5801.47786699197, 5681.886362272752, 5702.885942281131, 5721.885562288772, 5725.856853578653, 5746.339170995348, 5148.588112950993, 5156.845294641167, 5158.200478925773, 5165.896682066337, 5255.658382205144, 13946.51187208453, 14137.222452765094, 14145.646358841008, 14169.858301416956, 15478.845211547852, 2316.7219933607907, 2342.332435255944, 2507.8119141064494, 2541.2503311523146, 2713.3894873653467, 10277.075063244269, 10356.119729822974, 12199.451024703909, 14002.369893354824, 14066.2966851657, 1974.9506262343414, 1978.7229787829715, 1997.1412292714126, 1998.3405476192822, 2246.651768975795, 89409.55295223548, 91664.54167729118, 93623.53188234015, 96919.51540242325, 97324.51337743337, 18174.5456363592, 18197.7244096064, 18261.178246978918, 18490.537736556424, 18818.0, 33618.327633447196, 33952.83023584866, 34359.484607730905, 34396.48405273923, 34624.0, 10646.0, 10695.197860160519, 10993.900609938943, 11216.719582010515, 11257.324560526395, 9534.9988251234, 9570.282228832866, 9672.903270967341, 9685.70942871715, 9773.07155820196, 9310.115539023782, 9336.766580835534, 9444.0, 9509.191718703849, 9654.372465789702, 3223.903872683299, 3427.869417352085, 3663.5970043295215, 3703.2408356287438, 3864.3623802072907, 1000.979001418549, 1074.9408782517037, 1103.0734183286079, 1130.0676941523277, 1164.5923926625612, 18860.717089243673, 19160.520986975436, 19319.710204346946, 19459.4162175135, 19548.511287217934, 1060.4326685223368, 1086.7337502311984, 1126.3523474002482, 1131.055568600228, 1161.5992482593492, 10579.047885690325, 11025.61410350634, 11148.944255278671, 11198.104151667847, 11225.214235003472, 492052.0, 494021.0, 496888.0, 497619.0, 502320.0, 95559.52220238854, 100857.0, 101738.49130754446, 103677.48161259145, 104239.95760042302, 1135.2847705945367, 1146.4095990564865, 1157.3750174905624, 1178.7465694875643, 1180.2682336950973, 18134.32761422473, 18356.908215458836, 18382.540436489195, 18392.63214735671, 18475.538111547317, 30584.388312234074, 34846.825765871006, 42220.577794222896, 43420.348694768974, 43781.56218437902, 58689.4131058701, 64009.35990640034, 64366.0, 64749.35250647433, 65436.34563654493, 8895.332850036144, 8934.642614295355, 8976.41653292534, 9009.819803604023, 9056.773580660536, 9770.609175632895, 13636.386362613508, 13722.519711810039, 14056.718865622835, 14227.857721422653, 12037.518499259932, 12099.81850272229, 12206.267623942236, 12299.87700123023, 12413.44139513706, 11787.233829801036, 11833.763324733629, 11855.822162667739, 12172.45223964906, 12436.440360183995, 12220.51117955272, 12312.445939932546, 12454.065945054339, 12660.620181394574, 12836.679083022998, 8620.224179823846, 8939.553022348986, 8940.46357218569, 9146.268298535968, 9151.222146117389, 12416.255024698547, 12560.0, 12624.368781561068, 12694.492220311084, 12707.110502264753], "value": 10271.186434865056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.782723677829, 1518.14224962896, 1524.3521503361071, 1752.3779058434257, 1895.488218181092, 8340.666373345066, 8532.23209911108, 8548.743537693872, 8551.786205344853, 8555.57222138893, 8339.62471688774, 8515.23362897339, 8521.531315777629, 8538.573071346438, 8546.700865469695, 2305.0203663443012, 2310.514791893696, 2327.4995875886766, 2330.021391015777, 2342.02805835578, 2306.642470417088, 2375.904963801446, 2387.259949415678, 2388.2118900762707, 2391.7129944406697, 2288.9198878039274, 2298.8620682759006, 2308.6075367187536, 2330.5222429401933, 2332.183735692511, 2294.6443301288327, 2323.140438037928, 2337.9415514612188, 2338.462153704649, 2345.144022431817, 2339.4385347516472, 2354.2348736660656, 2357.752435994213, 2358.375030616871, 2374.4894847607675, 8228.711995080144, 8420.915790842075, 8590.441621294658, 8628.870566941501, 8631.136886311318, 5100.413452452941, 5230.424653288135, 5231.319928409321, 5235.816746413857, 5236.136037553799, 3363.5122907178566, 3383.509391138296, 3429.9142521437166, 3470.0630829676097, 3478.5477887874667, 1111.6387174168347, 1139.0545846947014, 1161.5469966712988, 1167.2937872587133, 1194.3908606610605, 11970.281783093042, 12047.578334758242, 12074.034077273885, 12076.939615301955, 12085.274883507018, 4113.9794301028305, 4217.072244106292, 4287.249731297073, 4385.824567017347, 4385.890352741207, 9595.42427454355, 9613.51932403391, 9670.806583868283, 9688.224942004763, 9701.854472182922, 4992.475790041994, 5010.423801262828, 5017.598592112695, 5029.2958985742025, 5033.6224783141415, 4217.0, 4656.231721765938, 4685.20351540239, 4729.834455794031, 4791.401074865642, 3832.2527107214382, 3938.448617193595, 3969.027588240842, 3969.106950936074, 4082.8366865325056, 1191.6782468733568, 1219.3354621731178, 1220.9450574724158, 1230.2864338683542, 1232.125191114301, 943.8253923024263, 1051.4269723000982, 1065.6909496246158, 1073.4793625091825, 1076.9461526923778, 5878.794242201588, 5924.0, 5984.102384642339, 6082.847928801815, 6145.84635384119, 425.857337791837, 431.78195011518983, 434.4374035623875, 442.263631054291, 458.7293496836882, 4109.0959988802415, 4150.169966006811, 4158.854440094643, 4163.2298024865495, 4170.562090980464, 10486.528106235237, 10596.576136954589, 10624.0, 10733.83899241512, 10764.838527422095, 10547.050765430995, 10610.09814165789, 10613.73465663349, 10617.469126543641, 10632.627858025087, 8219.301359384399, 8301.211384918422, 8303.792405189919, 8307.376946728898, 8321.500709957421, 5646.237757902631, 5717.17101020358, 5757.91363129545, 5768.798092066758, 5904.0, 9435.669751558662, 9445.52772361393, 9515.096065873731, 9578.760530986503, 9669.27480438984, 9262.259019278576, 9333.626654933998, 9653.2277417805, 9679.806403871742, 9721.756956076155, 6805.89791153143, 7392.22381649919, 7618.314351708373, 7633.885491717518, 7722.034745656793, 7868.803279918048, 7870.055593328837, 7894.0, 7922.762317130495, 7930.524168549906, 7404.96297518509, 7514.323710866049, 7545.132309784225, 7600.771976840703, 7682.961585192038, 7196.172440169447, 7378.667959941923, 7395.852082958203, 7464.0, 7483.588402637907, 6725.697343619451, 6735.966320168368, 6748.156480439945, 6785.558938668971, 6789.388954994074, 4915.164422048332, 5003.724795136302, 5038.0, 5076.213186956028, 5108.693478391308, 4819.566239038503, 4938.975305123451, 4961.3798275215595, 4973.452920178705, 5047.2429135629945], "value": 4463.5124391686995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.444852647552, 341.7761366305069, 341.7966310045523, 345.1733099227352, 347.98260086995657, 6059.727312270948, 6073.301570319414, 6157.0, 6163.137160797486, 6193.349698281683, 6064.272287325527, 6077.635341879491, 6078.513718902488, 6088.543359248063, 6096.878062438748, 4411.84558540452, 4577.198990176722, 4705.882352941187, 4714.2928560716, 4722.64580156488, 4687.578117969382, 4706.058788242348, 4714.952850471503, 4718.41019872516, 4723.197056500403, 4438.068005718803, 4683.344331793552, 4688.812447502096, 4693.9061218775605, 4697.765111744417, 4533.773311334437, 4546.431696037996, 4576.542345765413, 4672.229082201433, 4675.625949923998, 4102.118044620421, 4111.321631930728, 4112.91774164518, 4114.876553703364, 4121.196366708463, 5889.528837692974, 5906.143609176645, 5908.261467316585, 5916.1421593868645, 5916.201312822757, 5438.592105592096, 5446.264754258164, 5446.863828404282, 5451.863703407407, 5453.618246722731, 6465.709043093072, 6467.482601391877, 6478.902816457757, 6483.319251478574, 6491.610503369813, 4326.870193894157, 4466.307722303049, 4467.262901621229, 4468.218061839165, 4488.730676159441, 6715.496337774637, 6823.829404264883, 6826.5904045756915, 6826.658667066627, 6834.316568343126, 4551.158035763395, 4551.590356867898, 4555.043440877386, 4555.385023021916, 4561.908761824745, 4605.078984203105, 4609.53904609543, 4617.792199351037, 4618.1918164321105, 4620.399348084795, 5361.383440904346, 5367.892642147135, 5368.9731551342775, 5369.4898984597185, 5379.004884096455, 6447.954798663067, 6500.5449618526245, 6553.803385898431, 6567.573107747981, 6573.5069869759, 1595.4814685227116, 1607.5418505726045, 1617.9110148941686, 1617.9757303640454, 1620.813606435275, 972.8783902012249, 1040.3341861208833, 1052.2686732720686, 1062.914966802654, 1074.7420619051527, 6279.277883043508, 6441.613503189824, 6454.935450645527, 6459.483241340776, 6463.644499552475, 6817.5227734059135, 6819.897701534481, 6820.181578210647, 6831.487638427137, 6874.862502749917, 6393.264774550986, 6431.807045788634, 6432.421082102634, 6440.098386225932, 6450.516211284079, 3621.8008009559726, 3655.7440979131206, 3664.6518580734787, 3664.9083772905356, 3671.687906527975, 6920.065791118235, 7130.3939165170505, 7185.784426467214, 7197.208307086216, 7199.352058314672, 6909.239983601799, 6909.827254318682, 6918.377346038881, 6919.965400173068, 6926.099607051051, 7101.183363913113, 7132.0, 7133.89299160513, 7140.571565706075, 7165.7850264492145, 6809.761658341934, 6817.147856517935, 6819.113515242987, 6819.931800682129, 6822.317768223138, 6508.772192973223, 6698.5980841149685, 6711.161104861892, 6732.0, 6733.528652994243, 7146.785596432115, 7156.713731450684, 7163.7492687755675, 7167.677454514664, 7173.784786456415, 4531.637469002538, 4573.199690054294, 4574.634029277583, 4580.473245576802, 4586.151561961048, 6813.8977915330315, 6814.386705196556, 6816.2842901496615, 6818.795436136924, 6823.624700641314, 6391.392817682313, 6593.241777195684, 6603.471722262304, 6605.801825945229, 6609.173853268341, 6568.1789776277965, 6586.4401525870835, 6596.30738772422, 6610.239822420291, 6617.933820661732, 6475.3200913903365, 6477.643729594917, 6482.124913136666, 6485.254195767358, 6492.415682588589, 6631.171103612049, 6689.431398331002, 6692.732290708317, 6701.229358623821, 6701.463882889455, 6364.299927008118, 6472.093906852951, 6474.2878283387845, 6480.740770369321, 6492.902606460812], "value": 4925.558387207589, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.8436081505326, 915.0666320353239, 918.3663272342084, 923.219879202074, 935.9251259899205, 14997.325120369582, 15192.468263610775, 15229.086254824704, 15237.69524609507, 15279.465218717347, 14547.127172369665, 14639.268036598181, 14640.560783176496, 14658.780118298235, 14661.340239689212, 746.4103358346927, 861.9525926074064, 883.730462209026, 888.0852721696647, 888.373696543935, 892.5849479991803, 901.8827552418177, 902.4089221559856, 904.4618452021069, 904.651709092001, 935.6257497001186, 937.0254934867729, 939.3377668743519, 939.3706216834703, 939.7415710679584, 776.1733753552477, 923.5474617437475, 933.3373304953525, 940.1350757303229, 940.9388389754644, 684.7671791590833, 685.2530741491798, 685.3626127701236, 689.5449003657612, 689.6792991259089, 13930.37313320903, 13950.441982320695, 14004.71990560183, 14018.579442616738, 14022.509212177525, 14503.0, 15136.621584460476, 15218.619534511616, 15293.0, 15298.311575978996, 12287.631371058882, 12521.812172817416, 12644.873551264462, 12741.617751467378, 12757.42591583381, 4129.112240868198, 4129.421880936671, 4159.8960025999595, 4161.958380416218, 4210.410542524049, 53321.0, 53493.73253133748, 53575.464245357434, 53594.0, 53954.46045539534, 10560.911916275276, 11195.664130075947, 11281.548738050386, 11489.540418383338, 11567.479463423997, 20045.498862528555, 20083.899580502002, 20104.195832166843, 20127.798722012885, 20136.093875775627, 8353.122922093215, 8617.69838055665, 8728.345374096842, 8773.0, 8949.59726812295, 4657.068586282757, 4976.328195693607, 5050.3182070420025, 5053.519915608012, 5069.188929771219, 3582.426811710166, 3658.9451158232114, 3661.4324779659196, 3665.9450108248398, 3672.6878215351994, 550.9421510741395, 645.5803727577113, 670.299536983853, 677.2516369411827, 677.2584020497547, 595.8838026584774, 661.9801405957829, 698.8078278473358, 711.2531841566334, 816.2775943290231, 9377.15605595486, 10000.549975251131, 10089.697309080739, 10125.443100629389, 10190.720182180456, 613.6195558753512, 661.6625520984333, 707.3563057617544, 723.5550136665912, 807.1444269074799, 4503.347014682852, 4608.769561521911, 4635.930461043087, 4711.411073615798, 4729.456112547101, 67225.0, 68020.0, 68295.65852170707, 68945.65527172331, 68947.31052689509, 58329.66681332699, 58844.0, 60103.69948150231, 60464.09303860446, 60608.696956515814, 53234.20148697773, 53754.999999999214, 53874.7306263474, 54152.45847541553, 54732.452675473534, 9074.364794464589, 9201.263898888206, 9263.120003599648, 9301.767455813388, 9317.72046838596, 38688.6131138685, 39218.80390598029, 40561.59438405578, 40960.59039409687, 41629.79185104055, 46229.76885115553, 46337.0, 49068.50931490639, 50660.0, 50974.490255098455, 11597.362145082101, 11649.650510484698, 11729.648110556696, 12021.519139234333, 12603.117781755189, 13009.869901300866, 13051.151675141085, 13140.737185256432, 13669.0, 13748.243846588533, 12368.75262494727, 12398.62804115878, 12658.43037063316, 12708.745825083262, 12713.364331783188, 12205.145639805129, 12241.20432171906, 12244.142909996215, 12413.813792793297, 12557.93721031389, 11990.760184796081, 12125.393730313626, 12395.62813115608, 12601.810972835598, 12831.615051548468, 10378.792424151627, 10463.372197668165, 10466.738331541468, 10567.365958042543, 11183.552657893919, 10325.690229293134, 10340.948295258777, 10358.533865975898, 10393.428361440194, 10407.84388234162], "value": 7066.534306349949, "unit": "score"}], "name": "dromaeo_css", "value": 7531.162714755619, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 110.0, 111.0, 112.0, 111.0, 106.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 152.0, 183.0, 127.0, 155.0, 153.0, 139.0, 189.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 162.0, 161.0, 161.0, 162.0, 163.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 170.0, 75.0, 73.0, 83.0, 76.0, 166.0, 74.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 150.0, 92.0, 93.0, 91.0, 143.0, 92.0, 92.0, 159.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 68.0, 56.0, 55.0, 54.0, 56.0, 57.0, 75.0, 55.0, 53.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 72.0, 72.0, 73.0, 74.0, 73.0, 73.0, 72.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 113.0, 127.0, 113.0, 112.0, 113.0, 114.0, 136.0, 126.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 156.0, 161.0, 159.0, 163.0, 158.0, 163.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1521.3000000000002, "alertThreshold": 2.0}]} 11:17:59 INFO - Return code: 0 11:17:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:59 ERROR - # TBPL SUCCESS # 11:17:59 INFO - Running post-action listener: _resource_record_post_action 11:17:59 INFO - Running post-run listener: _resource_record_post_run 11:18:00 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 464195584; Read time: 0; Write time: 400952 11:18:00 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242122752; Read time: 0; Write time: 265444 11:18:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 222072832; Read time: 0; Write time: 135508 11:18:00 INFO - Running post-run listener: _upload_blobber_files 11:18:00 INFO - Blob upload gear active. 11:18:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:18:00 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 11:18:00 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'] 11:18:00 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 11:18:00 INFO - (blobuploader) - INFO - Open directory for files ... 11:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:18:01 INFO - (blobuploader) - INFO - Done attempting. 11:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:18:02 INFO - (blobuploader) - INFO - Done attempting. 11:18:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:18:02 INFO - Return code: 0 11:18:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:18:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:18:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4e8f11659f5552fd089a9369d2710c9adbd5a1b16e49e5e347c2a1450fcba4e93da89145c5f413f7bf2591728ab54e7da59d8dcd5b4f9470844e4ba1628b86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4303dd6ad611dd27a59319504c2583d30411cf2b80b275f302267a794ce82ffd76e992362adf54d2e5334d9d535e2a114a2f9b2f03767b421c3a9326477ba9c"} 11:18:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:18:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:18:02 INFO - Contents: 11:18:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4e8f11659f5552fd089a9369d2710c9adbd5a1b16e49e5e347c2a1450fcba4e93da89145c5f413f7bf2591728ab54e7da59d8dcd5b4f9470844e4ba1628b86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4303dd6ad611dd27a59319504c2583d30411cf2b80b275f302267a794ce82ffd76e992362adf54d2e5334d9d535e2a114a2f9b2f03767b421c3a9326477ba9c"} 11:18:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:18:02 INFO - Copying logs to upload dir... 11:18:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:18:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.565948 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-05 11:18:02.319147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:02.322684) ========= 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=4300f881736b422476174874000001bc-1467741457.302544-1835123630 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/e4e8f11659f5552fd089a9369d2710c9adbd5a1b16e49e5e347c2a1450fcba4e93da89145c5f413f7bf2591728ab54e7da59d8dcd5b4f9470844e4ba1628b86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4303dd6ad611dd27a59319504c2583d30411cf2b80b275f302267a794ce82ffd76e992362adf54d2e5334d9d535e2a114a2f9b2f03767b421c3a9326477ba9c"} build_url:https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/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/e4e8f11659f5552fd089a9369d2710c9adbd5a1b16e49e5e347c2a1450fcba4e93da89145c5f413f7bf2591728ab54e7da59d8dcd5b4f9470844e4ba1628b86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4303dd6ad611dd27a59319504c2583d30411cf2b80b275f302267a794ce82ffd76e992362adf54d2e5334d9d535e2a114a2f9b2f03767b421c3a9326477ba9c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:02.348529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:02.348856) ========= 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=4300f881736b422476174874000001bc-1467741457.302544-1835123630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:02.435057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:18:02.435878) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:18:02.436185) ========= ========= Total master_lag: 0.18 =========