builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1469025167.17 results: success (0) buildid: 20160720045219 builduid: d40508a16f0f4ae8a33ae4e73925e8bb revision: ef30d84237a8ef9880871c49faf9136fad326fd9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.173526) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.173961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.174246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.189679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.190080) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 07:32:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-07-20 07:32:47 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.322755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.527784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.528248) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.579123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:47.579705) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ef30d84237a8ef9880871c49faf9136fad326fd9 --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 ef30d84237a8ef9880871c49faf9136fad326fd9 --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=e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 07:32:47,806 truncating revision to first 12 chars 2016-07-20 07:32:47,807 Setting DEBUG logging. 2016-07-20 07:32:47,807 attempt 1/10 2016-07-20 07:32:47,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ef30d84237a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 07:32:48,126 unpacking tar archive at: mozilla-beta-ef30d84237a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:48.250813) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:48.251147) ========= script_repo_revision: ef30d84237a8ef9880871c49faf9136fad326fd9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:48.251588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:48.251855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:32:48.264710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-07-20 07:32:48.265149) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:32:48 INFO - MultiFileLogger online at 20160720 07:32:48 in /builds/slave/test 07:32:48 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 07:32:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:48 INFO - {'append_to_log': False, 07:32:48 INFO - 'base_work_dir': '/builds/slave/test', 07:32:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:32:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:48 INFO - 'branch': 'Mozilla-Beta', 07:32:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:48 INFO - 'config_files': ('talos/linux_config.py',), 07:32:48 INFO - 'default_actions': ('clobber', 07:32:48 INFO - 'read-buildbot-config', 07:32:48 INFO - 'download-and-extract', 07:32:48 INFO - 'populate-webroot', 07:32:48 INFO - 'create-virtualenv', 07:32:48 INFO - 'install', 07:32:48 INFO - 'run-tests'), 07:32:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:48 INFO - 'download_minidump_stackwalk': True, 07:32:48 INFO - 'download_symbols': 'ondemand', 07:32:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:48 INFO - 'installer_path': 'installer.exe', 07:32:48 INFO - 'log_level': 'info', 07:32:48 INFO - 'log_name': 'talos', 07:32:48 INFO - 'log_to_console': True, 07:32:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:32:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:32:48 INFO - 'opt_config_files': (), 07:32:48 INFO - 'pip_index': False, 07:32:48 INFO - 'sps_profile': False, 07:32:48 INFO - 'sps_profile_interval': 0, 07:32:48 INFO - 'suite': 'dromaeojs', 07:32:48 INFO - 'system_bits': '32', 07:32:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:48 INFO - 'title': 'talos-linux64-ix-006', 07:32:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:48 INFO - 'use_talos_json': True, 07:32:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:48 INFO - 'work_dir': 'build'} 07:32:48 INFO - ##### 07:32:48 INFO - ##### Running clobber step. 07:32:48 INFO - ##### 07:32:48 INFO - Running pre-action listener: _resource_record_pre_action 07:32:48 INFO - Running main action method: clobber 07:32:48 INFO - rmtree: /builds/slave/test/build 07:32:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:49 INFO - Running post-action listener: _resource_record_post_action 07:32:49 INFO - ##### 07:32:49 INFO - ##### Running read-buildbot-config step. 07:32:49 INFO - ##### 07:32:49 INFO - Running pre-action listener: _resource_record_pre_action 07:32:49 INFO - Running main action method: read_buildbot_config 07:32:49 INFO - Using buildbot properties: 07:32:49 INFO - { 07:32:49 INFO - "project": "", 07:32:49 INFO - "product": "firefox", 07:32:49 INFO - "script_repo_revision": "production", 07:32:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:32:49 INFO - "repository": "", 07:32:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 07:32:49 INFO - "buildid": "20160720045219", 07:32:49 INFO - "pgo_build": "True", 07:32:49 INFO - "basedir": "/builds/slave/test", 07:32:49 INFO - "buildnumber": 108, 07:32:49 INFO - "slavename": "talos-linux64-ix-006", 07:32:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:32:49 INFO - "platform": "ubuntu64_hw", 07:32:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 07:32:49 INFO - "branch": "mozilla-beta", 07:32:49 INFO - "repo_path": "releases/mozilla-beta", 07:32:49 INFO - "revision": "ef30d84237a8ef9880871c49faf9136fad326fd9", 07:32:49 INFO - "stage_platform": "linux64-pgo", 07:32:49 INFO - "builduid": "d40508a16f0f4ae8a33ae4e73925e8bb", 07:32:49 INFO - "slavebuilddir": "test" 07:32:49 INFO - } 07:32:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 07:32:49 INFO - Running post-action listener: _resource_record_post_action 07:32:49 INFO - ##### 07:32:49 INFO - ##### Running download-and-extract step. 07:32:49 INFO - ##### 07:32:49 INFO - Running pre-action listener: _resource_record_pre_action 07:32:49 INFO - Running main action method: download_and_extract 07:32:49 INFO - mkdir: /builds/slave/test/build/tests 07:32:49 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')]} 07:32:49 INFO - https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:32:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:32:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:32:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:50 INFO - Downloaded 1327 bytes. 07:32:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 07:32:50 INFO - Using the following test package requirements: 07:32:50 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 07:32:50 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:32:50 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 07:32:50 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'jsshell-linux-x86_64.zip'], 07:32:50 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:32:50 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 07:32:50 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 07:32:50 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 07:32:50 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:32:50 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 07:32:50 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:32:50 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:50 INFO - https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:51 INFO - Downloaded 24200724 bytes. 07:32:51 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'] 07:32:51 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 07:32:52 INFO - Return code: 0 07:32:52 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 07:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:52 INFO - https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 07:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:54 INFO - Downloaded 24200724 bytes. 07:32:54 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'] 07:32:54 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 07:32:55 INFO - Return code: 0 07:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:55 INFO - https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 07:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 07:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:56 INFO - Downloaded 10840145 bytes. 07:32:56 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'] 07:32:56 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 07:32:57 INFO - Return code: 0 07:32: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')]} 07:32:57 INFO - https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aygKxcBzTK2HljP58d17-A/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 07:32:58 INFO - Downloaded 56019050 bytes. 07:32:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:32:58 INFO - mkdir: /builds/slave/test/properties 07:32:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:58 INFO - Contents: 07:32:58 INFO - build_url:https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 07:32:59 INFO - Running post-action listener: _resource_record_post_action 07:32:59 INFO - Running post-action listener: set_extra_try_arguments 07:32:59 INFO - ##### 07:32:59 INFO - ##### Running populate-webroot step. 07:32:59 INFO - ##### 07:32:59 INFO - Running pre-action listener: _resource_record_pre_action 07:32:59 INFO - Running main action method: populate_webroot 07:32:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:59 INFO - '--tppagecycles', 07:32:59 INFO - '7'], 07:32:59 INFO - 'tests': ['tsvgm']}}, 07:32:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['damp', 'tps']}, 07:32:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'tests': ['damp', 'tps']}, 07:32:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['dromaeo_dom']}, 07:32:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['a11yr', 07:32:59 INFO - 'ts_paint', 07:32:59 INFO - 'tpaint', 07:32:59 INFO - 'sessionrestore', 07:32:59 INFO - 'sessionrestore_no_auto_restore', 07:32:59 INFO - 'tabpaint']}, 07:32:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:59 INFO - 'ts_paint', 07:32:59 INFO - 'tpaint', 07:32:59 INFO - 'sessionrestore', 07:32:59 INFO - 'sessionrestore_no_auto_restore', 07:32:59 INFO - 'tabpaint']}, 07:32:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:59 INFO - 'ts_paint', 07:32:59 INFO - 'tpaint', 07:32:59 INFO - 'sessionrestore', 07:32:59 INFO - 'sessionrestore_no_auto_restore', 07:32:59 INFO - 'tabpaint']}, 07:32:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:59 INFO - 'ts_paint', 07:32:59 INFO - 'tpaint', 07:32:59 INFO - 'sessionrestore', 07:32:59 INFO - 'sessionrestore_no_auto_restore', 07:32:59 INFO - 'tabpaint']}, 07:32:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['a11yr', 07:32:59 INFO - 'ts_paint', 07:32:59 INFO - 'tpaint', 07:32:59 INFO - 'sessionrestore', 07:32:59 INFO - 'sessionrestore_no_auto_restore', 07:32:59 INFO - 'tabpaint']}, 07:32:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['a11yr', 07:32:59 INFO - 'ts_paint', 07:32:59 INFO - 'tpaint', 07:32:59 INFO - 'sessionrestore', 07:32:59 INFO - 'sessionrestore_no_auto_restore', 07:32:59 INFO - 'tabpaint']}, 07:32:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['tsvgx', 07:32:59 INFO - 'tsvgr_opacity', 07:32:59 INFO - 'tart', 07:32:59 INFO - 'tscrollx', 07:32:59 INFO - 'cart']}, 07:32:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:59 INFO - 'tsvgr_opacity', 07:32:59 INFO - 'tart', 07:32:59 INFO - 'tscrollx', 07:32:59 INFO - 'cart']}, 07:32:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'talos_options': ['--disable-e10s'], 07:32:59 INFO - 'tests': ['tp5o']}, 07:32:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'tests': ['tp5o']}, 07:32:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'talos_options': ['--disable-e10s', 07:32:59 INFO - '--xperf_path', 07:32:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:59 INFO - 'tests': ['tp5n']}, 07:32:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:59 INFO - 'talos_options': ['--xperf_path', 07:32:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:59 INFO - 'tests': ['tp5n']}}, 07:32:59 INFO - 'talos.zip': {'path': '', 07:32:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:59 INFO - Running post-action listener: _resource_record_post_action 07:32:59 INFO - ##### 07:32:59 INFO - ##### Running create-virtualenv step. 07:32:59 INFO - ##### 07:32:59 INFO - Running pre-action listener: _resource_record_pre_action 07:32:59 INFO - Running main action method: create_virtualenv 07:32:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:59 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 07:32:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:59 INFO - Using real prefix '/usr' 07:32:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:33:01 INFO - Installing pip.................done. 07:33:01 INFO - Return code: 0 07:33:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:33:01 INFO - Using env: {'DISPLAY': ':0', 07:33:01 INFO - 'HOME': '/home/cltbld', 07:33:01 INFO - 'LANG': 'en_US.UTF-8', 07:33:01 INFO - 'LANGUAGE': 'en_US:en', 07:33:01 INFO - 'LOGNAME': 'cltbld', 07:33:01 INFO - 'MAIL': '/var/mail/cltbld', 07:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:01 INFO - 'MOZ_NO_REMOTE': '1', 07:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:01 INFO - 'NO_EM_RESTART': '1', 07:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:01 INFO - 'PWD': '/builds/slave/test', 07:33:01 INFO - 'SHELL': '/bin/bash', 07:33:01 INFO - 'SHLVL': '1', 07:33:01 INFO - 'TERM': 'linux', 07:33:01 INFO - 'TMOUT': '86400', 07:33:01 INFO - 'USER': 'cltbld', 07:33:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:01 INFO - '_': '/tools/buildbot/bin/python'} 07:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:02 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 07:33:02 INFO - Cleaning up... 07:33:02 INFO - Return code: 0 07:33:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:33:02 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')]} 07:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:02 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')]} 07:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:02 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:02 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 07:33:02 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 07:33:02 INFO - Using env: {'DISPLAY': ':0', 07:33:02 INFO - 'HOME': '/home/cltbld', 07:33:02 INFO - 'LANG': 'en_US.UTF-8', 07:33:02 INFO - 'LANGUAGE': 'en_US:en', 07:33:02 INFO - 'LOGNAME': 'cltbld', 07:33:02 INFO - 'MAIL': '/var/mail/cltbld', 07:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:02 INFO - 'MOZ_NO_REMOTE': '1', 07:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:02 INFO - 'NO_EM_RESTART': '1', 07:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:02 INFO - 'PWD': '/builds/slave/test', 07:33:02 INFO - 'SHELL': '/bin/bash', 07:33:02 INFO - 'SHLVL': '1', 07:33:02 INFO - 'TERM': 'linux', 07:33:02 INFO - 'TMOUT': '86400', 07:33:02 INFO - 'USER': 'cltbld', 07:33:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:02 INFO - '_': '/tools/buildbot/bin/python'} 07:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:02 INFO - Downloading/unpacking psutil>=0.7.1 07:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:33:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:04 INFO - Installing collected packages: psutil 07:33:04 INFO - Running setup.py install for psutil 07:33:04 INFO - building 'psutil._psutil_linux' extension 07:33:04 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 07:33:04 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 07:33:04 INFO - building 'psutil._psutil_posix' extension 07:33:04 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 07:33:04 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 07:33:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:04 INFO - Successfully installed psutil 07:33:04 INFO - Cleaning up... 07:33:04 INFO - Return code: 0 07:33:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:04 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:04 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 07:33:04 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 07:33:04 INFO - Using env: {'DISPLAY': ':0', 07:33:04 INFO - 'HOME': '/home/cltbld', 07:33:04 INFO - 'LANG': 'en_US.UTF-8', 07:33:04 INFO - 'LANGUAGE': 'en_US:en', 07:33:04 INFO - 'LOGNAME': 'cltbld', 07:33:04 INFO - 'MAIL': '/var/mail/cltbld', 07:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:04 INFO - 'MOZ_NO_REMOTE': '1', 07:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:04 INFO - 'NO_EM_RESTART': '1', 07:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:04 INFO - 'PWD': '/builds/slave/test', 07:33:04 INFO - 'SHELL': '/bin/bash', 07:33:04 INFO - 'SHLVL': '1', 07:33:04 INFO - 'TERM': 'linux', 07:33:04 INFO - 'TMOUT': '86400', 07:33:04 INFO - 'USER': 'cltbld', 07:33:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:04 INFO - '_': '/tools/buildbot/bin/python'} 07:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:33:07 INFO - Installing collected packages: mozsystemmonitor 07:33:07 INFO - Running setup.py install for mozsystemmonitor 07:33:07 INFO - Successfully installed mozsystemmonitor 07:33:07 INFO - Cleaning up... 07:33:07 INFO - Return code: 0 07:33:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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', '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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:33: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 blobuploader==1.2.4 07:33:07 INFO - Using env: {'DISPLAY': ':0', 07:33:07 INFO - 'HOME': '/home/cltbld', 07:33:07 INFO - 'LANG': 'en_US.UTF-8', 07:33:07 INFO - 'LANGUAGE': 'en_US:en', 07:33:07 INFO - 'LOGNAME': 'cltbld', 07:33:07 INFO - 'MAIL': '/var/mail/cltbld', 07:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:07 INFO - 'MOZ_NO_REMOTE': '1', 07:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:07 INFO - 'NO_EM_RESTART': '1', 07:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:07 INFO - 'PWD': '/builds/slave/test', 07:33:07 INFO - 'SHELL': '/bin/bash', 07:33:07 INFO - 'SHLVL': '1', 07:33:07 INFO - 'TERM': 'linux', 07:33:07 INFO - 'TMOUT': '86400', 07:33:07 INFO - 'USER': 'cltbld', 07:33:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:07 INFO - '_': '/tools/buildbot/bin/python'} 07:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:33:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:33:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33:09 INFO - Downloading docopt-0.6.1.tar.gz 07:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:33:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:33:10 INFO - Running setup.py install for blobuploader 07:33:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:33:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:33:10 INFO - Running setup.py install for requests 07:33:10 INFO - Running setup.py install for docopt 07:33:10 INFO - Successfully installed blobuploader requests docopt 07:33:10 INFO - Cleaning up... 07:33:10 INFO - Return code: 0 07:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:10 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:10 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 07:33:10 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 07:33:10 INFO - Using env: {'DISPLAY': ':0', 07:33:10 INFO - 'HOME': '/home/cltbld', 07:33:10 INFO - 'LANG': 'en_US.UTF-8', 07:33:10 INFO - 'LANGUAGE': 'en_US:en', 07:33:10 INFO - 'LOGNAME': 'cltbld', 07:33:10 INFO - 'MAIL': '/var/mail/cltbld', 07:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:10 INFO - 'MOZ_NO_REMOTE': '1', 07:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:10 INFO - 'NO_EM_RESTART': '1', 07:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:10 INFO - 'PWD': '/builds/slave/test', 07:33:10 INFO - 'SHELL': '/bin/bash', 07:33:10 INFO - 'SHLVL': '1', 07:33:10 INFO - 'TERM': 'linux', 07:33:10 INFO - 'TMOUT': '86400', 07:33:10 INFO - 'USER': 'cltbld', 07:33:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:10 INFO - '_': '/tools/buildbot/bin/python'} 07:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:10 INFO - Running setup.py (path:/tmp/pip-jWhhdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:10 INFO - Running setup.py (path:/tmp/pip-uprkbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:10 INFO - Running setup.py (path:/tmp/pip-fwoNiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:11 INFO - Running setup.py (path:/tmp/pip-6BqyDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:11 INFO - Running setup.py (path:/tmp/pip-0rsh91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:11 INFO - Running setup.py (path:/tmp/pip-12Grgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:11 INFO - Running setup.py (path:/tmp/pip-4u25eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:11 INFO - Running setup.py (path:/tmp/pip-JwZ1LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:11 INFO - Running setup.py (path:/tmp/pip-Oye3Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:11 INFO - Running setup.py (path:/tmp/pip-DSYOni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:11 INFO - Running setup.py (path:/tmp/pip-0CxT9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:11 INFO - Running setup.py (path:/tmp/pip-Kwcl3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:11 INFO - Running setup.py (path:/tmp/pip-yPZlHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:11 INFO - Running setup.py (path:/tmp/pip-oEv1Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:11 INFO - Running setup.py (path:/tmp/pip-UnL62a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:11 INFO - Running setup.py (path:/tmp/pip-KskvXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:12 INFO - Running setup.py (path:/tmp/pip-Y5MyLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:33:12 INFO - Running setup.py install for manifestparser 07:33:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Running setup.py install for mozcrash 07:33:12 INFO - Running setup.py install for mozdebug 07:33:12 INFO - Running setup.py install for mozdevice 07:33:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Running setup.py install for mozfile 07:33:12 INFO - Running setup.py install for mozhttpd 07:33:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Running setup.py install for mozinfo 07:33:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Running setup.py install for mozInstall 07:33:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:33:12 INFO - Running setup.py install for mozleak 07:33:12 INFO - Running setup.py install for mozlog 07:33:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Running setup.py install for moznetwork 07:33:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Running setup.py install for mozprocess 07:33:13 INFO - Running setup.py install for mozprofile 07:33:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Running setup.py install for mozrunner 07:33:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Running setup.py install for mozscreenshot 07:33:13 INFO - Running setup.py install for moztest 07:33:13 INFO - Running setup.py install for mozversion 07:33:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:33:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:33:13 INFO - Cleaning up... 07:33:13 INFO - Return code: 0 07:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:13 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:13 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 07:33:13 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 07:33:13 INFO - Using env: {'DISPLAY': ':0', 07:33:13 INFO - 'HOME': '/home/cltbld', 07:33:13 INFO - 'LANG': 'en_US.UTF-8', 07:33:13 INFO - 'LANGUAGE': 'en_US:en', 07:33:13 INFO - 'LOGNAME': 'cltbld', 07:33:13 INFO - 'MAIL': '/var/mail/cltbld', 07:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:13 INFO - 'MOZ_NO_REMOTE': '1', 07:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:13 INFO - 'NO_EM_RESTART': '1', 07:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:13 INFO - 'PWD': '/builds/slave/test', 07:33:13 INFO - 'SHELL': '/bin/bash', 07:33:13 INFO - 'SHLVL': '1', 07:33:13 INFO - 'TERM': 'linux', 07:33:13 INFO - 'TMOUT': '86400', 07:33:13 INFO - 'USER': 'cltbld', 07:33:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:13 INFO - '_': '/tools/buildbot/bin/python'} 07:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:14 INFO - Running setup.py (path:/tmp/pip-xfIOf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:14 INFO - Running setup.py (path:/tmp/pip-XQuKOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:14 INFO - Running setup.py (path:/tmp/pip-dlmEpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:14 INFO - Running setup.py (path:/tmp/pip-b5490T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:14 INFO - Running setup.py (path:/tmp/pip-5pvDUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:14 INFO - Running setup.py (path:/tmp/pip-AhIPmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:14 INFO - Running setup.py (path:/tmp/pip-Wqy5U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:14 INFO - Running setup.py (path:/tmp/pip-FwmF_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:14 INFO - Running setup.py (path:/tmp/pip-58SrF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:14 INFO - Running setup.py (path:/tmp/pip-weHMd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:14 INFO - Running setup.py (path:/tmp/pip-D9aG9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:14 INFO - Running setup.py (path:/tmp/pip-LIo9hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:14 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)) 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:14 INFO - Running setup.py (path:/tmp/pip-pJvfDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:15 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)) 07:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:15 INFO - Running setup.py (path:/tmp/pip-_dSG7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:15 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)) 07:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:15 INFO - Running setup.py (path:/tmp/pip-gR9g0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:15 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)) 07:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:15 INFO - Running setup.py (path:/tmp/pip-cdDffe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:15 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)) 07:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:15 INFO - Running setup.py (path:/tmp/pip-bm3Svr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:15 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)) 07:33:15 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)) 07:33:15 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)) 07:33:15 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)) 07:33:15 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)) 07:33:15 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)) 07:33:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:17 INFO - Downloading blessings-1.6.tar.gz 07:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:33:17 INFO - Installing collected packages: blessings 07:33:17 INFO - Running setup.py install for blessings 07:33:17 INFO - Successfully installed blessings 07:33:17 INFO - Cleaning up... 07:33:17 INFO - Return code: 0 07:33:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:17 INFO - Reading from file tmpfile_stdout 07:33:17 INFO - Current package versions: 07:33:17 INFO - argparse == 1.2.1 07:33:17 INFO - blessings == 1.6 07:33:17 INFO - blobuploader == 1.2.4 07:33:17 INFO - docopt == 0.6.1 07:33:17 INFO - manifestparser == 1.1 07:33:17 INFO - mozInstall == 1.12 07:33:17 INFO - mozcrash == 0.17 07:33:17 INFO - mozdebug == 0.1 07:33:17 INFO - mozdevice == 0.48 07:33:17 INFO - mozfile == 1.2 07:33:17 INFO - mozhttpd == 0.7 07:33:17 INFO - mozinfo == 0.9 07:33:17 INFO - mozleak == 0.1 07:33:17 INFO - mozlog == 3.1 07:33:17 INFO - moznetwork == 0.27 07:33:17 INFO - mozprocess == 0.22 07:33:17 INFO - mozprofile == 0.28 07:33:17 INFO - mozrunner == 6.11 07:33:17 INFO - mozscreenshot == 0.1 07:33:17 INFO - mozsystemmonitor == 0.0 07:33:17 INFO - moztest == 0.7 07:33:17 INFO - mozversion == 1.4 07:33:17 INFO - psutil == 3.1.1 07:33:17 INFO - requests == 1.2.3 07:33:17 INFO - wsgiref == 0.1.2 07:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:17 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')]} 07:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:17 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')]} 07:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:17 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:17 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 07:33:17 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 07:33:17 INFO - Using env: {'DISPLAY': ':0', 07:33:17 INFO - 'HOME': '/home/cltbld', 07:33:17 INFO - 'LANG': 'en_US.UTF-8', 07:33:17 INFO - 'LANGUAGE': 'en_US:en', 07:33:17 INFO - 'LOGNAME': 'cltbld', 07:33:17 INFO - 'MAIL': '/var/mail/cltbld', 07:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:17 INFO - 'MOZ_NO_REMOTE': '1', 07:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:17 INFO - 'NO_EM_RESTART': '1', 07:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:17 INFO - 'PWD': '/builds/slave/test', 07:33:17 INFO - 'SHELL': '/bin/bash', 07:33:17 INFO - 'SHLVL': '1', 07:33:17 INFO - 'TERM': 'linux', 07:33:17 INFO - 'TMOUT': '86400', 07:33:17 INFO - 'USER': 'cltbld', 07:33:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:17 INFO - '_': '/tools/buildbot/bin/python'} 07:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 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)) 07:33:17 INFO - Cleaning up... 07:33:17 INFO - Return code: 0 07:33:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:33:17 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')]} 07:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:17 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')]} 07:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:17 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:17 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 07:33:17 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 07:33:17 INFO - Using env: {'DISPLAY': ':0', 07:33:17 INFO - 'HOME': '/home/cltbld', 07:33:17 INFO - 'LANG': 'en_US.UTF-8', 07:33:17 INFO - 'LANGUAGE': 'en_US:en', 07:33:17 INFO - 'LOGNAME': 'cltbld', 07:33:17 INFO - 'MAIL': '/var/mail/cltbld', 07:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:17 INFO - 'MOZ_NO_REMOTE': '1', 07:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:17 INFO - 'NO_EM_RESTART': '1', 07:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:17 INFO - 'PWD': '/builds/slave/test', 07:33:17 INFO - 'SHELL': '/bin/bash', 07:33:17 INFO - 'SHLVL': '1', 07:33:17 INFO - 'TERM': 'linux', 07:33:17 INFO - 'TMOUT': '86400', 07:33:17 INFO - 'USER': 'cltbld', 07:33:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:17 INFO - '_': '/tools/buildbot/bin/python'} 07:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:18 INFO - Downloading/unpacking jsonschema 07:33:18 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 07:33:18 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 07:33:18 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 07:33:18 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 07:33:18 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 07:33:18 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 07:33:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:33:20 INFO - Downloading/unpacking functools32 (from jsonschema) 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:33:20 INFO - warning: no files found matching '*.txt' 07:33:20 INFO - no previously-included directories found matching 'build' 07:33:20 INFO - no previously-included directories found matching 'dist' 07:33:20 INFO - no previously-included directories found matching '.git*' 07:33:20 INFO - Installing collected packages: jsonschema, functools32 07:33:20 INFO - Running setup.py install for functools32 07:33:20 INFO - warning: no files found matching '*.txt' 07:33:20 INFO - no previously-included directories found matching 'build' 07:33:20 INFO - no previously-included directories found matching 'dist' 07:33:20 INFO - no previously-included directories found matching '.git*' 07:33:20 INFO - Successfully installed jsonschema functools32 07:33:20 INFO - Cleaning up... 07:33:20 INFO - Return code: 0 07:33:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:33:20 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')]} 07:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:20 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')]} 07:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:20 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 0x7f37ac245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', '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 07:33:20 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 07:33:20 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 07:33:20 INFO - Using env: {'DISPLAY': ':0', 07:33:20 INFO - 'HOME': '/home/cltbld', 07:33:20 INFO - 'LANG': 'en_US.UTF-8', 07:33:20 INFO - 'LANGUAGE': 'en_US:en', 07:33:20 INFO - 'LOGNAME': 'cltbld', 07:33:20 INFO - 'MAIL': '/var/mail/cltbld', 07:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:20 INFO - 'MOZ_NO_REMOTE': '1', 07:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:20 INFO - 'NO_EM_RESTART': '1', 07:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:20 INFO - 'PWD': '/builds/slave/test', 07:33:20 INFO - 'SHELL': '/bin/bash', 07:33:20 INFO - 'SHLVL': '1', 07:33:20 INFO - 'TERM': 'linux', 07:33:20 INFO - 'TMOUT': '86400', 07:33:20 INFO - 'USER': 'cltbld', 07:33:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:20 INFO - '_': '/tools/buildbot/bin/python'} 07:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:20 INFO - Downloading/unpacking flake8 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 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 07:33:20 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 07:33:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:33:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:33:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 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 07:33:22 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 07:33:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:33:23 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 07:33:23 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 07:33:23 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 07:33:23 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 07:33:23 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 07:33:23 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 07:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:33:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:33:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:33:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:33:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:33:23 INFO - no previously-included directories found matching 'docs/_build' 07:33:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:33:23 INFO - Running setup.py install for pep8 07:33:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:33:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:33:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:33:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:33:23 INFO - no previously-included directories found matching 'docs/_build' 07:33:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:33:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:33:23 INFO - Cleaning up... 07:33:23 INFO - Return code: 0 07:33:23 INFO - Running post-action listener: _resource_record_post_action 07:33:23 INFO - Running post-action listener: _start_resource_monitoring 07:33:23 INFO - Starting resource monitoring. 07:33:23 INFO - ##### 07:33:23 INFO - ##### Running install step. 07:33:23 INFO - ##### 07:33:23 INFO - Running pre-action listener: _resource_record_pre_action 07:33:23 INFO - Running main action method: install 07:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:23 INFO - Reading from file tmpfile_stdout 07:33:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:33:23 INFO - Reading from file tmpfile_stdout 07:33:23 INFO - Output received: 07:33:23 INFO - Usage: mozinstall [options] installer 07:33:23 INFO - Options: 07:33:23 INFO - -h, --help show this help message and exit 07:33:23 INFO - -d DEST, --destination=DEST 07:33:23 INFO - Directory to install application into. [default: 07:33:23 INFO - "/builds/slave/test"] 07:33:23 INFO - --app=APP Application being installed. [default: firefox] 07:33:23 INFO - mkdir: /builds/slave/test/build/application 07:33:23 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'] 07:33:23 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 07:33:37 INFO - Reading from file tmpfile_stdout 07:33:37 INFO - Output received: 07:33:37 INFO - /builds/slave/test/build/application/firefox/firefox 07:33:37 INFO - Running post-action listener: _resource_record_post_action 07:33:37 INFO - ##### 07:33:37 INFO - ##### Running run-tests step. 07:33:37 INFO - ##### 07:33:37 INFO - Running pre-action listener: _resource_record_pre_action 07:33:37 INFO - Running main action method: run_tests 07:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:37 INFO - Python 2.7.3 07:33:37 INFO - Return code: 0 07:33:37 INFO - grabbing minidump binary from tooltool 07:33:37 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')]} 07:33:37 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 0x2a7d410>, '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 0x2a7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:37 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 07:33:37 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 07:33:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:37 INFO - Return code: 0 07:33:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:33:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:33:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:33:38 INFO - Return code: 0 07:33:38 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/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 07:33:38 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/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 07:33:38 INFO - Using env: {'DISPLAY': ':0', 07:33:38 INFO - 'HOME': '/home/cltbld', 07:33:38 INFO - 'LANG': 'en_US.UTF-8', 07:33:38 INFO - 'LANGUAGE': 'en_US:en', 07:33:38 INFO - 'LOGNAME': 'cltbld', 07:33:38 INFO - 'MAIL': '/var/mail/cltbld', 07:33:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:38 INFO - 'MOZ_NO_REMOTE': '1', 07:33:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:38 INFO - 'NO_EM_RESTART': '1', 07:33:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:38 INFO - 'PWD': '/builds/slave/test', 07:33:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:38 INFO - 'SHELL': '/bin/bash', 07:33:38 INFO - 'SHLVL': '1', 07:33:38 INFO - 'TERM': 'linux', 07:33:38 INFO - 'TMOUT': '86400', 07:33:38 INFO - 'USER': 'cltbld', 07:33:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460', 07:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:38 INFO - '_': '/tools/buildbot/bin/python'} 07:33:38 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/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 07:33:38 INFO - mozversion application_buildid: 20160720045219 07:33:38 INFO - mozversion application_changeset: ef30d84237a8ef9880871c49faf9136fad326fd9 07:33:38 INFO - mozversion application_display_name: Firefox 07:33:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:38 INFO - mozversion application_name: Firefox 07:33:38 INFO - mozversion application_remotingname: firefox 07:33:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:33:38 INFO - mozversion application_vendor: Mozilla 07:33:38 INFO - mozversion application_version: 48.0 07:33:38 INFO - mozversion platform_buildid: 20160720045219 07:33:38 INFO - mozversion platform_changeset: ef30d84237a8ef9880871c49faf9136fad326fd9 07:33:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:33:38 INFO - mozversion platform_version: 48.0 07:33:38 INFO - using testdate: 1469025218 07:33:38 INFO - actual date: 1469025218 07:33:38 INFO - starting webserver on 'localhost:42001' 07:33:38 INFO - SUITE-START | Running 2 tests 07:33:38 INFO - TEST-START | dromaeo_css 07:33:38 INFO - operating with platform_type : linux_ 07:33:38 INFO - Initialising browser for dromaeo_css test... 07:33:38 INFO - TEST-INFO | started process 7239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1jVUfx/profile http://localhost:42001/getInfo.html) 07:33:42 INFO - PROCESS | 7239 | __metrics Screen width/height:1600/1200 07:33:42 INFO - PROCESS | 7239 | colorDepth:24 07:33:42 INFO - PROCESS | 7239 | Browser inner width/height: 1024/697 07:33:42 INFO - PROCESS | 7239 | __metrics 07:33:43 INFO - PROCESS | 7239 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:33:43 ERROR - PROCESS | 7239 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:33:44 INFO - TEST-INFO | 7239: exit 0 07:33:44 INFO - Browser initialized. 07:33:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:44 INFO - TEST-INFO | started process 7331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1jVUfx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:56 INFO - PROCESS | 7331 | RSS: Main: 139689984 07:33:56 INFO - PROCESS | 7331 | 07:34:47 INFO - PROCESS | 7331 | 1469025287445 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:36:55 INFO - PROCESS | 7331 | Cycle 1(1): loaded http://localhost:42001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42001/tests/dromaeo/cssquery-ext.html) 07:36:56 INFO - PROCESS | 7331 | RSS: Main: 252653568 07:36:56 INFO - PROCESS | 7331 | 07:39:58 INFO - PROCESS | 7331 | Cycle 1(1): loaded http://localhost:42001/tests/dromaeo/cssquery-ext.html (next: http://localhost:42001/tests/dromaeo/cssquery-jquery.html) 07:39:58 INFO - PROCESS | 7331 | RSS: Main: 225452032 07:39:58 INFO - PROCESS | 7331 | 07:43:00 INFO - PROCESS | 7331 | Cycle 1(1): loaded http://localhost:42001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42001/tests/dromaeo/cssquery-mootools.html) 07:43:01 INFO - PROCESS | 7331 | RSS: Main: 222412800 07:43:01 INFO - PROCESS | 7331 | 07:46:02 INFO - PROCESS | 7331 | Cycle 1(1): loaded http://localhost:42001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42001/tests/dromaeo/cssquery-prototype.html) 07:46:03 INFO - PROCESS | 7331 | RSS: Main: 218017792 07:46:03 INFO - PROCESS | 7331 | 07:49:05 INFO - PROCESS | 7331 | Cycle 1(1): loaded http://localhost:42001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42001/tests/dromaeo/cssquery-yui.html) 07:49:06 INFO - PROCESS | 7331 | RSS: Main: 209899520 07:49:06 INFO - PROCESS | 7331 | 07:52:08 INFO - PROCESS | 7331 | Cycle 1(1): loaded http://localhost:42001/tests/dromaeo/cssquery-yui.html (next: http://localhost:42001/tests/dromaeo/cssquery-dojo.html) 07:52:09 INFO - PROCESS | 7331 | RSS: Main: 257863680 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | __start_tp_report 07:52:09 INFO - PROCESS | 7331 | _x_x_mozilla_page_load 07:52:09 INFO - PROCESS | 7331 | _x_x_mozilla_page_load_details 07:52:09 INFO - PROCESS | 7331 | |i|pagename|runs| 07:52:09 INFO - PROCESS | 7331 | |0;dojo.html;3326.0354497195813;3405.1487128217946;3423.845926933288;3439.2089819341536;3445.0181698216015;5656.802011929578;5664.858378540539;5680.091185410335;5704.201411802351;5708.400617935119;5672.347680016789;5708.514776244025;5714.457126572969;5716.085426331777;5716.742746576404;5069.695818250917;5151.124308867483;5275.657082289639;5304.443033481487;5331.600129990247;5115.769790359443;5157.6647517911215;5197.87005324868;5201.557867581241;5202.973985130069;5155.81954631588;5157.793688252485;5238.083335416287;5252.921206181911;5272.393674727398;5240.8689782755355;5267.841964741064;5267.920981185285;5273.209018647195;5304.814331498379;5061.670991385585;5107.846764597068;5142.100132476839;5177.249298851683;5184.015037142931;5560.110382338807;5608.130739735348;5627.493525582676;5629.60592758507;5636.0982242841355;5988.580799344048;5990.071538911476;5990.7903223386975;5992.4307190817235;5995.340512543617;6006.279246490405;6047.516198704137;6056.545759068087;6087.634741915499;6096.085587161917;5529.806456773994;5580.330360356743;5582.553395728291;5596.776128954878;5622.353429355636;6050.334463209044;6053.092036194518;6061.696915154224;6076.787312444043;6102.9694851525455;5934.732937017845;5937.910931335947;5982.46157845796;5993.220881285405;5999.850003749942;5983.790567330209;5988.5508586855285;5991.221141251609;5992.34084250732;6004.0693692477735;5903.291605007341;5949.196858424144;5953.434423729739;5981.401859813984;6094.360092190344;5877.500412464903;5952.345242023374;5956.136360227742;5968.015277479254;5996.13056106862;4560.384348113029;4564.452265728134;4566.566176213254;4589.449266088091;4596.35651008859;4110.05468742191;4112.814923328458;4121.814518346681;4126.051008268115;4171.478565179353;5538.030844602259;5561.221428999943;5562.3047119110115;5564.666120032811;5609.4390560943575;5954.46409823118;5956.821295361059;5957.195778569924;5960.195373624505;5979.910301345483;5556.055470570012;5561.249231353796;5672.376038635747;5708.431205957336;5723.055695810228;5120.462351453119;5132.178851383761;5132.820351287687;5133.076046311625;5153.407358153785;6144.2319710036245;6160.661163636043;6181.041938499539;6182.752689892444;6196.566240363221;5894.528437724972;6098.420650038239;6148.108524263867;6148.877022459616;6150.507959363151;6157.96921015392;6161.045038019114;6163.167972323679;6168.35232300602;6172.321044685171;5843.474087332161;5847.619904706181;5853.94146058534;5901.645901245939;5903.144044113666;6074.271087469532;6111.014442317695;6116.396640261158;6136.028952951454;6137.3248942617165;5912.852178695567;5914.970425147847;5918.615290006136;5921.822345329647;5929.140274660236;5790.247267855152;5886.970565147147;5934.9109763354445;5937.762489500372;5973.49225315853;5871.970640146772;5891.58758886891;5902.6458412495385;5904.793332233351;5942.049272116441;6007.339192688713;6015.969920150371;6022.759089636365;6025;6028.758849645965;5717.628354157133;5895.911561326498;5905.616134951386;5922.822315330547;5939.91090133657 07:52:09 INFO - PROCESS | 7331 | |1;ext.html;666.8466252761865;678.4335080208027;679.9087464619283;752.7967448788827;759.8024513626456;31905.99999999997;40458.19083618326;41435.37846932298;41561.376579351294;41563.376549351706;44175.116497670024;44550.55449445505;44683.329750053774;44773.552264477345;44864;8751.3874028818;8926.553672316391;8927.151920567536;8930.46417214966;8934.910650893506;8760;8950.731478055635;8951.910480895205;8957.059508751585;8958.910410895905;9129.406588571755;9195.356325057248;9196.908030919672;9201.631934722604;9206.125418085272;9093.454392736458;9131.543422828898;9135.680251191176;9142.085791420872;9152;8906.821863562758;8936;9006.639734410615;9022.233110185642;9022.729318120468;43358;43980.78009609963;43997.34003989943;44109.77945110286;44129.33805992913;3908.8045597720284;3957.841686332572;3976.443297938291;4142.46148000758;4552.499225085238;33106.50340244898;33465.83267083673;33791;33941.6605833941;35335.293294133975;4466.798994045275;4486.7083639563325;4548.158590660738;4568.70303430276;4632.606228470584;317307;319227;320118;320524;321327;62256.377436225965;63256;63308;63348.68325658342;63372;71220.64389678018;71749.64125179446;71963.6401817998;72047.2795272051;72101.63949180221;19347.226110955686;19456.513587160433;19549.706754398696;19573.706394404096;19579.216831326587;15053.548393548212;15079.773803392738;15131.47039853622;15138.545843624708;15143.469978550698;20506.07722652484;20690;20708.58582828335;20740.377788666363;21532.56934861294;7640.662883995278;7645.426593005547;7775.844483110306;7862.449628526063;7866.6066696666085;1127.5997021057572;1153.2849633227286;1189.3993533265646;1200.255841378351;1302.5310888080282;33479;33963.66036339654;34190.658093418744;34566.82716586401;34879.651203488145;1216.6958260434892;1221.8961388282096;1241.3979220078254;1312.3044786263297;1354.6545630864066;16939.407120750962;17910.5522361942;18049.187786549635;18068.728969065476;18094.3666971658;440616;441681;448875;448958;450941;62350.68824655938;63181.68409157925;63340.04989925155;63521.04718429227;63577.36422635807;1502.1587910770004;1517.0670037926595;1533.1950725869008;1539.8460153984288;1546.2577962578025;32751;34279.82860085684;34396;34399.82800085984;34520.82739586286;54572.45427545674;55380.72309638426;55403;55419.72290138685;55529;328763;331368;333268;333707;334025;27091.1872643821;27598.862005690647;27612.447751045267;30698.386032279675;31101.222469438446;34246;39954.80022599985;47747.28379074247;47952.28071578999;48291;38697.80651096727;39350.80324598359;39909.20181596294;40016.79991600024;40459.39310910398;37987.620123798406;38252.426213607374;38729.612703873725;39613.207735844546;39852.60147398489;42998.35502467528;43663.781681091394;44077.779611103026;44819;45420;37424.43863341997;38173;38325;38418.615813841505;38853.22293554169;29628.23211661389;29700;29748.55377169301;29811.850940745157;30002.549961750155 07:52:09 INFO - PROCESS | 7331 | |2;jquery.html;400.62341399084875;440.29332920662335;440.68270844991616;442.55081092690915;451.35730299098776;17060.65878682427;19209.519762005955;19255.807441925575;19261.90369048153;19441.805581944176;18774.342897998573;19002;19044.14301356439;19123.904380478078;19306.324278650216;4038.172174704179;5267.841964741045;5412.864678383052;5414.214938833867;5733.741981610817;5829.183914252008;5842.737076831531;5858.443447872445;5870.383609720981;5879.88240235195;5698.914516282259;5867.794627188049;5878.941210587882;6014;6027.63834169949;5917.20117784098;5940.97029514854;5965.135055416984;5981.401859814027;6003.249593800775;5508.7521061552325;5762.625429347121;5777.508911742507;5847;5857.179994800731;14496.492622758153;14602.050866693631;14698.55904322872;21883.890580546995;23461;2259.378670865509;2522.848629082261;2550.60465627828;2884.67305039682;3054.862531186102;10481.842772358421;10676.306040107369;10678.893211067867;10720.78558428835;10894.128469722482;2017.3040301096098;2110.89445527723;2113.6829475578634;2114.862533935305;2120.819730322909;72250;73975.63012184958;76241.85637215502;76704.61647691726;78074;11191.94404027991;11425.143114266462;11469.369184694922;11527.942360288313;11758.412079396167;15662.686746265012;16233.107179105027;16364.19993800681;16366;16389.508314750576;8563.614637341334;8644.178803013703;8725.781855453537;8802.207801297915;8815.074417186232;8428.620712067848;8467.280281176047;8500.74497765068;8565.743027709179;8597.742067737978;4868.14807408702;4891.584215341736;4902.803887844446;4915.778789954389;4921.4832442593015;1984.6725290327222;2018.757749070121;2034.52188735647;2063.690446433047;2073.2950796728883;1039.8076355874186;1047.3611097230682;1103.7185517692938;1188.9167758257013;1203.9277643341427;18441.81558184401;18526.351577694717;18913.527161821065;18926.810731892503;19141.712874306897;1046.3774054437597;1068.3803394031443;1085.9022687958122;1087.3910610058392;1125.1842414249768;10238.488075596191;10429.634962776267;10726.785464290671;10742.624008159833;10798.838017429745;491358;496201;504348;506517;508018;56067.43932560704;75569.62215188889;77041.6147919268;78834.6058269705;86186;1115.6206889657556;1123.7977164110375;1127.610974213895;1153.0602558914459;1162.581470670558;16282.67434651324;16673.583160421087;16684.165791710122;16873.578160546083;17302.91348543249;36994.630053700195;37757.622423775414;37944.620553794106;38408.807955960045;38456.80771596236;52848.20727689165;53065.46934530605;53127;53276.73361633167;53599.464005361006;8989.640414383352;9004.099590040943;9016.86474702893;9158.358914875895;9210.861837072316;12890.67773305675;13035.283059431822;13051.608451746462;13563.660908477366;13768.380422880795;11633;11861.703457413289;11883.702907427038;12250;12294.323812190416;10942.562297508011;11607.76784464289;11621.76756464883;12181.756364872475;12493.75012499763;6502.4472919800455;10203.591856325664;10225.43760093202;12416.56542021061;12500.187487813264;9159.679411220575;9216.447013179231;9346.20557252614;9445;9482.099200575934;11635.41822908868;11691.240069395462;11939.820902686293;12036.097292702907;12232.510699571918 07:52:09 INFO - PROCESS | 7331 | |3;mootools.html;1423.5231197548821;1586.5002524204874;1599.6480774229672;1841.4751795738218;1934.5550523379632;8292.212239837221;8580.442271252365;8583.313334933206;8584.742457726263;8602;8177.713780017701;8348.29039531639;8356.415050946436;8358.791030224247;8360.372972027091;2429.8906549205285;2451.1053465485147;2454.2514533067406;2457.4102215468247;2462.445949661321;2377.1917548033666;2401.9639705404434;2445.254197469771;2456.5455390752677;2463.0763463701114;2422.9636555451684;2458.7787099161073;2468.358226861011;2477.925662230127;2485.3662316109367;2379.845310054841;2418.4316685578874;2447.7674620910984;2463.273334366357;2465.6055031195015;2390.521895620883;2439.42673471734;2455.9754402455924;2457.8279520433575;2458.4714286428502;7538.623068846536;7686.7693969180455;8516.8722469163;8548.358873084482;8550.358723095731;5090.9745451272875;5130.256112863613;5172.844814655567;5188.8962220755375;5195.350581177353;3653.5433070866143;3664.6885014773775;3711.66595006448;3716.8513259469587;3721.4603882437164;1199.106665534174;1225.5587988324196;1238.907081968856;1252.1923359433115;1266.3604879535867;12028.03775697942;12181.51273949041;12236.143469957107;12524.248545087234;12596.370181490889;4868.732219727878;4885.731284779371;4905.3623029006;4979.0788704089855;5046.44489106198;10657.73355666099;10669.78660426787;10676;10757.623483178208;10776.946115269373;5529.778808847682;5594.524465420403;5595.524380427709;5605.8037968671715;5605.943940560543;5032.949670503322;5119.129747942859;5124.92312615311;5130.12787826063;5133.435322114565;4026.798660066985;4075.53280818905;4116.835326586903;4146.067134894624;4156.688248381323;1302.1054365897596;1311.5999620115956;1335.5592654424017;1344.919304841693;1356.2947267421084;965.280865755017;1086.4676308608882;1095.4905968724581;1097.4841824342545;1119.6976816259564;6030.396960303934;6067.696615169224;6091.604045737013;6204.503639708812;6215.440610345;492.6477568538512;498.7730582584915;499.7850924102598;501.33072348414544;503.23508267433294;3941.073847645801;3987.840486380512;4061.614146656063;4297.119090586422;4574.6340292776495;10627.202959777893;10845.566177352817;10898.12814974816;10906.5092070857;10944.288621239593;10660.147188224923;10878.564857405774;10990.230683852213;11155.888441115485;11259.549618015188;8230.547319897343;8280.213379729037;8369.49783013021;8382.538960357117;8461.8576492174;5905.291365036223;6125.938740612537;6147;6356.650384228912;6408;9381.484018379055;9449;9597.712068637951;9740.561674724513;9746.9025309746;9697.466639334903;9972.252081094091;10034;10195.643152489627;10218.744531386776;7581.203973582695;7594.734184303523;7647.732329368446;7668.348190403655;7679.808004799925;7936.127026027017;7960.761177164694;7968.721094761656;7986.3610911128135;8000.839983200187;7509.136449308399;7534.623268836646;7581.241875812595;7587.848243035219;7753.5347879125175;7457.291557302047;7460.3658689012045;7545.962270188614;7691.769246922601;7737.845243094994;6921.204061532988;7003.29967003316;7034.788956331318;7035.824104397431;7040.155181378267;5361.731913404392;5403.83788486346;5465.289512363367;5478.45215478449;5512.366077900932;5380.166074258496;5446.319210098738;5478.205660179331;5492.615516913777;5553.028220061392 07:52:09 INFO - PROCESS | 7331 | |4;prototype.html;361.21255662655403;362.8621123972891;363.7635536901014;364.41329459570096;365.10367048894966;6188.133661287423;6226.221722284715;6234.5635805493575;6241.219847519054;6244.937550624492;6118;6129.172561704168;6228.096925945735;6230.221222347207;6248.15649887265;4598.264277715574;4677.83627573035;4733.64497662675;4828.106800241949;4854.56308932196;4801.5438533339275;4821.831235906744;4832.73419961902;4836.758162091881;4837.637177211705;4547.204239258133;4792.83225087122;4799.472058073609;4799.5680388765;4800.5679488846;4671.205894997842;4755.809767609291;4774.522547745198;4780.11567859947;4785.521447855222;4230.238557059728;4235.894102647459;4245.532991370947;4246.723962942398;4248.575142485757;5935.91096133554;5936.287645482526;5942.64344139353;5946.464818166342;5948.97025514874;5591.832245032615;5592.049351610195;5593.468620481048;5594.216809646653;5596.076647353182;6431.970884658479;6558.475321974231;6562.278149403562;6566.63883486408;6566.8358291043105;4722.645801564897;4737;4738.763061846894;4739.526047395268;4756.239001759736;6838.213605435389;6844.178698556156;6845.110135682379;6887.621180835052;6934.930650693529;4848.854534363974;4849.878753031132;4854.514548545118;4860.441049279308;4866.367372241657;4888.193448081027;4913.705177689279;4914.434839993375;4915.459299477055;4919.631027672939;5584.664920104807;5585.636933599303;5590.077637189818;5590.273264475673;5590.608657394025;6472.190976127984;6631.370019848203;6635.900461493082;6649.401553860176;6651.16860392451;1706.3771723321147;1709.3248166974224;1715.322447633178;1718.037898776689;1718.2010365180251;1091.1816137896578;1144.1133121830649;1155.6879642496478;1161.1929708852267;1172.4137931034484;6263.185785847811;6270.7805226816845;6273.1844860167885;6275.152854364694;6277.96861015692;6687.164104486939;6705.228898676617;6705.530612857053;6721.092652491851;6722.529422940347;6244.375562443719;6250.406211409909;6255.6872156392;6266.154069200599;6267.2165979252595;3589.2462582857893;3620.25784714133;3622.3298689741955;3623.0761155905075;3623.565172179355;6799.524033317719;7005.439564834801;7014.894776578355;7032.789016329519;7033.120859892513;6831.248562658104;6858.759943401957;6863.039174515572;6867.759628412981;6874.725010999504;6990.26602206761;6993.825154371079;7005.92994070063;7009.228984811667;7012.5792452453015;6688.598684078971;6698.66506674674;6707.899381509379;6720.865582688221;6721.495887808336;6572.8356791080605;6669.633170175687;6827.1807383112355;6833.69248383814;6837.3162683731225;7150.64246787669;7161.641917904188;7161.820954476179;7175.712971481083;7191.316824901626;4701.835435759732;4741.9051618968115;4746.264329029006;4750.857474275777;4752;6868.622225777431;6871.690773915086;6876.071730316343;6878.965605171942;6882.8623427532175;6422.197225346832;6675.098861653809;6679.499037572299;6683.231428385603;6706.094677218513;6632.50256230775;6691.5315927884585;6696;6698.095757072733;6701.0953521274005;6568.507361947777;6568.507361947777;6582.045603387578;6583.572067815577;6595.8021259362295;6728.529002969745;6731.461483081243;6735.932640673531;6749.055132281386;6783.152105986752;6172.969135154475;6361.045843123568;6572.605643661395;6588.868222635616;6606.174228221473 07:52:09 INFO - PROCESS | 7331 | |5;yui.html;892.5983307511617;897.6902968475875;943.1841457139572;957.5690939077417;968.2883080935516;13436.52972145975;13500.2574858383;13586.320683965812;13621.65945851353;14725.484608038707;12808.871911280885;13889.652758681039;13917.443302267922;13978.161310321388;14013.15921044738;907.3376435202306;929.6606738540418;937.4984383354906;938.6339327662183;938.9108034736689;901.995490022549;911.6581282019242;915.2266334946959;915.50562696144;917.2799352508282;971.1599466461495;976.0581039297077;976.5361453309656;976.8778902637171;977.1157102821958;963.2823546457863;968.3221744778683;968.728755948332;969.4038166527605;969.6654654144309;712.3588770106893;712.654362634122;713.728783062433;714.125196634119;714.4962801225124;13024.283664398454;13179.472821087145;13197.076204665676;13232.206067635972;13238;13006.674833129153;13077.934610326982;13080.869191308155;13104.344782760823;13150.674016861622;10679.41263230522;10752.139828813755;10755.354678719224;10914.072303854182;11068.778624427467;3551.5738111426795;3671.0638787109115;3684.871029513981;3686.299603075407;3744.962550374516;45354.31968520475;54041.189382158904;55664.72167639136;55722.16416753752;55808.76764929398;10890.074343680717;11052.723681908017;11151.163662725328;11163.553457861757;11272.661820145244;20798.58402831935;20831;20840.436967227517;20857.68713469299;20884.895575522027;8521.318294536422;8591.398602097917;8617.655293788179;8672;8937.642494300286;4636.188666983265;4680.180968330528;4977.502249774993;5010.173321401928;5015.971725796203;3659.7621154624862;3707.443883417509;3709.221063576679;3709.8330575124182;3711.1278849470355;671.2314400011959;674.0596867369991;680.2007641021878;683.723092147681;693.0574418790441;614.7725341623628;672.2873753820868;695.8712638161957;697.5849369625065;700.5341447937167;9096.727098187064;9706.660266890765;9706.70879873605;9898.505074746234;9900.950495247478;580.3859318418589;596.1207219351509;703.3002162848;717.4905816870081;723.0383589825519;4241.830326786894;4320.805563749639;4331;4490.079533695584;4491.528389519053;62854.68572657107;64484.35515644877;64873.67563162154;64984.67507662431;65035.34964650293;47412.52587474081;51140.74429627828;56269.43730562724;56645;57605;44864.55135448604;45127;45227;48385.27422088671;48627.75686121618;9126.406783559047;9364.484953327632;9421.29340299494;9765.316427850266;10015.69952901414;38370.616293836705;39014.36349700867;39046.80476597599;39071;39736.2052758949;46820.7658961703;49598.50401496083;50161.99352026024;50581;50997.49002510076;12240.816387754012;12403;12554.937225313815;12630.557930472389;12740.362981850685;12959.416826242654;12973.993392781664;13419.530316438877;13442.126261792951;13580.93209533946;12592.489596472295;12846.614601561969;12871.613851584467;13114.344282786013;13191.736165276832;12911.869541525542;12942.80585791195;12951.740965180832;13136.802947955597;13402.396892139683;12857.164284321489;12893.613191604267;13331.600051998455;13449.663758406117;13457.865421346052;10664.306820056672;10889.509972051119;10987.340759554452;11312.830307545559;11439.428028598702;10324.793504130026;10534.841977370499;10922.29005114665;10979.945100274448;10982.121430285717 07:52:09 INFO - PROCESS | 7331 | __end_tp_report 07:52:09 INFO - PROCESS | 7331 | __start_cc_report 07:52:09 INFO - PROCESS | 7331 | _x_x_mozilla_cycle_collect,860 07:52:09 INFO - PROCESS | 7331 | __end_cc_report 07:52:09 INFO - PROCESS | 7331 | __startTimestamp1469026329004__endTimestamp 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | ------- Summary: start ------- 07:52:09 INFO - PROCESS | 7331 | Number of tests: 6 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | [#0] dojo.html Cycles:165 Average:5608.06 Median:5886.97 stddev:608.34 (10.3%) stddev-sans-first:583.27 07:52:09 INFO - PROCESS | 7331 | Values: 3326.0 3405.1 3423.8 3439.2 3445.0 5656.8 5664.9 5680.1 5704.2 5708.4 5672.3 5708.5 5714.5 5716.1 5716.7 5069.7 5151.1 5275.7 5304.4 5331.6 5115.8 5157.7 5197.9 5201.6 5203.0 5155.8 5157.8 5238.1 5252.9 5272.4 5240.9 5267.8 5267.9 5273.2 5304.8 5061.7 5107.8 5142.1 5177.2 5184.0 5560.1 5608.1 5627.5 5629.6 5636.1 5988.6 5990.1 5990.8 5992.4 5995.3 6006.3 6047.5 6056.5 6087.6 6096.1 5529.8 5580.3 5582.6 5596.8 5622.4 6050.3 6053.1 6061.7 6076.8 6103.0 5934.7 5937.9 5982.5 5993.2 5999.9 5983.8 5988.6 5991.2 5992.3 6004.1 5903.3 5949.2 5953.4 5981.4 6094.4 5877.5 5952.3 5956.1 5968.0 5996.1 4560.4 4564.5 4566.6 4589.4 4596.4 4110.1 4112.8 4121.8 4126.1 4171.5 5538.0 5561.2 5562.3 5564.7 5609.4 5954.5 5956.8 5957.2 5960.2 5979.9 5556.1 5561.2 5672.4 5708.4 5723.1 5120.5 5132.2 5132.8 5133.1 5153.4 6144.2 6160.7 6181.0 6182.8 6196.6 5894.5 6098.4 6148.1 6148.9 6150.5 6158.0 6161.0 6163.2 6168.4 6172.3 5843.5 5847.6 5853.9 5901.6 5903.1 6074.3 6111.0 6116.4 6136.0 6137.3 5912.9 5915.0 5918.6 5921.8 5929.1 5790.2 5887.0 5934.9 5937.8 5973.5 5872.0 5891.6 5902.6 5904.8 5942.0 6007.3 6016.0 6022.8 6025.0 6028.8 5717.6 5895.9 5905.6 5922.8 5939.9 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | [#1] ext.html Cycles:180 Average:55121.08 Median:40458.79 stddev:97384.97 (240.7%) stddev-sans-first:97572.33 07:52:09 INFO - PROCESS | 7331 | Values: 666.8 678.4 679.9 752.8 759.8 31906.0 40458.2 41435.4 41561.4 41563.4 44175.1 44550.6 44683.3 44773.6 44864.0 8751.4 8926.6 8927.2 8930.5 8934.9 8760.0 8950.7 8951.9 8957.1 8958.9 9129.4 9195.4 9196.9 9201.6 9206.1 9093.5 9131.5 9135.7 9142.1 9152.0 8906.8 8936.0 9006.6 9022.2 9022.7 43358.0 43980.8 43997.3 44109.8 44129.3 3908.8 3957.8 3976.4 4142.5 4552.5 33106.5 33465.8 33791.0 33941.7 35335.3 4466.8 4486.7 4548.2 4568.7 4632.6 317307.0 319227.0 320118.0 320524.0 321327.0 62256.4 63256.0 63308.0 63348.7 63372.0 71220.6 71749.6 71963.6 72047.3 72101.6 19347.2 19456.5 19549.7 19573.7 19579.2 15053.5 15079.8 15131.5 15138.5 15143.5 20506.1 20690.0 20708.6 20740.4 21532.6 7640.7 7645.4 7775.8 7862.4 7866.6 1127.6 1153.3 1189.4 1200.3 1302.5 33479.0 33963.7 34190.7 34566.8 34879.7 1216.7 1221.9 1241.4 1312.3 1354.7 16939.4 17910.6 18049.2 18068.7 18094.4 440616.0 441681.0 448875.0 448958.0 450941.0 62350.7 63181.7 63340.0 63521.0 63577.4 1502.2 1517.1 1533.2 1539.8 1546.3 32751.0 34279.8 34396.0 34399.8 34520.8 54572.5 55380.7 55403.0 55419.7 55529.0 328763.0 331368.0 333268.0 333707.0 334025.0 27091.2 27598.9 27612.4 30698.4 31101.2 34246.0 39954.8 47747.3 47952.3 48291.0 38697.8 39350.8 39909.2 40016.8 40459.4 37987.6 38252.4 38729.6 39613.2 39852.6 42998.4 43663.8 44077.8 44819.0 45420.0 37424.4 38173.0 38325.0 38418.6 38853.2 29628.2 29700.0 29748.6 29811.9 30002.5 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | [#2] jquery.html Cycles:180 Average:28383.96 Median:2117.84 stddev:82136.97 (3878.3%) stddev-sans-first:82340.51 07:52:09 INFO - PROCESS | 7331 | Values: 400.6 440.3 440.7 442.6 451.4 17060.7 19209.5 19255.8 19261.9 19441.8 18774.3 19002.0 19044.1 19123.9 19306.3 4038.2 5267.8 5412.9 5414.2 5733.7 5829.2 5842.7 5858.4 5870.4 5879.9 5698.9 5867.8 5878.9 6014.0 6027.6 5917.2 5941.0 5965.1 5981.4 6003.2 5508.8 5762.6 5777.5 5847.0 5857.2 14496.5 14602.1 14698.6 21883.9 23461.0 2259.4 2522.8 2550.6 2884.7 3054.9 10481.8 10676.3 10678.9 10720.8 10894.1 2017.3 2110.9 2113.7 2114.9 2120.8 72250.0 73975.6 76241.9 76704.6 78074.0 11191.9 11425.1 11469.4 11527.9 11758.4 15662.7 16233.1 16364.2 16366.0 16389.5 8563.6 8644.2 8725.8 8802.2 8815.1 8428.6 8467.3 8500.7 8565.7 8597.7 4868.1 4891.6 4902.8 4915.8 4921.5 1984.7 2018.8 2034.5 2063.7 2073.3 1039.8 1047.4 1103.7 1188.9 1203.9 18441.8 18526.4 18913.5 18926.8 19141.7 1046.4 1068.4 1085.9 1087.4 1125.2 10238.5 10429.6 10726.8 10742.6 10798.8 491358.0 496201.0 504348.0 506517.0 508018.0 56067.4 75569.6 77041.6 78834.6 86186.0 1115.6 1123.8 1127.6 1153.1 1162.6 16282.7 16673.6 16684.2 16873.6 17302.9 36994.6 37757.6 37944.6 38408.8 38456.8 52848.2 53065.5 53127.0 53276.7 53599.5 8989.6 9004.1 9016.9 9158.4 9210.9 12890.7 13035.3 13051.6 13563.7 13768.4 11633.0 11861.7 11883.7 12250.0 12294.3 10942.6 11607.8 11621.8 12181.8 12493.8 6502.4 10203.6 10225.4 12416.6 12500.2 9159.7 9216.4 9346.2 9445.0 9482.1 11635.4 11691.2 11939.8 12036.1 12232.5 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | [#3] mootools.html Cycles:180 Average:5822.86 Median:2768.09 stddev:3215.23 (116.2%) stddev-sans-first:3207.25 07:52:09 INFO - PROCESS | 7331 | Values: 1423.5 1586.5 1599.6 1841.5 1934.6 8292.2 8580.4 8583.3 8584.7 8602.0 8177.7 8348.3 8356.4 8358.8 8360.4 2429.9 2451.1 2454.3 2457.4 2462.4 2377.2 2402.0 2445.3 2456.5 2463.1 2423.0 2458.8 2468.4 2477.9 2485.4 2379.8 2418.4 2447.8 2463.3 2465.6 2390.5 2439.4 2456.0 2457.8 2458.5 7538.6 7686.8 8516.9 8548.4 8550.4 5091.0 5130.3 5172.8 5188.9 5195.4 3653.5 3664.7 3711.7 3716.9 3721.5 1199.1 1225.6 1238.9 1252.2 1266.4 12028.0 12181.5 12236.1 12524.2 12596.4 4868.7 4885.7 4905.4 4979.1 5046.4 10657.7 10669.8 10676.0 10757.6 10776.9 5529.8 5594.5 5595.5 5605.8 5605.9 5032.9 5119.1 5124.9 5130.1 5133.4 4026.8 4075.5 4116.8 4146.1 4156.7 1302.1 1311.6 1335.6 1344.9 1356.3 965.3 1086.5 1095.5 1097.5 1119.7 6030.4 6067.7 6091.6 6204.5 6215.4 492.6 498.8 499.8 501.3 503.2 3941.1 3987.8 4061.6 4297.1 4574.6 10627.2 10845.6 10898.1 10906.5 10944.3 10660.1 10878.6 10990.2 11155.9 11259.5 8230.5 8280.2 8369.5 8382.5 8461.9 5905.3 6125.9 6147.0 6356.7 6408.0 9381.5 9449.0 9597.7 9740.6 9746.9 9697.5 9972.3 10034.0 10195.6 10218.7 7581.2 7594.7 7647.7 7668.3 7679.8 7936.1 7960.8 7968.7 7986.4 8000.8 7509.1 7534.6 7581.2 7587.8 7753.5 7457.3 7460.4 7546.0 7691.8 7737.8 6921.2 7003.3 7034.8 7035.8 7040.2 5361.7 5403.8 5465.3 5478.5 5512.4 5380.2 5446.3 5478.2 5492.6 5553.0 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | [#4] prototype.html Cycles:180 Average:5545.09 Median:6246.55 stddev:1648.22 (26.4%) stddev-sans-first:1606.26 07:52:09 INFO - PROCESS | 7331 | Values: 361.2 362.9 363.8 364.4 365.1 6188.1 6226.2 6234.6 6241.2 6244.9 6118.0 6129.2 6228.1 6230.2 6248.2 4598.3 4677.8 4733.6 4828.1 4854.6 4801.5 4821.8 4832.7 4836.8 4837.6 4547.2 4792.8 4799.5 4799.6 4800.6 4671.2 4755.8 4774.5 4780.1 4785.5 4230.2 4235.9 4245.5 4246.7 4248.6 5935.9 5936.3 5942.6 5946.5 5949.0 5591.8 5592.0 5593.5 5594.2 5596.1 6432.0 6558.5 6562.3 6566.6 6566.8 4722.6 4737.0 4738.8 4739.5 4756.2 6838.2 6844.2 6845.1 6887.6 6934.9 4848.9 4849.9 4854.5 4860.4 4866.4 4888.2 4913.7 4914.4 4915.5 4919.6 5584.7 5585.6 5590.1 5590.3 5590.6 6472.2 6631.4 6635.9 6649.4 6651.2 1706.4 1709.3 1715.3 1718.0 1718.2 1091.2 1144.1 1155.7 1161.2 1172.4 6263.2 6270.8 6273.2 6275.2 6278.0 6687.2 6705.2 6705.5 6721.1 6722.5 6244.4 6250.4 6255.7 6266.2 6267.2 3589.2 3620.3 3622.3 3623.1 3623.6 6799.5 7005.4 7014.9 7032.8 7033.1 6831.2 6858.8 6863.0 6867.8 6874.7 6990.3 6993.8 7005.9 7009.2 7012.6 6688.6 6698.7 6707.9 6720.9 6721.5 6572.8 6669.6 6827.2 6833.7 6837.3 7150.6 7161.6 7161.8 7175.7 7191.3 4701.8 4741.9 4746.3 4750.9 4752.0 6868.6 6871.7 6876.1 6879.0 6882.9 6422.2 6675.1 6679.5 6683.2 6706.1 6632.5 6691.5 6696.0 6698.1 6701.1 6568.5 6568.5 6582.0 6583.6 6595.8 6728.5 6731.5 6735.9 6749.1 6783.2 6173.0 6361.0 6572.6 6588.9 6606.2 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - PROCESS | 7331 | [#5] yui.html Cycles:180 Average:15054.33 Median:4490.80 stddev:17315.39 (385.6%) stddev-sans-first:17331.30 07:52:09 INFO - PROCESS | 7331 | Values: 892.6 897.7 943.2 957.6 968.3 13436.5 13500.3 13586.3 13621.7 14725.5 12808.9 13889.7 13917.4 13978.2 14013.2 907.3 929.7 937.5 938.6 938.9 902.0 911.7 915.2 915.5 917.3 971.2 976.1 976.5 976.9 977.1 963.3 968.3 968.7 969.4 969.7 712.4 712.7 713.7 714.1 714.5 13024.3 13179.5 13197.1 13232.2 13238.0 13006.7 13077.9 13080.9 13104.3 13150.7 10679.4 10752.1 10755.4 10914.1 11068.8 3551.6 3671.1 3684.9 3686.3 3745.0 45354.3 54041.2 55664.7 55722.2 55808.8 10890.1 11052.7 11151.2 11163.6 11272.7 20798.6 20831.0 20840.4 20857.7 20884.9 8521.3 8591.4 8617.7 8672.0 8937.6 4636.2 4680.2 4977.5 5010.2 5016.0 3659.8 3707.4 3709.2 3709.8 3711.1 671.2 674.1 680.2 683.7 693.1 614.8 672.3 695.9 697.6 700.5 9096.7 9706.7 9706.7 9898.5 9901.0 580.4 596.1 703.3 717.5 723.0 4241.8 4320.8 4331.0 4490.1 4491.5 62854.7 64484.4 64873.7 64984.7 65035.3 47412.5 51140.7 56269.4 56645.0 57605.0 44864.6 45127.0 45227.0 48385.3 48627.8 9126.4 9364.5 9421.3 9765.3 10015.7 38370.6 39014.4 39046.8 39071.0 39736.2 46820.8 49598.5 50162.0 50581.0 50997.5 12240.8 12403.0 12554.9 12630.6 12740.4 12959.4 12974.0 13419.5 13442.1 13580.9 12592.5 12846.6 12871.6 13114.3 13191.7 12911.9 12942.8 12951.7 13136.8 13402.4 12857.2 12893.6 13331.6 13449.7 13457.9 10664.3 10889.5 10987.3 11312.8 11439.4 10324.8 10534.8 10922.3 10979.9 10982.1 07:52:09 INFO - PROCESS | 7331 | -------- Summary: end -------- 07:52:09 INFO - PROCESS | 7331 | 07:52:09 INFO - TEST-INFO | 7331: exit 0 07:52:09 INFO - TEST-OK | dromaeo_css | took 1110832ms 07:52:09 INFO - TEST-START | kraken 07:52:09 INFO - operating with platform_type : linux_ 07:52:09 INFO - Initialising browser for kraken test... 07:52:09 INFO - TEST-INFO | started process 7526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevUZ3c/profile http://localhost:42001/getInfo.html) 07:52:13 INFO - PROCESS | 7526 | __metrics Screen width/height:1600/1200 07:52:13 INFO - PROCESS | 7526 | colorDepth:24 07:52:13 INFO - PROCESS | 7526 | Browser inner width/height: 1024/697 07:52:13 INFO - PROCESS | 7526 | __metrics 07:52:14 INFO - PROCESS | 7526 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:52:14 ERROR - PROCESS | 7526 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:52:15 INFO - TEST-INFO | 7526: exit 0 07:52:15 INFO - Browser initialized. 07:52:15 INFO - Running cycle 1/1 for kraken test... 07:52:15 INFO - TEST-INFO | started process 7618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevUZ3c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:27 INFO - PROCESS | 7618 | RSS: Main: 139386880 07:52:27 INFO - PROCESS | 7618 | 07:52:29 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42001/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:30 INFO - PROCESS | 7618 | RSS: Main: 196964352 07:52:30 INFO - PROCESS | 7618 | 07:52:33 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42001/tests/kraken/driver.html?testName=audio-dft) 07:52:33 INFO - PROCESS | 7618 | RSS: Main: 184729600 07:52:33 INFO - PROCESS | 7618 | 07:52:36 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42001/tests/kraken/driver.html?testName=audio-fft) 07:52:37 INFO - PROCESS | 7618 | RSS: Main: 272748544 07:52:37 INFO - PROCESS | 7618 | 07:52:39 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42001/tests/kraken/driver.html?testName=audio-oscillator) 07:52:39 INFO - PROCESS | 7618 | RSS: Main: 180224000 07:52:39 INFO - PROCESS | 7618 | 07:52:41 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:42 INFO - PROCESS | 7618 | RSS: Main: 177643520 07:52:42 INFO - PROCESS | 7618 | 07:52:45 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42001/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:45 INFO - PROCESS | 7618 | RSS: Main: 212668416 07:52:45 INFO - PROCESS | 7618 | 07:52:49 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42001/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:49 INFO - PROCESS | 7618 | RSS: Main: 212459520 07:52:49 INFO - PROCESS | 7618 | 07:52:52 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42001/tests/kraken/driver.html?testName=json-parse-financial) 07:52:53 INFO - PROCESS | 7618 | RSS: Main: 211894272 07:52:53 INFO - PROCESS | 7618 | 07:52:54 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:55 INFO - PROCESS | 7618 | RSS: Main: 191762432 07:52:55 INFO - PROCESS | 7618 | 07:52:57 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:57 INFO - PROCESS | 7618 | RSS: Main: 196960256 07:52:57 INFO - PROCESS | 7618 | 07:52:59 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:53:00 INFO - PROCESS | 7618 | RSS: Main: 209158144 07:53:00 INFO - PROCESS | 7618 | 07:53:02 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:53:03 INFO - PROCESS | 7618 | RSS: Main: 217251840 07:53:03 INFO - PROCESS | 7618 | 07:53:05 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:53:06 INFO - PROCESS | 7618 | RSS: Main: 212213760 07:53:06 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | Cycle 1(1): loaded http://localhost:42001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42001/tests/kraken/driver.html?testName=ai-astar) 07:53:08 INFO - PROCESS | 7618 | RSS: Main: 274067456 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | __start_tp_report 07:53:08 INFO - PROCESS | 7618 | _x_x_mozilla_page_load 07:53:08 INFO - PROCESS | 7618 | _x_x_mozilla_page_load_details 07:53:08 INFO - PROCESS | 7618 | |i|pagename|runs| 07:53:08 INFO - PROCESS | 7618 | |0;ai-astar;112;112;110;109;111;111;105;110;111;109 07:53:08 INFO - PROCESS | 7618 | |1;audio-beat-detection;152;127;155;181;130;151;154;130;175;125 07:53:08 INFO - PROCESS | 7618 | |2;audio-dft;161;161;161;161;159;160;159;160;161;160 07:53:08 INFO - PROCESS | 7618 | |3;audio-fft;75;74;74;186;77;75;73;77;181;74 07:53:08 INFO - PROCESS | 7618 | |4;audio-oscillator;92;92;150;93;92;91;149;92;92;150 07:53:08 INFO - PROCESS | 7618 | |5;imaging-gaussian-blur;117;118;117;116;117;116;117;117;117;117 07:53:08 INFO - PROCESS | 7618 | |6;imaging-darkroom;145;146;146;146;145;145;145;145;146;145 07:53:08 INFO - PROCESS | 7618 | |7;imaging-desaturate;95;94;95;95;95;95;94;94;94;95 07:53:08 INFO - PROCESS | 7618 | |8;json-parse-financial;54;55;53;54;57;54;56;83;52;53 07:53:08 INFO - PROCESS | 7618 | |9;json-stringify-tinderbox;58;59;59;59;58;58;59;59;57;58 07:53:08 INFO - PROCESS | 7618 | |10;stanford-crypto-aes;72;71;71;80;73;74;74;74;73;74 07:53:08 INFO - PROCESS | 7618 | |11;stanford-crypto-ccm;119;115;112;121;111;112;113;113;134;126 07:53:08 INFO - PROCESS | 7618 | |12;stanford-crypto-pbkdf2;161;154;160;157;159;159;155;155;157;157 07:53:08 INFO - PROCESS | 7618 | |13;stanford-crypto-sha256-iterative;67;67;66;67;65;65;64;65;65;64 07:53:08 INFO - PROCESS | 7618 | __end_tp_report 07:53:08 INFO - PROCESS | 7618 | __start_cc_report 07:53:08 INFO - PROCESS | 7618 | _x_x_mozilla_cycle_collect,1570 07:53:08 INFO - PROCESS | 7618 | __end_cc_report 07:53:08 INFO - PROCESS | 7618 | __startTimestamp1469026388425__endTimestamp 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | ------- Summary: start ------- 07:53:08 INFO - PROCESS | 7618 | Number of tests: 14 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.05 (1.9%) stddev-sans-first:2.05 07:53:08 INFO - PROCESS | 7618 | Values: 112.0 112.0 110.0 109.0 111.0 111.0 105.0 110.0 111.0 109.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.00 stddev:19.85 (13.0%) stddev-sans-first:21.00 07:53:08 INFO - PROCESS | 7618 | Values: 152.0 127.0 155.0 181.0 130.0 151.0 154.0 130.0 175.0 125.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 07:53:08 INFO - PROCESS | 7618 | Values: 161.0 161.0 161.0 161.0 159.0 160.0 159.0 160.0 161.0 160.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#3] audio-fft Cycles:10 Average:96.60 Median:74.50 stddev:45.83 (61.5%) stddev-sans-first:47.94 07:53:08 INFO - PROCESS | 7618 | Values: 75.0 74.0 74.0 186.0 77.0 75.0 73.0 77.0 181.0 74.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:27.86 (30.3%) stddev-sans-first:28.84 07:53:08 INFO - PROCESS | 7618 | Values: 92.0 92.0 150.0 93.0 92.0 91.0 149.0 92.0 92.0 150.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:53:08 INFO - PROCESS | 7618 | Values: 117.0 118.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:53:08 INFO - PROCESS | 7618 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:53:08 INFO - PROCESS | 7618 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:54.50 stddev:9.22 (16.9%) stddev-sans-first:9.71 07:53:08 INFO - PROCESS | 7618 | Values: 54.0 55.0 53.0 54.0 57.0 54.0 56.0 83.0 52.0 53.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 07:53:08 INFO - PROCESS | 7618 | Values: 58.0 59.0 59.0 59.0 58.0 58.0 59.0 59.0 57.0 58.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:2.55 (3.4%) stddev-sans-first:2.64 07:53:08 INFO - PROCESS | 7618 | Values: 72.0 71.0 71.0 80.0 73.0 74.0 74.0 74.0 73.0 74.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:117.00 stddev:7.52 (6.4%) stddev-sans-first:7.95 07:53:08 INFO - PROCESS | 7618 | Values: 119.0 115.0 112.0 121.0 111.0 112.0 113.0 113.0 134.0 126.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.00 stddev:2.32 (1.5%) stddev-sans-first:2.06 07:53:08 INFO - PROCESS | 7618 | Values: 161.0 154.0 160.0 157.0 159.0 159.0 155.0 155.0 157.0 157.0 07:53:08 INFO - PROCESS | 7618 | 07:53:08 INFO - PROCESS | 7618 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.18 (1.8%) stddev-sans-first:1.12 07:53:08 INFO - PROCESS | 7618 | Values: 67.0 67.0 66.0 67.0 65.0 65.0 64.0 65.0 65.0 64.0 07:53:08 INFO - PROCESS | 7618 | -------- Summary: end -------- 07:53:08 INFO - PROCESS | 7618 | 07:53:09 INFO - TEST-INFO | 7618: exit 0 07:53:09 INFO - TEST-OK | kraken | took 59857ms 07:53:09 INFO - SUITE-END | took 1170s 07:53:10 INFO - Completed test suite (00:19:31) 07:53:10 INFO - javascript benchmark 07:53:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.0354497195813, 3405.1487128217946, 3423.845926933288, 3439.2089819341536, 3445.0181698216015, 5656.802011929578, 5664.858378540539, 5680.091185410335, 5704.201411802351, 5708.400617935119, 5672.347680016789, 5708.514776244025, 5714.457126572969, 5716.085426331777, 5716.742746576404, 5069.695818250917, 5151.124308867483, 5275.657082289639, 5304.443033481487, 5331.600129990247, 5115.769790359443, 5157.6647517911215, 5197.87005324868, 5201.557867581241, 5202.973985130069, 5155.81954631588, 5157.793688252485, 5238.083335416287, 5252.921206181911, 5272.393674727398, 5240.8689782755355, 5267.841964741064, 5267.920981185285, 5273.209018647195, 5304.814331498379, 5061.670991385585, 5107.846764597068, 5142.100132476839, 5177.249298851683, 5184.015037142931, 5560.110382338807, 5608.130739735348, 5627.493525582676, 5629.60592758507, 5636.0982242841355, 5988.580799344048, 5990.071538911476, 5990.7903223386975, 5992.4307190817235, 5995.340512543617, 6006.279246490405, 6047.516198704137, 6056.545759068087, 6087.634741915499, 6096.085587161917, 5529.806456773994, 5580.330360356743, 5582.553395728291, 5596.776128954878, 5622.353429355636, 6050.334463209044, 6053.092036194518, 6061.696915154224, 6076.787312444043, 6102.9694851525455, 5934.732937017845, 5937.910931335947, 5982.46157845796, 5993.220881285405, 5999.850003749942, 5983.790567330209, 5988.5508586855285, 5991.221141251609, 5992.34084250732, 6004.0693692477735, 5903.291605007341, 5949.196858424144, 5953.434423729739, 5981.401859813984, 6094.360092190344, 5877.500412464903, 5952.345242023374, 5956.136360227742, 5968.015277479254, 5996.13056106862, 4560.384348113029, 4564.452265728134, 4566.566176213254, 4589.449266088091, 4596.35651008859, 4110.05468742191, 4112.814923328458, 4121.814518346681, 4126.051008268115, 4171.478565179353, 5538.030844602259, 5561.221428999943, 5562.3047119110115, 5564.666120032811, 5609.4390560943575, 5954.46409823118, 5956.821295361059, 5957.195778569924, 5960.195373624505, 5979.910301345483, 5556.055470570012, 5561.249231353796, 5672.376038635747, 5708.431205957336, 5723.055695810228, 5120.462351453119, 5132.178851383761, 5132.820351287687, 5133.076046311625, 5153.407358153785, 6144.2319710036245, 6160.661163636043, 6181.041938499539, 6182.752689892444, 6196.566240363221, 5894.528437724972, 6098.420650038239, 6148.108524263867, 6148.877022459616, 6150.507959363151, 6157.96921015392, 6161.045038019114, 6163.167972323679, 6168.35232300602, 6172.321044685171, 5843.474087332161, 5847.619904706181, 5853.94146058534, 5901.645901245939, 5903.144044113666, 6074.271087469532, 6111.014442317695, 6116.396640261158, 6136.028952951454, 6137.3248942617165, 5912.852178695567, 5914.970425147847, 5918.615290006136, 5921.822345329647, 5929.140274660236, 5790.247267855152, 5886.970565147147, 5934.9109763354445, 5937.762489500372, 5973.49225315853, 5871.970640146772, 5891.58758886891, 5902.6458412495385, 5904.793332233351, 5942.049272116441, 6007.339192688713, 6015.969920150371, 6022.759089636365, 6025.0, 6028.758849645965, 5717.628354157133, 5895.911561326498, 5905.616134951386, 5922.822315330547, 5939.91090133657], "value": 5569.181158069189, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.8466252761865, 678.4335080208027, 679.9087464619283, 752.7967448788827, 759.8024513626456, 31905.99999999997, 40458.19083618326, 41435.37846932298, 41561.376579351294, 41563.376549351706, 44175.116497670024, 44550.55449445505, 44683.329750053774, 44773.552264477345, 44864.0, 8751.3874028818, 8926.553672316391, 8927.151920567536, 8930.46417214966, 8934.910650893506, 8760.0, 8950.731478055635, 8951.910480895205, 8957.059508751585, 8958.910410895905, 9129.406588571755, 9195.356325057248, 9196.908030919672, 9201.631934722604, 9206.125418085272, 9093.454392736458, 9131.543422828898, 9135.680251191176, 9142.085791420872, 9152.0, 8906.821863562758, 8936.0, 9006.639734410615, 9022.233110185642, 9022.729318120468, 43358.0, 43980.78009609963, 43997.34003989943, 44109.77945110286, 44129.33805992913, 3908.8045597720284, 3957.841686332572, 3976.443297938291, 4142.46148000758, 4552.499225085238, 33106.50340244898, 33465.83267083673, 33791.0, 33941.6605833941, 35335.293294133975, 4466.798994045275, 4486.7083639563325, 4548.158590660738, 4568.70303430276, 4632.606228470584, 317307.0, 319227.0, 320118.0, 320524.0, 321327.0, 62256.377436225965, 63256.0, 63308.0, 63348.68325658342, 63372.0, 71220.64389678018, 71749.64125179446, 71963.6401817998, 72047.2795272051, 72101.63949180221, 19347.226110955686, 19456.513587160433, 19549.706754398696, 19573.706394404096, 19579.216831326587, 15053.548393548212, 15079.773803392738, 15131.47039853622, 15138.545843624708, 15143.469978550698, 20506.07722652484, 20690.0, 20708.58582828335, 20740.377788666363, 21532.56934861294, 7640.662883995278, 7645.426593005547, 7775.844483110306, 7862.449628526063, 7866.6066696666085, 1127.5997021057572, 1153.2849633227286, 1189.3993533265646, 1200.255841378351, 1302.5310888080282, 33479.0, 33963.66036339654, 34190.658093418744, 34566.82716586401, 34879.651203488145, 1216.6958260434892, 1221.8961388282096, 1241.3979220078254, 1312.3044786263297, 1354.6545630864066, 16939.407120750962, 17910.5522361942, 18049.187786549635, 18068.728969065476, 18094.3666971658, 440616.0, 441681.0, 448875.0, 448958.0, 450941.0, 62350.68824655938, 63181.68409157925, 63340.04989925155, 63521.04718429227, 63577.36422635807, 1502.1587910770004, 1517.0670037926595, 1533.1950725869008, 1539.8460153984288, 1546.2577962578025, 32751.0, 34279.82860085684, 34396.0, 34399.82800085984, 34520.82739586286, 54572.45427545674, 55380.72309638426, 55403.0, 55419.72290138685, 55529.0, 328763.0, 331368.0, 333268.0, 333707.0, 334025.0, 27091.1872643821, 27598.862005690647, 27612.447751045267, 30698.386032279675, 31101.222469438446, 34246.0, 39954.80022599985, 47747.28379074247, 47952.28071578999, 48291.0, 38697.80651096727, 39350.80324598359, 39909.20181596294, 40016.79991600024, 40459.39310910398, 37987.620123798406, 38252.426213607374, 38729.612703873725, 39613.207735844546, 39852.60147398489, 42998.35502467528, 43663.781681091394, 44077.779611103026, 44819.0, 45420.0, 37424.43863341997, 38173.0, 38325.0, 38418.615813841505, 38853.22293554169, 29628.23211661389, 29700.0, 29748.55377169301, 29811.850940745157, 30002.549961750155], "value": 20921.21347594982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.62341399084875, 440.29332920662335, 440.68270844991616, 442.55081092690915, 451.35730299098776, 17060.65878682427, 19209.519762005955, 19255.807441925575, 19261.90369048153, 19441.805581944176, 18774.342897998573, 19002.0, 19044.14301356439, 19123.904380478078, 19306.324278650216, 4038.172174704179, 5267.841964741045, 5412.864678383052, 5414.214938833867, 5733.741981610817, 5829.183914252008, 5842.737076831531, 5858.443447872445, 5870.383609720981, 5879.88240235195, 5698.914516282259, 5867.794627188049, 5878.941210587882, 6014.0, 6027.63834169949, 5917.20117784098, 5940.97029514854, 5965.135055416984, 5981.401859814027, 6003.249593800775, 5508.7521061552325, 5762.625429347121, 5777.508911742507, 5847.0, 5857.179994800731, 14496.492622758153, 14602.050866693631, 14698.55904322872, 21883.890580546995, 23461.0, 2259.378670865509, 2522.848629082261, 2550.60465627828, 2884.67305039682, 3054.862531186102, 10481.842772358421, 10676.306040107369, 10678.893211067867, 10720.78558428835, 10894.128469722482, 2017.3040301096098, 2110.89445527723, 2113.6829475578634, 2114.862533935305, 2120.819730322909, 72250.0, 73975.63012184958, 76241.85637215502, 76704.61647691726, 78074.0, 11191.94404027991, 11425.143114266462, 11469.369184694922, 11527.942360288313, 11758.412079396167, 15662.686746265012, 16233.107179105027, 16364.19993800681, 16366.0, 16389.508314750576, 8563.614637341334, 8644.178803013703, 8725.781855453537, 8802.207801297915, 8815.074417186232, 8428.620712067848, 8467.280281176047, 8500.74497765068, 8565.743027709179, 8597.742067737978, 4868.14807408702, 4891.584215341736, 4902.803887844446, 4915.778789954389, 4921.4832442593015, 1984.6725290327222, 2018.757749070121, 2034.52188735647, 2063.690446433047, 2073.2950796728883, 1039.8076355874186, 1047.3611097230682, 1103.7185517692938, 1188.9167758257013, 1203.9277643341427, 18441.81558184401, 18526.351577694717, 18913.527161821065, 18926.810731892503, 19141.712874306897, 1046.3774054437597, 1068.3803394031443, 1085.9022687958122, 1087.3910610058392, 1125.1842414249768, 10238.488075596191, 10429.634962776267, 10726.785464290671, 10742.624008159833, 10798.838017429745, 491358.0, 496201.0, 504348.0, 506517.0, 508018.0, 56067.43932560704, 75569.62215188889, 77041.6147919268, 78834.6058269705, 86186.0, 1115.6206889657556, 1123.7977164110375, 1127.610974213895, 1153.0602558914459, 1162.581470670558, 16282.67434651324, 16673.583160421087, 16684.165791710122, 16873.578160546083, 17302.91348543249, 36994.630053700195, 37757.622423775414, 37944.620553794106, 38408.807955960045, 38456.80771596236, 52848.20727689165, 53065.46934530605, 53127.0, 53276.73361633167, 53599.464005361006, 8989.640414383352, 9004.099590040943, 9016.86474702893, 9158.358914875895, 9210.861837072316, 12890.67773305675, 13035.283059431822, 13051.608451746462, 13563.660908477366, 13768.380422880795, 11633.0, 11861.703457413289, 11883.702907427038, 12250.0, 12294.323812190416, 10942.562297508011, 11607.76784464289, 11621.76756464883, 12181.756364872475, 12493.75012499763, 6502.4472919800455, 10203.591856325664, 10225.43760093202, 12416.56542021061, 12500.187487813264, 9159.679411220575, 9216.447013179231, 9346.20557252614, 9445.0, 9482.099200575934, 11635.41822908868, 11691.240069395462, 11939.820902686293, 12036.097292702907, 12232.510699571918], "value": 9293.731389220817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.5231197548821, 1586.5002524204874, 1599.6480774229672, 1841.4751795738218, 1934.5550523379632, 8292.212239837221, 8580.442271252365, 8583.313334933206, 8584.742457726263, 8602.0, 8177.713780017701, 8348.29039531639, 8356.415050946436, 8358.791030224247, 8360.372972027091, 2429.8906549205285, 2451.1053465485147, 2454.2514533067406, 2457.4102215468247, 2462.445949661321, 2377.1917548033666, 2401.9639705404434, 2445.254197469771, 2456.5455390752677, 2463.0763463701114, 2422.9636555451684, 2458.7787099161073, 2468.358226861011, 2477.925662230127, 2485.3662316109367, 2379.845310054841, 2418.4316685578874, 2447.7674620910984, 2463.273334366357, 2465.6055031195015, 2390.521895620883, 2439.42673471734, 2455.9754402455924, 2457.8279520433575, 2458.4714286428502, 7538.623068846536, 7686.7693969180455, 8516.8722469163, 8548.358873084482, 8550.358723095731, 5090.9745451272875, 5130.256112863613, 5172.844814655567, 5188.8962220755375, 5195.350581177353, 3653.5433070866143, 3664.6885014773775, 3711.66595006448, 3716.8513259469587, 3721.4603882437164, 1199.106665534174, 1225.5587988324196, 1238.907081968856, 1252.1923359433115, 1266.3604879535867, 12028.03775697942, 12181.51273949041, 12236.143469957107, 12524.248545087234, 12596.370181490889, 4868.732219727878, 4885.731284779371, 4905.3623029006, 4979.0788704089855, 5046.44489106198, 10657.73355666099, 10669.78660426787, 10676.0, 10757.623483178208, 10776.946115269373, 5529.778808847682, 5594.524465420403, 5595.524380427709, 5605.8037968671715, 5605.943940560543, 5032.949670503322, 5119.129747942859, 5124.92312615311, 5130.12787826063, 5133.435322114565, 4026.798660066985, 4075.53280818905, 4116.835326586903, 4146.067134894624, 4156.688248381323, 1302.1054365897596, 1311.5999620115956, 1335.5592654424017, 1344.919304841693, 1356.2947267421084, 965.280865755017, 1086.4676308608882, 1095.4905968724581, 1097.4841824342545, 1119.6976816259564, 6030.396960303934, 6067.696615169224, 6091.604045737013, 6204.503639708812, 6215.440610345, 492.6477568538512, 498.7730582584915, 499.7850924102598, 501.33072348414544, 503.23508267433294, 3941.073847645801, 3987.840486380512, 4061.614146656063, 4297.119090586422, 4574.6340292776495, 10627.202959777893, 10845.566177352817, 10898.12814974816, 10906.5092070857, 10944.288621239593, 10660.147188224923, 10878.564857405774, 10990.230683852213, 11155.888441115485, 11259.549618015188, 8230.547319897343, 8280.213379729037, 8369.49783013021, 8382.538960357117, 8461.8576492174, 5905.291365036223, 6125.938740612537, 6147.0, 6356.650384228912, 6408.0, 9381.484018379055, 9449.0, 9597.712068637951, 9740.561674724513, 9746.9025309746, 9697.466639334903, 9972.252081094091, 10034.0, 10195.643152489627, 10218.744531386776, 7581.203973582695, 7594.734184303523, 7647.732329368446, 7668.348190403655, 7679.808004799925, 7936.127026027017, 7960.761177164694, 7968.721094761656, 7986.3610911128135, 8000.839983200187, 7509.136449308399, 7534.623268836646, 7581.241875812595, 7587.848243035219, 7753.5347879125175, 7457.291557302047, 7460.3658689012045, 7545.962270188614, 7691.769246922601, 7737.845243094994, 6921.204061532988, 7003.29967003316, 7034.788956331318, 7035.824104397431, 7040.155181378267, 5361.731913404392, 5403.83788486346, 5465.289512363367, 5478.45215478449, 5512.366077900932, 5380.166074258496, 5446.319210098738, 5478.205660179331, 5492.615516913777, 5553.028220061392], "value": 4665.02953129264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.21255662655403, 362.8621123972891, 363.7635536901014, 364.41329459570096, 365.10367048894966, 6188.133661287423, 6226.221722284715, 6234.5635805493575, 6241.219847519054, 6244.937550624492, 6118.0, 6129.172561704168, 6228.096925945735, 6230.221222347207, 6248.15649887265, 4598.264277715574, 4677.83627573035, 4733.64497662675, 4828.106800241949, 4854.56308932196, 4801.5438533339275, 4821.831235906744, 4832.73419961902, 4836.758162091881, 4837.637177211705, 4547.204239258133, 4792.83225087122, 4799.472058073609, 4799.5680388765, 4800.5679488846, 4671.205894997842, 4755.809767609291, 4774.522547745198, 4780.11567859947, 4785.521447855222, 4230.238557059728, 4235.894102647459, 4245.532991370947, 4246.723962942398, 4248.575142485757, 5935.91096133554, 5936.287645482526, 5942.64344139353, 5946.464818166342, 5948.97025514874, 5591.832245032615, 5592.049351610195, 5593.468620481048, 5594.216809646653, 5596.076647353182, 6431.970884658479, 6558.475321974231, 6562.278149403562, 6566.63883486408, 6566.8358291043105, 4722.645801564897, 4737.0, 4738.763061846894, 4739.526047395268, 4756.239001759736, 6838.213605435389, 6844.178698556156, 6845.110135682379, 6887.621180835052, 6934.930650693529, 4848.854534363974, 4849.878753031132, 4854.514548545118, 4860.441049279308, 4866.367372241657, 4888.193448081027, 4913.705177689279, 4914.434839993375, 4915.459299477055, 4919.631027672939, 5584.664920104807, 5585.636933599303, 5590.077637189818, 5590.273264475673, 5590.608657394025, 6472.190976127984, 6631.370019848203, 6635.900461493082, 6649.401553860176, 6651.16860392451, 1706.3771723321147, 1709.3248166974224, 1715.322447633178, 1718.037898776689, 1718.2010365180251, 1091.1816137896578, 1144.1133121830649, 1155.6879642496478, 1161.1929708852267, 1172.4137931034484, 6263.185785847811, 6270.7805226816845, 6273.1844860167885, 6275.152854364694, 6277.96861015692, 6687.164104486939, 6705.228898676617, 6705.530612857053, 6721.092652491851, 6722.529422940347, 6244.375562443719, 6250.406211409909, 6255.6872156392, 6266.154069200599, 6267.2165979252595, 3589.2462582857893, 3620.25784714133, 3622.3298689741955, 3623.0761155905075, 3623.565172179355, 6799.524033317719, 7005.439564834801, 7014.894776578355, 7032.789016329519, 7033.120859892513, 6831.248562658104, 6858.759943401957, 6863.039174515572, 6867.759628412981, 6874.725010999504, 6990.26602206761, 6993.825154371079, 7005.92994070063, 7009.228984811667, 7012.5792452453015, 6688.598684078971, 6698.66506674674, 6707.899381509379, 6720.865582688221, 6721.495887808336, 6572.8356791080605, 6669.633170175687, 6827.1807383112355, 6833.69248383814, 6837.3162683731225, 7150.64246787669, 7161.641917904188, 7161.820954476179, 7175.712971481083, 7191.316824901626, 4701.835435759732, 4741.9051618968115, 4746.264329029006, 4750.857474275777, 4752.0, 6868.622225777431, 6871.690773915086, 6876.071730316343, 6878.965605171942, 6882.8623427532175, 6422.197225346832, 6675.098861653809, 6679.499037572299, 6683.231428385603, 6706.094677218513, 6632.50256230775, 6691.5315927884585, 6696.0, 6698.095757072733, 6701.0953521274005, 6568.507361947777, 6568.507361947777, 6582.045603387578, 6583.572067815577, 6595.8021259362295, 6728.529002969745, 6731.461483081243, 6735.932640673531, 6749.055132281386, 6783.152105986752, 6172.969135154475, 6361.045843123568, 6572.605643661395, 6588.868222635616, 6606.174228221473], "value": 5014.139312298552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.5983307511617, 897.6902968475875, 943.1841457139572, 957.5690939077417, 968.2883080935516, 13436.52972145975, 13500.2574858383, 13586.320683965812, 13621.65945851353, 14725.484608038707, 12808.871911280885, 13889.652758681039, 13917.443302267922, 13978.161310321388, 14013.15921044738, 907.3376435202306, 929.6606738540418, 937.4984383354906, 938.6339327662183, 938.9108034736689, 901.995490022549, 911.6581282019242, 915.2266334946959, 915.50562696144, 917.2799352508282, 971.1599466461495, 976.0581039297077, 976.5361453309656, 976.8778902637171, 977.1157102821958, 963.2823546457863, 968.3221744778683, 968.728755948332, 969.4038166527605, 969.6654654144309, 712.3588770106893, 712.654362634122, 713.728783062433, 714.125196634119, 714.4962801225124, 13024.283664398454, 13179.472821087145, 13197.076204665676, 13232.206067635972, 13238.0, 13006.674833129153, 13077.934610326982, 13080.869191308155, 13104.344782760823, 13150.674016861622, 10679.41263230522, 10752.139828813755, 10755.354678719224, 10914.072303854182, 11068.778624427467, 3551.5738111426795, 3671.0638787109115, 3684.871029513981, 3686.299603075407, 3744.962550374516, 45354.31968520475, 54041.189382158904, 55664.72167639136, 55722.16416753752, 55808.76764929398, 10890.074343680717, 11052.723681908017, 11151.163662725328, 11163.553457861757, 11272.661820145244, 20798.58402831935, 20831.0, 20840.436967227517, 20857.68713469299, 20884.895575522027, 8521.318294536422, 8591.398602097917, 8617.655293788179, 8672.0, 8937.642494300286, 4636.188666983265, 4680.180968330528, 4977.502249774993, 5010.173321401928, 5015.971725796203, 3659.7621154624862, 3707.443883417509, 3709.221063576679, 3709.8330575124182, 3711.1278849470355, 671.2314400011959, 674.0596867369991, 680.2007641021878, 683.723092147681, 693.0574418790441, 614.7725341623628, 672.2873753820868, 695.8712638161957, 697.5849369625065, 700.5341447937167, 9096.727098187064, 9706.660266890765, 9706.70879873605, 9898.505074746234, 9900.950495247478, 580.3859318418589, 596.1207219351509, 703.3002162848, 717.4905816870081, 723.0383589825519, 4241.830326786894, 4320.805563749639, 4331.0, 4490.079533695584, 4491.528389519053, 62854.68572657107, 64484.35515644877, 64873.67563162154, 64984.67507662431, 65035.34964650293, 47412.52587474081, 51140.74429627828, 56269.43730562724, 56645.0, 57605.0, 44864.55135448604, 45127.0, 45227.0, 48385.27422088671, 48627.75686121618, 9126.406783559047, 9364.484953327632, 9421.29340299494, 9765.316427850266, 10015.69952901414, 38370.616293836705, 39014.36349700867, 39046.80476597599, 39071.0, 39736.2052758949, 46820.7658961703, 49598.50401496083, 50161.99352026024, 50581.0, 50997.49002510076, 12240.816387754012, 12403.0, 12554.937225313815, 12630.557930472389, 12740.362981850685, 12959.416826242654, 12973.993392781664, 13419.530316438877, 13442.126261792951, 13580.93209533946, 12592.489596472295, 12846.614601561969, 12871.613851584467, 13114.344282786013, 13191.736165276832, 12911.869541525542, 12942.80585791195, 12951.740965180832, 13136.802947955597, 13402.396892139683, 12857.164284321489, 12893.613191604267, 13331.600051998455, 13449.663758406117, 13457.865421346052, 10664.306820056672, 10889.509972051119, 10987.340759554452, 11312.830307545559, 11439.428028598702, 10324.793504130026, 10534.841977370499, 10922.29005114665, 10979.945100274448, 10982.121430285717], "value": 6969.62505258252, "unit": "score"}], "name": "dromaeo_css", "value": 7489.93450549087, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 110.0, 109.0, 111.0, 111.0, 105.0, 110.0, 111.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 155.0, 181.0, 130.0, 151.0, 154.0, 130.0, 175.0, 125.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 159.0, 160.0, 159.0, 160.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 186.0, 77.0, 75.0, 73.0, 77.0, 181.0, 74.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 93.0, 92.0, 91.0, 149.0, 92.0, 92.0, 150.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 57.0, 54.0, 56.0, 83.0, 52.0, 53.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0, 57.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 80.0, 73.0, 74.0, 74.0, 74.0, 73.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 112.0, 121.0, 111.0, 112.0, 113.0, 113.0, 134.0, 126.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 154.0, 160.0, 157.0, 159.0, 159.0, 155.0, 155.0, 157.0, 157.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1510.6999999999998, "alertThreshold": 2.0}]} 07:53:10 INFO - Return code: 0 07:53:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:53:10 ERROR - # TBPL SUCCESS # 07:53:10 INFO - Running post-action listener: _resource_record_post_action 07:53:10 INFO - Running post-run listener: _resource_record_post_run 07:53:11 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 28672; Write bytes: 478801920; Read time: 20; Write time: 577656 07:53:11 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 257433600; Read time: 0; Write time: 380600 07:53:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221061120; Read time: 12; Write time: 197008 07:53:11 INFO - Running post-run listener: _upload_blobber_files 07:53:11 INFO - Blob upload gear active. 07:53:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:53:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:53:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:53:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:12 INFO - (blobuploader) - INFO - Done attempting. 07:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:13 INFO - (blobuploader) - INFO - Done attempting. 07:53:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:53:13 INFO - Return code: 0 07:53:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:53:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:53:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b696136b25f54286b8edf2949a228df181076eecfe8f25acc93f3b3aec4e3f39426cd2c0ebea80011009c0e7b47e742b65db48edbcdecdde255f9fb4a37c0b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa9c368e1bb6c675b7fd5ee94864107ff996ebe3e91bf87eaa6f4bf604f6055ba52fb7b71f9d236e9fb74820d10038066c69a60489d723f000ebed5667055182"} 07:53:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:53:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:53:13 INFO - Contents: 07:53:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b696136b25f54286b8edf2949a228df181076eecfe8f25acc93f3b3aec4e3f39426cd2c0ebea80011009c0e7b47e742b65db48edbcdecdde255f9fb4a37c0b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa9c368e1bb6c675b7fd5ee94864107ff996ebe3e91bf87eaa6f4bf604f6055ba52fb7b71f9d236e9fb74820d10038066c69a60489d723f000ebed5667055182"} 07:53:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:53:13 INFO - Copying logs to upload dir... 07:53:13 INFO - mkdir: /builds/slave/test/build/upload/logs 07:53:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.058099 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-07-20 07:53:13.336262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:53:13.339742) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460 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/9b696136b25f54286b8edf2949a228df181076eecfe8f25acc93f3b3aec4e3f39426cd2c0ebea80011009c0e7b47e742b65db48edbcdecdde255f9fb4a37c0b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa9c368e1bb6c675b7fd5ee94864107ff996ebe3e91bf87eaa6f4bf604f6055ba52fb7b71f9d236e9fb74820d10038066c69a60489d723f000ebed5667055182"} build_url:https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/aygKxcBzTK2HljP58d17-A/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/9b696136b25f54286b8edf2949a228df181076eecfe8f25acc93f3b3aec4e3f39426cd2c0ebea80011009c0e7b47e742b65db48edbcdecdde255f9fb4a37c0b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa9c368e1bb6c675b7fd5ee94864107ff996ebe3e91bf87eaa6f4bf604f6055ba52fb7b71f9d236e9fb74820d10038066c69a60489d723f000ebed5667055182"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:53:13.365153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:53:13.365524) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469025166.530567-1290708460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:53:13.449900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:53:13.450239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:53:13.450571) ========= ========= Total master_lag: 0.17 =========