builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1470333000.47 results: success (0) buildid: 20160804080522 builduid: 0b796fb3a6b84105809eb81b95c591f2 revision: 942d7567e119d48bd129f2850fabe2dd687a0476 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.469585) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.470075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.470374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.485247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.485559) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:50:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.1M=0s 2016-08-04 10:50:00 (89.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.584411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.584710) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017712 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.640834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.641151) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 942d7567e119d48bd129f2850fabe2dd687a0476 --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 942d7567e119d48bd129f2850fabe2dd687a0476 --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=a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:50:00,855 truncating revision to first 12 chars 2016-08-04 10:50:00,855 Setting DEBUG logging. 2016-08-04 10:50:00,855 attempt 1/10 2016-08-04 10:50:00,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/942d7567e119?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:50:01,319 unpacking tar archive at: mozilla-beta-942d7567e119/testing/mozharness/ program finished with exit code 0 elapsedTime=0.801236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:01.456412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:01.456701) ========= script_repo_revision: 942d7567e119d48bd129f2850fabe2dd687a0476 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:01.457092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:01.457368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:01.465934) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 10:50:01.466432) ========= /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=a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:01 INFO - MultiFileLogger online at 20160804 10:50:01 in /builds/slave/test 10:50:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:50:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:01 INFO - {'append_to_log': False, 10:50:01 INFO - 'base_work_dir': '/builds/slave/test', 10:50:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:50:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:01 INFO - 'branch': 'Mozilla-Beta', 10:50:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:01 INFO - 'config_files': ('talos/linux_config.py',), 10:50:01 INFO - 'default_actions': ('clobber', 10:50:01 INFO - 'read-buildbot-config', 10:50:01 INFO - 'download-and-extract', 10:50:01 INFO - 'populate-webroot', 10:50:01 INFO - 'create-virtualenv', 10:50:01 INFO - 'install', 10:50:01 INFO - 'run-tests'), 10:50:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:01 INFO - 'download_minidump_stackwalk': True, 10:50:01 INFO - 'download_symbols': 'ondemand', 10:50:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:01 INFO - 'installer_path': 'installer.exe', 10:50:01 INFO - 'log_level': 'info', 10:50:01 INFO - 'log_name': 'talos', 10:50:01 INFO - 'log_to_console': True, 10:50:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:01 INFO - 'opt_config_files': (), 10:50:01 INFO - 'pip_index': False, 10:50:01 INFO - 'sps_profile': False, 10:50:01 INFO - 'sps_profile_interval': 0, 10:50:01 INFO - 'suite': 'dromaeojs', 10:50:01 INFO - 'system_bits': '32', 10:50:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:01 INFO - 'title': 'talos-linux64-ix-002', 10:50:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:01 INFO - 'use_talos_json': True, 10:50:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:01 INFO - 'work_dir': 'build'} 10:50:01 INFO - ##### 10:50:01 INFO - ##### Running clobber step. 10:50:01 INFO - ##### 10:50:01 INFO - Running pre-action listener: _resource_record_pre_action 10:50:01 INFO - Running main action method: clobber 10:50:01 INFO - rmtree: /builds/slave/test/build 10:50:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:02 INFO - Running post-action listener: _resource_record_post_action 10:50:02 INFO - ##### 10:50:02 INFO - ##### Finished clobber step (success) 10:50:02 INFO - ##### 10:50:02 INFO - ##### 10:50:02 INFO - ##### Running read-buildbot-config step. 10:50:02 INFO - ##### 10:50:02 INFO - Running pre-action listener: _resource_record_pre_action 10:50:02 INFO - Running main action method: read_buildbot_config 10:50:02 INFO - Using buildbot properties: 10:50:02 INFO - { 10:50:02 INFO - "project": "", 10:50:02 INFO - "product": "firefox", 10:50:02 INFO - "script_repo_revision": "production", 10:50:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:50:02 INFO - "repository": "", 10:50:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:50:02 INFO - "buildid": "20160804080522", 10:50:02 INFO - "pgo_build": "True", 10:50:02 INFO - "basedir": "/builds/slave/test", 10:50:02 INFO - "buildnumber": 119, 10:50:02 INFO - "slavename": "talos-linux64-ix-002", 10:50:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:50:02 INFO - "platform": "ubuntu64_hw", 10:50:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:50:02 INFO - "branch": "mozilla-beta", 10:50:02 INFO - "repo_path": "releases/mozilla-beta", 10:50:02 INFO - "revision": "942d7567e119d48bd129f2850fabe2dd687a0476", 10:50:02 INFO - "stage_platform": "linux64-pgo", 10:50:02 INFO - "builduid": "0b796fb3a6b84105809eb81b95c591f2", 10:50:02 INFO - "slavebuilddir": "test" 10:50:02 INFO - } 10:50:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 10:50:02 INFO - Running post-action listener: _resource_record_post_action 10:50:02 INFO - ##### 10:50:02 INFO - ##### Finished read-buildbot-config step (success) 10:50:02 INFO - ##### 10:50:02 INFO - ##### 10:50:02 INFO - ##### Running download-and-extract step. 10:50:02 INFO - ##### 10:50:02 INFO - Running pre-action listener: _resource_record_pre_action 10:50:02 INFO - Running main action method: download_and_extract 10:50:02 INFO - mkdir: /builds/slave/test/build/tests 10:50: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')]} 10:50:02 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:50:04 INFO - Downloaded 1327 bytes. 10:50:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:04 INFO - Using the following test package requirements: 10:50:04 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 10:50:04 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:04 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 10:50:04 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'jsshell-linux-x86_64.zip'], 10:50:04 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:04 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 10:50:04 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 10:50:04 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 10:50:04 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:04 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:04 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:04 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50: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')]} 10:50:04 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:05 INFO - Downloaded 21968842 bytes. 10:50:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:50:07 INFO - Return code: 0 10:50:07 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:07 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:12 INFO - Downloaded 21968842 bytes. 10:50:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:50:14 INFO - Return code: 0 10:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:14 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:50:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:50:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:50:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:50:15 INFO - Downloaded 10833369 bytes. 10:50:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:50:15 INFO - Return code: 0 10:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:15 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:50:17 INFO - Downloaded 55286878 bytes. 10:50:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:17 INFO - mkdir: /builds/slave/test/properties 10:50:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:17 INFO - Contents: 10:50:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:17 INFO - Running post-action listener: _resource_record_post_action 10:50:17 INFO - Running post-action listener: set_extra_try_arguments 10:50:17 INFO - ##### 10:50:17 INFO - ##### Finished download-and-extract step (success) 10:50:17 INFO - ##### 10:50:17 INFO - ##### 10:50:17 INFO - ##### Running populate-webroot step. 10:50:17 INFO - ##### 10:50:17 INFO - Running pre-action listener: _resource_record_pre_action 10:50:17 INFO - Running main action method: populate_webroot 10:50:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:17 INFO - '--tppagecycles', 10:50:17 INFO - '7'], 10:50:17 INFO - 'tests': ['tsvgm']}}, 10:50:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:50:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['damp', 'tps']}, 10:50:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'tests': ['damp', 'tps']}, 10:50:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['dromaeo_dom']}, 10:50:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['a11yr', 10:50:18 INFO - 'ts_paint', 10:50:18 INFO - 'tpaint', 10:50:18 INFO - 'sessionrestore', 10:50:18 INFO - 'sessionrestore_no_auto_restore', 10:50:18 INFO - 'tabpaint']}, 10:50:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:18 INFO - 'ts_paint', 10:50:18 INFO - 'tpaint', 10:50:18 INFO - 'sessionrestore', 10:50:18 INFO - 'sessionrestore_no_auto_restore', 10:50:18 INFO - 'tabpaint']}, 10:50:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:50:18 INFO - 'ts_paint', 10:50:18 INFO - 'tpaint', 10:50:18 INFO - 'sessionrestore', 10:50:18 INFO - 'sessionrestore_no_auto_restore', 10:50:18 INFO - 'tabpaint']}, 10:50:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:50:18 INFO - 'ts_paint', 10:50:18 INFO - 'tpaint', 10:50:18 INFO - 'sessionrestore', 10:50:18 INFO - 'sessionrestore_no_auto_restore', 10:50:18 INFO - 'tabpaint']}, 10:50:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['a11yr', 10:50:18 INFO - 'ts_paint', 10:50:18 INFO - 'tpaint', 10:50:18 INFO - 'sessionrestore', 10:50:18 INFO - 'sessionrestore_no_auto_restore', 10:50:18 INFO - 'tabpaint']}, 10:50:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['a11yr', 10:50:18 INFO - 'ts_paint', 10:50:18 INFO - 'tpaint', 10:50:18 INFO - 'sessionrestore', 10:50:18 INFO - 'sessionrestore_no_auto_restore', 10:50:18 INFO - 'tabpaint']}, 10:50:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['tsvgx', 10:50:18 INFO - 'tsvgr_opacity', 10:50:18 INFO - 'tart', 10:50:18 INFO - 'tscrollx', 10:50:18 INFO - 'cart']}, 10:50:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:18 INFO - 'tsvgr_opacity', 10:50:18 INFO - 'tart', 10:50:18 INFO - 'tscrollx', 10:50:18 INFO - 'cart']}, 10:50:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'talos_options': ['--disable-e10s'], 10:50:18 INFO - 'tests': ['tp5o']}, 10:50:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'tests': ['tp5o']}, 10:50:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'talos_options': ['--disable-e10s', 10:50:18 INFO - '--xperf_path', 10:50:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:18 INFO - 'tests': ['tp5n']}, 10:50:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:18 INFO - 'talos_options': ['--xperf_path', 10:50:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:18 INFO - 'tests': ['tp5n']}}, 10:50:18 INFO - 'talos.zip': {'path': '', 10:50:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:18 INFO - Running post-action listener: _resource_record_post_action 10:50:18 INFO - ##### 10:50:18 INFO - ##### Finished populate-webroot step (success) 10:50:18 INFO - ##### 10:50:18 INFO - ##### 10:50:18 INFO - ##### Running create-virtualenv step. 10:50:18 INFO - ##### 10:50:18 INFO - Running pre-action listener: _resource_record_pre_action 10:50:18 INFO - Running main action method: create_virtualenv 10:50:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:50:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:18 INFO - Using real prefix '/usr' 10:50:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:20 INFO - Installing pip.................done. 10:50:20 INFO - Return code: 0 10:50:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50: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', 'pip>=1.5'] in /builds/slave/test/build 10:50: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 pip>=1.5 10:50:20 INFO - Using env: {'DISPLAY': ':0', 10:50:20 INFO - 'HOME': '/home/cltbld', 10:50:20 INFO - 'LANG': 'en_US.UTF-8', 10:50:20 INFO - 'LANGUAGE': 'en_US:en', 10:50:20 INFO - 'LOGNAME': 'cltbld', 10:50:20 INFO - 'MAIL': '/var/mail/cltbld', 10:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:20 INFO - 'MOZ_NO_REMOTE': '1', 10:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:20 INFO - 'NO_EM_RESTART': '1', 10:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:20 INFO - 'PWD': '/builds/slave/test', 10:50:20 INFO - 'SHELL': '/bin/bash', 10:50:20 INFO - 'SHLVL': '1', 10:50:20 INFO - 'TERM': 'linux', 10:50:20 INFO - 'TMOUT': '86400', 10:50:20 INFO - 'USER': 'cltbld', 10:50:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:20 INFO - '_': '/tools/buildbot/bin/python'} 10:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:50:20 INFO - Cleaning up... 10:50:20 INFO - Return code: 0 10:50:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:50: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 psutil>=3.1.1 10:50:20 INFO - Using env: {'DISPLAY': ':0', 10:50:20 INFO - 'HOME': '/home/cltbld', 10:50:20 INFO - 'LANG': 'en_US.UTF-8', 10:50:20 INFO - 'LANGUAGE': 'en_US:en', 10:50:20 INFO - 'LOGNAME': 'cltbld', 10:50:20 INFO - 'MAIL': '/var/mail/cltbld', 10:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:20 INFO - 'MOZ_NO_REMOTE': '1', 10:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:20 INFO - 'NO_EM_RESTART': '1', 10:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:20 INFO - 'PWD': '/builds/slave/test', 10:50:20 INFO - 'SHELL': '/bin/bash', 10:50:20 INFO - 'SHLVL': '1', 10:50:20 INFO - 'TERM': 'linux', 10:50:20 INFO - 'TMOUT': '86400', 10:50:20 INFO - 'USER': 'cltbld', 10:50:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:20 INFO - '_': '/tools/buildbot/bin/python'} 10:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:21 INFO - Downloading/unpacking psutil>=3.1.1 10:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:23 INFO - Installing collected packages: psutil 10:50:23 INFO - Running setup.py install for psutil 10:50:23 INFO - building 'psutil._psutil_linux' extension 10:50:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:50:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:50:23 INFO - building 'psutil._psutil_posix' extension 10:50:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:50:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:23 INFO - Successfully installed psutil 10:50:23 INFO - Cleaning up... 10:50:23 INFO - Return code: 0 10:50:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:50:23 INFO - Using env: {'DISPLAY': ':0', 10:50:23 INFO - 'HOME': '/home/cltbld', 10:50:23 INFO - 'LANG': 'en_US.UTF-8', 10:50:23 INFO - 'LANGUAGE': 'en_US:en', 10:50:23 INFO - 'LOGNAME': 'cltbld', 10:50:23 INFO - 'MAIL': '/var/mail/cltbld', 10:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:23 INFO - 'MOZ_NO_REMOTE': '1', 10:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:23 INFO - 'NO_EM_RESTART': '1', 10:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:23 INFO - 'PWD': '/builds/slave/test', 10:50:23 INFO - 'SHELL': '/bin/bash', 10:50:23 INFO - 'SHLVL': '1', 10:50:23 INFO - 'TERM': 'linux', 10:50:23 INFO - 'TMOUT': '86400', 10:50:23 INFO - 'USER': 'cltbld', 10:50:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:23 INFO - '_': '/tools/buildbot/bin/python'} 10:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:25 INFO - Installing collected packages: mozsystemmonitor 10:50:25 INFO - Running setup.py install for mozsystemmonitor 10:50:25 INFO - Successfully installed mozsystemmonitor 10:50:25 INFO - Cleaning up... 10:50:25 INFO - Return code: 0 10:50:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:25 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:25 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==2.5.1'] in /builds/slave/test/build 10:50:25 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==2.5.1 10:50:25 INFO - Using env: {'DISPLAY': ':0', 10:50:25 INFO - 'HOME': '/home/cltbld', 10:50:25 INFO - 'LANG': 'en_US.UTF-8', 10:50:25 INFO - 'LANGUAGE': 'en_US:en', 10:50:25 INFO - 'LOGNAME': 'cltbld', 10:50:25 INFO - 'MAIL': '/var/mail/cltbld', 10:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:25 INFO - 'MOZ_NO_REMOTE': '1', 10:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:25 INFO - 'NO_EM_RESTART': '1', 10:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:25 INFO - 'PWD': '/builds/slave/test', 10:50:25 INFO - 'SHELL': '/bin/bash', 10:50:25 INFO - 'SHLVL': '1', 10:50:25 INFO - 'TERM': 'linux', 10:50:25 INFO - 'TMOUT': '86400', 10:50:25 INFO - 'USER': 'cltbld', 10:50:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:25 INFO - '_': '/tools/buildbot/bin/python'} 10:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:26 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:28 INFO - warning: no files found matching '*.txt' 10:50:28 INFO - no previously-included directories found matching 'build' 10:50:28 INFO - no previously-included directories found matching 'dist' 10:50:28 INFO - no previously-included directories found matching '.git*' 10:50:28 INFO - Installing collected packages: jsonschema, functools32 10:50:28 INFO - Running setup.py install for functools32 10:50:28 INFO - warning: no files found matching '*.txt' 10:50:28 INFO - no previously-included directories found matching 'build' 10:50:28 INFO - no previously-included directories found matching 'dist' 10:50:28 INFO - no previously-included directories found matching '.git*' 10:50:28 INFO - Successfully installed jsonschema functools32 10:50:28 INFO - Cleaning up... 10:50:28 INFO - Return code: 0 10:50:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:28 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 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:50:28 INFO - Using env: {'DISPLAY': ':0', 10:50:28 INFO - 'HOME': '/home/cltbld', 10:50:28 INFO - 'LANG': 'en_US.UTF-8', 10:50:28 INFO - 'LANGUAGE': 'en_US:en', 10:50:28 INFO - 'LOGNAME': 'cltbld', 10:50:28 INFO - 'MAIL': '/var/mail/cltbld', 10:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:28 INFO - 'MOZ_NO_REMOTE': '1', 10:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:28 INFO - 'NO_EM_RESTART': '1', 10:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:28 INFO - 'PWD': '/builds/slave/test', 10:50:28 INFO - 'SHELL': '/bin/bash', 10:50:28 INFO - 'SHLVL': '1', 10:50:28 INFO - 'TERM': 'linux', 10:50:28 INFO - 'TMOUT': '86400', 10:50:28 INFO - 'USER': 'cltbld', 10:50:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:28 INFO - '_': '/tools/buildbot/bin/python'} 10:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:28 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:30 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:31 INFO - Downloading docopt-0.6.1.tar.gz 10:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:31 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:31 INFO - Running setup.py install for blobuploader 10:50:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:31 INFO - Running setup.py install for requests 10:50:31 INFO - Running setup.py install for docopt 10:50:31 INFO - Successfully installed blobuploader requests docopt 10:50:31 INFO - Cleaning up... 10:50:31 INFO - Return code: 0 10:50:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:31 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 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:50:31 INFO - Using env: {'DISPLAY': ':0', 10:50:31 INFO - 'HOME': '/home/cltbld', 10:50:31 INFO - 'LANG': 'en_US.UTF-8', 10:50:31 INFO - 'LANGUAGE': 'en_US:en', 10:50:31 INFO - 'LOGNAME': 'cltbld', 10:50:31 INFO - 'MAIL': '/var/mail/cltbld', 10:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:31 INFO - 'MOZ_NO_REMOTE': '1', 10:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:31 INFO - 'NO_EM_RESTART': '1', 10:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:31 INFO - 'PWD': '/builds/slave/test', 10:50:31 INFO - 'SHELL': '/bin/bash', 10:50:31 INFO - 'SHLVL': '1', 10:50:31 INFO - 'TERM': 'linux', 10:50:31 INFO - 'TMOUT': '86400', 10:50:31 INFO - 'USER': 'cltbld', 10:50:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:31 INFO - '_': '/tools/buildbot/bin/python'} 10:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:32 INFO - Running setup.py (path:/tmp/pip-9P8KOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:32 INFO - Running setup.py (path:/tmp/pip-Ieg3nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:32 INFO - Running setup.py (path:/tmp/pip-XQU__P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:32 INFO - Running setup.py (path:/tmp/pip-06oAmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:32 INFO - Running setup.py (path:/tmp/pip-RiQ_7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:32 INFO - Running setup.py (path:/tmp/pip-vjRRqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:32 INFO - Running setup.py (path:/tmp/pip-RSZ5wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:32 INFO - Running setup.py (path:/tmp/pip-vuNtLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:32 INFO - Running setup.py (path:/tmp/pip-DCePL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:32 INFO - Running setup.py (path:/tmp/pip-yZ3dKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:32 INFO - Running setup.py (path:/tmp/pip-QGXK0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:32 INFO - Running setup.py (path:/tmp/pip-rzwTOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:33 INFO - Running setup.py (path:/tmp/pip-tAUvPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:33 INFO - Running setup.py (path:/tmp/pip-ItTyGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:33 INFO - Running setup.py (path:/tmp/pip-itEIZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:33 INFO - Running setup.py (path:/tmp/pip-imBaPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:33 INFO - Running setup.py (path:/tmp/pip-xiNdhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:33 INFO - Running setup.py install for manifestparser 10:50:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:33 INFO - Running setup.py install for mozcrash 10:50:33 INFO - Running setup.py install for mozdebug 10:50:33 INFO - Running setup.py install for mozdevice 10:50:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:50:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:50:33 INFO - Running setup.py install for mozfile 10:50:33 INFO - Running setup.py install for mozhttpd 10:50:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for mozinfo 10:50:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for mozInstall 10:50:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for mozleak 10:50:34 INFO - Running setup.py install for mozlog 10:50:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for moznetwork 10:50:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for mozprocess 10:50:34 INFO - Running setup.py install for mozprofile 10:50:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for mozrunner 10:50:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:50:34 INFO - Running setup.py install for mozscreenshot 10:50:34 INFO - Running setup.py install for moztest 10:50:35 INFO - Running setup.py install for mozversion 10:50:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:50:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:50:35 INFO - Cleaning up... 10:50:35 INFO - Return code: 0 10:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 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 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:50:35 INFO - Using env: {'DISPLAY': ':0', 10:50:35 INFO - 'HOME': '/home/cltbld', 10:50:35 INFO - 'LANG': 'en_US.UTF-8', 10:50:35 INFO - 'LANGUAGE': 'en_US:en', 10:50:35 INFO - 'LOGNAME': 'cltbld', 10:50:35 INFO - 'MAIL': '/var/mail/cltbld', 10:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:35 INFO - 'MOZ_NO_REMOTE': '1', 10:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:35 INFO - 'NO_EM_RESTART': '1', 10:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:35 INFO - 'PWD': '/builds/slave/test', 10:50:35 INFO - 'SHELL': '/bin/bash', 10:50:35 INFO - 'SHLVL': '1', 10:50:35 INFO - 'TERM': 'linux', 10:50:35 INFO - 'TMOUT': '86400', 10:50:35 INFO - 'USER': 'cltbld', 10:50:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:35 INFO - '_': '/tools/buildbot/bin/python'} 10:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:35 INFO - Running setup.py (path:/tmp/pip-OtCCj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:35 INFO - Running setup.py (path:/tmp/pip-yqwsEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:35 INFO - Running setup.py (path:/tmp/pip-R0ytji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:35 INFO - Running setup.py (path:/tmp/pip-tae8wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:35 INFO - Running setup.py (path:/tmp/pip-AJ8_9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:35 INFO - Running setup.py (path:/tmp/pip-TW_8xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:35 INFO - Running setup.py (path:/tmp/pip-da3XAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:35 INFO - Running setup.py (path:/tmp/pip-StM6Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:35 INFO - Running setup.py (path:/tmp/pip-T7VXv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:36 INFO - Running setup.py (path:/tmp/pip-HDIv7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:36 INFO - Running setup.py (path:/tmp/pip-TJOm3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:36 INFO - Running setup.py (path:/tmp/pip-P7_Det-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:36 INFO - Running setup.py (path:/tmp/pip-1bLByJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:36 INFO - Running setup.py (path:/tmp/pip-p55rLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:36 INFO - Running setup.py (path:/tmp/pip-Kw28kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:36 INFO - Running setup.py (path:/tmp/pip-IvuSKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:36 INFO - Running setup.py (path:/tmp/pip-uKt41M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:38 INFO - Downloading blessings-1.6.tar.gz 10:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:38 INFO - Installing collected packages: blessings 10:50:38 INFO - Running setup.py install for blessings 10:50:38 INFO - Successfully installed blessings 10:50:38 INFO - Cleaning up... 10:50:38 INFO - Return code: 0 10:50:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:38 INFO - Reading from file tmpfile_stdout 10:50:38 INFO - Current package versions: 10:50:38 INFO - argparse == 1.2.1 10:50:38 INFO - blessings == 1.6 10:50:38 INFO - blobuploader == 1.2.4 10:50:38 INFO - docopt == 0.6.1 10:50:38 INFO - functools32 == 3.2.3-2 10:50:38 INFO - jsonschema == 2.5.1 10:50:38 INFO - manifestparser == 1.1 10:50:38 INFO - mozInstall == 1.12 10:50:38 INFO - mozcrash == 0.17 10:50:38 INFO - mozdebug == 0.1 10:50:38 INFO - mozdevice == 0.48 10:50:38 INFO - mozfile == 1.2 10:50:38 INFO - mozhttpd == 0.7 10:50:38 INFO - mozinfo == 0.9 10:50:38 INFO - mozleak == 0.1 10:50:38 INFO - mozlog == 3.2 10:50:38 INFO - moznetwork == 0.27 10:50:38 INFO - mozprocess == 0.23 10:50:38 INFO - mozprofile == 0.28 10:50:38 INFO - mozrunner == 6.12 10:50:38 INFO - mozscreenshot == 0.1 10:50:38 INFO - mozsystemmonitor == 0.3 10:50:38 INFO - moztest == 0.7 10:50:38 INFO - mozversion == 1.4 10:50:38 INFO - psutil == 3.1.1 10:50:38 INFO - requests == 1.2.3 10:50:38 INFO - wsgiref == 0.1.2 10:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:38 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 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:50:38 INFO - Using env: {'DISPLAY': ':0', 10:50:38 INFO - 'HOME': '/home/cltbld', 10:50:38 INFO - 'LANG': 'en_US.UTF-8', 10:50:38 INFO - 'LANGUAGE': 'en_US:en', 10:50:38 INFO - 'LOGNAME': 'cltbld', 10:50:38 INFO - 'MAIL': '/var/mail/cltbld', 10:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:38 INFO - 'MOZ_NO_REMOTE': '1', 10:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:38 INFO - 'NO_EM_RESTART': '1', 10:50:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:38 INFO - 'PWD': '/builds/slave/test', 10:50:38 INFO - 'SHELL': '/bin/bash', 10:50:38 INFO - 'SHLVL': '1', 10:50:38 INFO - 'TERM': 'linux', 10:50:38 INFO - 'TMOUT': '86400', 10:50:38 INFO - 'USER': 'cltbld', 10:50:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:38 INFO - '_': '/tools/buildbot/bin/python'} 10:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:50:39 INFO - Cleaning up... 10:50:39 INFO - Return code: 0 10:50:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:39 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 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:50:39 INFO - Using env: {'DISPLAY': ':0', 10:50:39 INFO - 'HOME': '/home/cltbld', 10:50:39 INFO - 'LANG': 'en_US.UTF-8', 10:50:39 INFO - 'LANGUAGE': 'en_US:en', 10:50:39 INFO - 'LOGNAME': 'cltbld', 10:50:39 INFO - 'MAIL': '/var/mail/cltbld', 10:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:39 INFO - 'MOZ_NO_REMOTE': '1', 10:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:39 INFO - 'NO_EM_RESTART': '1', 10:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:39 INFO - 'PWD': '/builds/slave/test', 10:50:39 INFO - 'SHELL': '/bin/bash', 10:50:39 INFO - 'SHLVL': '1', 10:50:39 INFO - 'TERM': 'linux', 10:50:39 INFO - 'TMOUT': '86400', 10:50:39 INFO - 'USER': 'cltbld', 10:50:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:39 INFO - '_': '/tools/buildbot/bin/python'} 10:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:50:39 INFO - Cleaning up... 10:50:39 INFO - Return code: 0 10:50:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:39 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 0x7f617c09ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:50:39 INFO - Using env: {'DISPLAY': ':0', 10:50:39 INFO - 'HOME': '/home/cltbld', 10:50:39 INFO - 'LANG': 'en_US.UTF-8', 10:50:39 INFO - 'LANGUAGE': 'en_US:en', 10:50:39 INFO - 'LOGNAME': 'cltbld', 10:50:39 INFO - 'MAIL': '/var/mail/cltbld', 10:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:39 INFO - 'MOZ_NO_REMOTE': '1', 10:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:39 INFO - 'NO_EM_RESTART': '1', 10:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:39 INFO - 'PWD': '/builds/slave/test', 10:50:39 INFO - 'SHELL': '/bin/bash', 10:50:39 INFO - 'SHLVL': '1', 10:50:39 INFO - 'TERM': 'linux', 10:50:39 INFO - 'TMOUT': '86400', 10:50:39 INFO - 'USER': 'cltbld', 10:50:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:39 INFO - '_': '/tools/buildbot/bin/python'} 10:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:39 INFO - Downloading/unpacking flake8 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:50:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:50:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:50:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:50:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:50:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:50:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:50:42 INFO - no previously-included directories found matching 'docs/_build' 10:50:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:50:42 INFO - Running setup.py install for pep8 10:50:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:50:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:50:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:50:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:50:42 INFO - no previously-included directories found matching 'docs/_build' 10:50:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:50:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:50:42 INFO - Cleaning up... 10:50:42 INFO - Return code: 0 10:50:42 INFO - Running post-action listener: _resource_record_post_action 10:50:42 INFO - Running post-action listener: _start_resource_monitoring 10:50:42 INFO - Starting resource monitoring. 10:50:42 INFO - ##### 10:50:42 INFO - ##### Finished create-virtualenv step (success) 10:50:42 INFO - ##### 10:50:42 INFO - ##### 10:50:42 INFO - ##### Running install step. 10:50:42 INFO - ##### 10:50:42 INFO - Running pre-action listener: _resource_record_pre_action 10:50:42 INFO - Running main action method: install 10:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:42 INFO - Reading from file tmpfile_stdout 10:50:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:50:42 INFO - Reading from file tmpfile_stdout 10:50:42 INFO - Output received: 10:50:42 INFO - Usage: mozinstall [options] installer 10:50:42 INFO - Options: 10:50:42 INFO - -h, --help show this help message and exit 10:50:42 INFO - -d DEST, --destination=DEST 10:50:42 INFO - Directory to install application into. [default: 10:50:42 INFO - "/builds/slave/test"] 10:50:42 INFO - --app=APP Application being installed. [default: firefox] 10:50:42 INFO - mkdir: /builds/slave/test/build/application 10:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:50:55 INFO - Reading from file tmpfile_stdout 10:50:55 INFO - Output received: 10:50:55 INFO - /builds/slave/test/build/application/firefox/firefox 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - ##### 10:50:55 INFO - ##### Finished install step (success) 10:50:55 INFO - ##### 10:50:55 INFO - ##### 10:50:55 INFO - ##### Running run-tests step. 10:50:55 INFO - ##### 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: run_tests 10:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:55 INFO - Python 2.7.3 10:50:55 INFO - Return code: 0 10:50:55 INFO - grabbing minidump binary from tooltool 10:50: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')]} 10:50:55 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23972e0>, '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 0x2303140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23035d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:50:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:50:55 INFO - Calling ['/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'] with output_timeout 600 10:50:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:56 INFO - Return code: 0 10:50:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:50:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:50:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:50:56 INFO - Return code: 0 10:50:56 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/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:50:56 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/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:50:56 INFO - Using env: {'DISPLAY': ':0', 10:50:56 INFO - 'HOME': '/home/cltbld', 10:50:56 INFO - 'LANG': 'en_US.UTF-8', 10:50:56 INFO - 'LANGUAGE': 'en_US:en', 10:50:56 INFO - 'LOGNAME': 'cltbld', 10:50:56 INFO - 'MAIL': '/var/mail/cltbld', 10:50:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:56 INFO - 'MOZ_NO_REMOTE': '1', 10:50:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:56 INFO - 'NO_EM_RESTART': '1', 10:50:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:56 INFO - 'PWD': '/builds/slave/test', 10:50:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:56 INFO - 'SHELL': '/bin/bash', 10:50:56 INFO - 'SHLVL': '1', 10:50:56 INFO - 'TERM': 'linux', 10:50:56 INFO - 'TMOUT': '86400', 10:50:56 INFO - 'USER': 'cltbld', 10:50:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987', 10:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:56 INFO - '_': '/tools/buildbot/bin/python'} 10:50:56 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/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:50:57 INFO - mozversion application_buildid: 20160804080522 10:50:57 INFO - mozversion application_changeset: 942d7567e119d48bd129f2850fabe2dd687a0476 10:50:57 INFO - mozversion application_display_name: Firefox 10:50:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:57 INFO - mozversion application_name: Firefox 10:50:57 INFO - mozversion application_remotingname: firefox 10:50:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:50:57 INFO - mozversion application_vendor: Mozilla 10:50:57 INFO - mozversion application_version: 49.0 10:50:57 INFO - mozversion platform_buildid: 20160804080522 10:50:57 INFO - mozversion platform_changeset: 942d7567e119d48bd129f2850fabe2dd687a0476 10:50:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:50:57 INFO - mozversion platform_version: 49.0 10:50:57 INFO - using testdate: 1470333057 10:50:57 INFO - actual date: 1470333057 10:50:57 INFO - starting webserver on 'localhost:49290' 10:50:57 INFO - SUITE-START | Running 2 tests 10:50:57 INFO - TEST-START | dromaeo_css 10:50:57 INFO - operating with platform_type : linux_ 10:50:57 INFO - Initialising browser for dromaeo_css test... 10:50:57 INFO - TEST-INFO | started process 10160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvtpiZ/profile http://localhost:49290/getInfo.html) 10:51:00 INFO - PROCESS | 10160 | __metrics Screen width/height:1600/1200 10:51:00 INFO - PROCESS | 10160 | colorDepth:24 10:51:00 INFO - PROCESS | 10160 | Browser inner width/height: 1024/697 10:51:00 INFO - PROCESS | 10160 | __metrics 10:51:01 INFO - PROCESS | 10160 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:51:01 ERROR - PROCESS | 10160 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:51:02 INFO - TEST-INFO | 10160: exit 0 10:51:02 INFO - Browser initialized. 10:51:02 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:02 INFO - TEST-INFO | started process 10252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvtpiZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:14 INFO - PROCESS | 10252 | RSS: Main: 140947456 10:51:14 INFO - PROCESS | 10252 | 10:52:06 INFO - PROCESS | 10252 | 1470333126190 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:54:14 INFO - PROCESS | 10252 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49290/tests/dromaeo/cssquery-ext.html) 10:54:15 INFO - PROCESS | 10252 | RSS: Main: 254758912 10:54:15 INFO - PROCESS | 10252 | 10:57:17 INFO - PROCESS | 10252 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-ext.html (next: http://localhost:49290/tests/dromaeo/cssquery-jquery.html) 10:57:18 INFO - PROCESS | 10252 | RSS: Main: 226603008 10:57:18 INFO - PROCESS | 10252 | 11:00:20 INFO - PROCESS | 10252 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49290/tests/dromaeo/cssquery-mootools.html) 11:00:20 INFO - PROCESS | 10252 | RSS: Main: 217432064 11:00:20 INFO - PROCESS | 10252 | 11:03:22 INFO - PROCESS | 10252 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49290/tests/dromaeo/cssquery-prototype.html) 11:03:23 INFO - PROCESS | 10252 | RSS: Main: 220602368 11:03:23 INFO - PROCESS | 10252 | 11:06:26 INFO - PROCESS | 10252 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49290/tests/dromaeo/cssquery-yui.html) 11:06:26 INFO - PROCESS | 10252 | RSS: Main: 213782528 11:06:26 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-yui.html (next: http://localhost:49290/tests/dromaeo/cssquery-dojo.html) 11:09:29 INFO - PROCESS | 10252 | RSS: Main: 255844352 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | __start_tp_report 11:09:29 INFO - PROCESS | 10252 | _x_x_mozilla_page_load 11:09:29 INFO - PROCESS | 10252 | _x_x_mozilla_page_load_details 11:09:29 INFO - PROCESS | 10252 | |i|pagename|runs| 11:09:29 INFO - PROCESS | 10252 | |0;dojo.html;3424.298018906123;3456.2223499712554;3458.6541345865407;3468.774529655572;3490.0402389342926;5695.145728140781;5772.422757724225;5778.59549831512;5788.363280039198;5795.3335366432875;5699;5699.344575373833;5743.023685973384;5748.5975981681295;5757.366689664133;4925.08885856116;5133.794648214076;5185.766640501187;5211.035958347698;5250.4487028861995;5112.463191364909;5200.817971371002;5243.2659427680155;5247.370315562138;5249.055170069386;5127.282180494715;5155.948440515603;5175.146100893348;5178.430372659004;5247.029299579571;5253.343332083489;5267.710275934822;5280.841574752763;5282.92075618868;5312.335958005249;4966.925496117561;5054.368203974504;5084.008618319393;5163.870903227412;5178.016176926372;5522.171674248854;5534.308211473566;5543.861403464905;5546.27898373213;5601.775928962837;6127.8357112149;6134.447899689049;6135.9693201534155;6142.04798256271;6147.44672979434;6086.119437974155;6092.268927728656;6116.944513560587;6180.443760061616;6204.937950620481;5746.770129194827;5779.9422005779825;5797.4782269595935;5798.8550286242335;5799.420057994209;6066.064870567369;6290.811275661737;6303;6303.779367722108;6307.211598550181;6018.789342372996;6072.696365181723;6080;6115.021596544531;6116.52178244948;6189.35011823761;6192.349803270592;6193.938060619336;6196.3803619638575;6198.163247961557;5841.44506271912;6048.032314829694;6171.012637977902;6175.567710260329;6176.8764624707255;6107.96946015276;6167.105769663373;6172.382761723792;6177.104319873593;6187.566870319034;4681.063787242565;4721.811127554928;4724.834630787906;4738.407699037621;4764.690295130806;4081.0613558881623;4114.485689288839;4171.666266698657;4223.366495025771;4242.193983143193;5859.912101318484;5865.296164460292;5871.55963302754;5872.471477567039;5900.291964964146;6146.969265153645;6183.567150299526;6199.783007594712;6204.441600255998;6207.720652570645;5609.579281553818;5654.180143879114;5703.458171473703;5725.971370143123;5893.5874488785375;5270.235815806686;5270.657407268515;5271.499207575274;5277.445868183862;5284.233786101071;6346.333634968354;6360.459360954278;6360.681965901779;6368.872622547523;6373.235211774617;5987.072003839412;6091.086337049478;6130.856783744145;6140.078988151813;6196.938030619636;6424.807255782334;6456.257530384066;6468.708908099241;6473.611583305017;6476.805695829133;5834.679092649945;6091.939080609137;6100.633961962297;6113.694315284307;6114.449699527064;6139.676133582418;6164.075388691732;6223.626582405071;6227;6236.532260080603;6067.635941843503;6068;6072.089186622042;6078.756849726138;6110.450059494667;5770.3652598215;5908.05471124618;5959.970200148971;6027.457528822427;6032.758689652364;5872.0898260769645;5930.555208359304;5945.19739835134;5952.434518720715;5987.401259873977;6057.969710151421;6063.43793650247;6092.786752463642;6094.664793436404;6098.695065246809;5728.8567785804025;5841.357450680507;5885.293764748258;5910.231669882888;5924.140999555127 11:09:29 INFO - PROCESS | 10252 | |1;ext.html;595.3153873045997;648.5589798936722;651.3519048546697;652.1359199061242;658.5423130924008;32491.512627310578;35038.47442288364;45597.77201113998;46002;46061;47688.76155619217;48089.759551202194;48196.75901620496;48230.758846205805;48301.75849120758;8135.389845761562;8873.423227490224;9084.182423581877;9093.363464557484;10995.505202265877;10496.737581560485;10642.201834862377;10996.780064398707;11002.33985960841;11070.612528561502;11130.220884538086;11206.327620342765;11207.719807004849;11211.271267367636;11216.439178041106;11004.504797284102;11071.667849964433;11072.944635276852;11077.612283570037;11082.61210857616;10933.507992140372;10999.725006874813;11006.779864402748;11008.669739907735;11008.889911100867;46266.30600540995;46770;46772.532274677156;46805.53194468046;46861.76569117133;3992.640662340403;3994.1013272013565;4025.2955732746946;4027.536833264183;4660.557247061523;36165.819170903975;36386.45420318697;36514.26971460583;36795.448068278994;38146.42780358297;4754.500777418356;4779.371672730521;4809.951900480985;4893.853184404438;4921.608657239398;390941;395227.99999999715;395911;396377;397120;39483.21033579313;40523.39214911779;70673.64663176754;71486.64256678683;71654;40629.39055914163;40730.79634601808;40740;40813.59186408157;40858.182836343105;15233;15265.389384424721;15284.694306113815;15394.076355418487;15413.306401211748;11473.483693233824;12211.877881221251;12341.568045118378;12398.81401778974;12910.225386476654;9502.382345147544;9520.428774273565;9526.333156679104;9551.522423878778;9583.377080489747;3622.873199438007;3623.474596183539;3660.1215708230366;3679.300932822755;3732.832022558937;1082.5994382078682;1114.9442527873573;1130.0959232613875;1152.6196355202762;1155.1509640414288;34163.487547686804;34450.82774586111;34497;34510.30979380399;34966.65033349685;1161.285809227319;1205.9698507537207;1271.3134907150036;1325.0658285908412;1325.2247435250295;17775.644487110185;17928.462146135636;17989.370372036916;18044.639107217783;18201.08994550267;609251;610540;614860;615709;616457;64593.35406645967;65213;65237.67381163064;65291.34708652853;65509.67245163744;1345.6299517632729;1464.8974571780086;1473.630685018924;1474.8967572270053;1503.9022463539834;33941.321173575896;34728;34952.300953981285;34972.82513587517;35976.460353094204;54321;54556.18165727596;54640;54749.45250547444;54865.72567137139;415271;417665;417810;418773;419323;27550.44899102047;31276.530852037693;31343;32032.83983580067;32228;52560.73719631377;53032.46967530275;53150.468495314555;53522.46477535175;53997.46002539925;43786;44850.327245092005;45161.32258016067;45268.54731452643;45932.7703361481;42369;42990.57009429866;47716.52283477259;48021.03957920752;48377.758111209216;45067.54932450633;45375.77312113418;46210.30684539668;46411.53588464207;46722.29916551187;39166.80416597899;39929;40685.97583629232;41276.1744765109;41741.37387939244;30061.398772024873;30845.845770771004;31009.534856976712;31031.53452698166;31085.378292434478 11:09:29 INFO - PROCESS | 10252 | |2;jquery.html;406.605592575202;421.18290516398184;425.1921349436073;427.20326590907956;437.85331913808875;19441.611167776635;20141.496462588442;20662;20678;21074.789252107475;17911.55221119473;18285.90857045713;18966;19116.044197790125;19519.512012199702;5668.546516278698;5897.587168898179;5908.97045514774;5910.67491287979;5913.852153696149;4373;5281.075811732951;5750.281214848144;5886.146508756249;6653.733850645968;6572.408483236508;6700.061991321195;6706.631135287582;6708.932910670879;6727.629980351078;6414.839629009265;6453.645049522274;6575.967120164392;6588.868222635569;6600.273969863311;3895.4156876468473;5538.972305138489;5702.77188912443;5732.31212254528;5886.323072846634;23902.88048559746;23931.88034059836;23998.280051598478;24195.395115122086;24236.63645045308;2629.579267317239;2684.302081458835;3003.459377312083;3204.647488776233;3209.293955329824;7127.964360178218;7161.641917904084;7194.352508274228;7200.783976480714;7425.10898692155;1950.8927009014499;2036.1855257896812;2037.8165965063215;2041.7039529268172;2115.1327955538154;57084.714576427265;83731;84945.57527212324;85959.57020214922;86140.56929715374;10931.125509959184;11490.482928268248;11668.474918628683;12052.216605920587;12082.818757718642;16419.83580164183;16480;16508.83491165097;16560.751588725936;16587.17064146812;8340.87488687658;8551.957240213758;8652.221300082896;8671.653133874574;8715;8235.83528329442;8307.958460207661;8367.539785311867;8451.873221901677;8460.661573536989;7103.715851365888;7133.500654954103;7165.176004759519;7194.892076618855;7306.926930730731;2017.6973453981727;2044.1312442212;2047.62119007984;2089.791020897898;2090.7491101067667;1002.4987506246877;1015.4059874973224;1049.4333060147587;1115.576081089181;1136.710138914588;19568.60862782765;19782.109805058808;20213.292534761214;20299.898500507403;20403.693944590843;1080.184460732158;1105.2539535813294;1121.7812526557243;1134.7049767060623;1134.8865113488584;11299.152563557765;11732.765344693229;11868.050555955502;11895.88104118965;12021.939890300668;489423;502307;508021;513941;518766;51887.481125188264;53041;79424;85267.14732852593;87493.56253218821;1094.518411898762;1096.4791723931069;1113.6881673131536;1114.0307932099126;1124.7300647844622;17647;17913.552161196076;18079.548011299823;18139.909300453943;18322.17550210217;37221.44167837431;38480.80759596184;38977.6102238974;40179.799101004304;40191.397129043675;51554.74222628863;54525.18212226899;54578.72710636421;54586.727066364416;54647.18029229644;9030.096990301181;9087.136722011399;9263.444193348421;9476.857847132436;9581.568829402833;13493.595192144252;13500.864991349961;13642.93178534101;13774.380152892943;13926.651833704238;11783.116266279892;11817.940910295738;12137.757244854876;12488.12583119173;12642.55751048709;11225.382603956534;11327.32036077838;11839.644810655695;12056.457459414523;12547.05897057706;11660.00889924332;12247.693807654523;12351.814722778985;12353.567625133077;12850.164739291917;8211.507309561446;8384.245417912418;8706.259967902799;8892.199702026848;8960.014398416039;9140.908590914005;11548.133889958455;11652.708682282671;11945.402729863647;11956.222845515014 11:09:29 INFO - PROCESS | 10252 | |3;mootools.html;1494.9775753363695;1611.2588209423668;1637.7379619260919;1878.192377277771;1992.4919145617873;8991.370604057718;9318.347715659907;9333.953330233357;9695.951520242406;9709.271804614664;9376.8593471098;9550.570224339905;9555.140037396633;9557.04429557044;9632.325737198398;2406.783389494945;2433.6592876997233;2435.2815919303757;2437.427204606916;2437.4515733959806;2353.964690529635;2401.1955994741784;2439.5974664180476;2439.658447817307;2439.951200975979;2403.2429784617875;2421.2736179146273;2463.15021317646;2465.704115506133;2469.49375378048;2300.608896487601;2313.3175713164655;2318.826088043395;2330.0563271874917;2386.021731090245;2327.8719670418122;2362.870042147681;2368.336865677613;2369.715634123899;2371.8814059297138;8201.30288925442;9010.639574417015;9501.477418741966;9594.328397012212;9594.9520252399;5378.784848606051;5589.860253493654;5601.831945041656;5603.915941260843;5614.578906581982;3483.5645544306963;3569.1255642367787;3633.818309084562;3646.2160635463238;3660.871869484582;1171.2152857585438;1194.6117511808698;1220.920640158387;1238.4798384678368;1243.1919252485866;13146.539871104465;13253.536126235536;13265.734685306239;13292.401841917137;13293.86706132936;4763.893871413164;4771.928421073687;4808.735519546459;4817.590504807061;4855.6115510759055;11180.552777888794;11213.439328033566;11222.55109795599;11222.831657525143;11244.156688248415;5479.397266300703;5510.421405752419;5545.1682247663175;5551.25058117149;5557.3331200256225;4984.180774017457;5073.9746301269;5136.8202112925865;5153.922691159635;5181.689098654093;4106.035081755785;4165.7600632973745;4170.082581831992;4192.140611174702;4200.4959404871615;1261.8738126187309;1265.2471779291307;1274.4456161569747;1281.9615411537668;1294.6116165150418;950.3632566180676;968.5351031504918;968.5544649461327;1034.8551202831609;1065.9893401066045;6410.55126141175;6421.646809425526;6468.288488266287;6500.447461965786;6516.152900122954;475.237244223024;476.3616753550259;478.17992143474106;479.0706030301204;502.74862568715645;3932.7247092703237;4217.219814334297;4395.692301538862;4406.6474682026;4447.2439685253585;11395.202335836411;12103.334316612494;12104.576339828063;12111.515539378326;12120.939395303143;11181.496832642388;11724.120690948213;11734.11994100446;12020.75958480843;12098.758024839453;8831.60257788401;8849.955750221208;8944.284457243404;8997.370184087182;8998.86501702475;6419.390157934989;6544.770933017321;6591.176102987127;6640.236372817188;6704.631245281556;10549.841752373566;10559.472026398804;10615.734606634896;10619.522121504397;10939.507722152362;11139.220254582426;11264.098872090377;11274;11278.718032049264;11406.771864562828;8505;8582.442141261048;8694.434861733967;8696.434731742416;8704.91295087041;8269.09040005587;8438.915610843813;8459.661613535389;9273.489958052372;9315.02192269829;8243.422960392714;8359.623816928131;8365.623546940524;8373.748787536384;8385.58072096405;8116.228958248957;8131.7560473185895;8171.101178870438;8185.836283274421;8284.337253019865;7734.381249500139;7747.845043098993;7793.532388056735;7795.41534384912;7796.493227940393;5490.725463726878;5566.749496272597;5577.2191893135805;5709.029464990878;5710.543156547549;4667.369905062773;5403.864903377447;5652.886942261214;5775.8106226377895;5832.533397328119 11:09:29 INFO - PROCESS | 10252 | |4;prototype.html;325.721646177459;343.7078483289205;343.788570029432;347.0975463794134;349.66606890419644;5515;5563.36021357544;5571.746357069663;5585.218069470272;5614.747336369863;5241.8427447176555;5286;5433.4566543345645;5451.836444906659;5518.310211223597;4213.094184750278;4234.30134027885;4236.131593023439;4250.192463431938;4293.570642935712;4251.8511852085185;4260.978695106535;4284.764337961411;4299.473686841173;4302.41917341158;4003.938956176601;4010.4585880906143;4082.3672330788777;4206.1377417629465;4221.704480686353;4214.452121224222;4221.5567365426805;4227.97886010568;4231.97884010581;4235.9788201058955;3730.365837807552;3731.253749250161;3732.861477249438;3742.850285988557;3749.0692293468887;5105.591552675777;5203.739813009334;5205.24523944026;5206.557442617382;5245.160774276097;4841.8063277468855;4860.222364421711;4868.732219727914;4886.804527818883;4891.951080489185;5618.831435056954;5642.661440313554;5650.943490565124;5654.660720356751;5660.2075709400715;4045.271851066807;4090.4682391288943;4121.835126594932;4122.525909520384;4156.251874662559;5843;5845.269341332333;5869.911951320733;5874.206982057453;5894.587378883522;4265.850695225652;4267.5305716371795;4271.700980931367;4277.101808620162;4285.935710964338;4204.432401625802;4259.3185090386005;4271.3592961055465;4280.76455794928;4311.741295522279;4795.232762757942;4858.344123543347;4862.95137048632;4874.780634871439;4879.706537927169;5625.353084395347;5687.9431205687415;5736.340320863154;5811.418858114239;5819.88360232793;1401.2993503248376;1440.2582669924998;1477.4385733421232;1478.7633978563379;1478.7707905274485;1009.5507499162802;1026.8921763214905;1027.6968294353185;1030.7423144213947;1036.8133735927606;5522.144067669517;5534.007757207402;5554.1391084381985;5565.220869078333;5607.4112218217315;5786.3056433228285;5795.739191736382;5835.153902684087;5854.765809367577;5855.209546711139;5369.597280203922;5530.751116199781;5543.972280138573;5562.805301814417;5668.489835914787;3131.1545882611567;3142.6543080261154;3151.739304278307;3157.778955473095;3163.557102005721;6073.210482637317;6193.4425901669065;6199.473044791153;6216.378362163838;6216.968915155486;5900.1739756434135;5951.791687290924;6035.668038257938;6055.666938318347;6105.053716673922;6113.32753397126;6118.20463339763;6153.923063463965;6158.137860699506;6188.752449902044;5631.971840140773;5891.911621325769;5939.10913362999;5978.206538038484;5991.820245392645;5854.443827836349;5870.236869207147;5886.293644762484;5892.7642894283745;5895.587308888336;5929.407059294209;6174.845628859314;6177.84555386119;6184.196054512884;6225.128482012431;4148.211839750437;4194.769287689206;4207.75871118027;4221.577842215754;4229.53475117743;5911.970440147772;5939;5963.165156877953;5968.2247754794225;5976.551758618034;5612.803551875828;5667.858303542444;5765.279340082489;5795.7254151406005;5818.418158184148;5790.276215473066;5809.331926828469;5817.556626216914;5825.76696932118;5832.737526811219;5609.579281553818;5730.971345143247;5751.223584816164;5756.42435756421;5765.192872997867;5798.652080875161;5810.796622118375;5816.592838501433;5836.766529338949;5852.678102704393;5685.175649530877;5688.516476099412;5708.429157084258;5708.885822283448;5731.799387021434 11:09:29 INFO - PROCESS | 10252 | |5;yui.html;842.9157084291568;854.1458541458542;905.2034209895293;905.6151135767298;915.4324318922268;14641.853581464182;15625.453109141183;16498.42255521057;16765.245563949622;16829.41097061603;14846.1834599097;14927.402903883858;15072.47246346378;15165.848341516581;15378.307976141072;745.8620155271265;878.7978764884049;887.9778005549848;905.3752910491772;911.7447114807832;891.131147131548;899.5906862377602;899.7435730816718;902.9503377314245;903.1329923273665;931.175909320253;931.3015238571072;931.7950050988771;932.6689025395989;934.8924873639517;770.5761830992959;916.4821875640275;936.0452338614643;938.3009657804911;938.558877327655;686.3685409423342;688.4767576641739;691.550492180082;691.5746815708303;692.4218277738045;15740.134292613902;15780.289886955115;15856.52430427089;15874.80938929585;15914.363425462967;15013.69972600542;15485.922570387076;15563.533094007085;15647.452339168074;15856.762148567665;13004;13210.801837972438;13255.734885302336;13292.202467851863;13330.73338533224;4651.279051746985;4735.526447355272;4743.905121897577;4745.1695953208055;4789.592884604813;74847.62576187085;74860.87708684374;74941;76956;78423.6078819608;12295.4467048983;12536.185147965352;12571.245725256515;12636.936815315865;12655.93672031634;22898.65652015221;23071.423214419774;23071.653925191134;23133;23903.7609623905;9084.31867609932;9151.725448236564;9199.310051746146;9209.953950230207;9286;5078.390593128848;5117.130087885069;5120.206368012964;5237.8428647140645;5382.946170538323;3708.6291370862696;3840.135969406917;3843.0584506795453;3846.769193848322;3846.8268927897752;682.754208484945;688.9379955804002;694.2259380790382;694.8853439182478;714.706381449578;629.3989240275525;697.4594689115976;706.5019161491136;709.989350159748;716.7957132217293;9444.338896277332;9607.991160928143;10486.632967846088;10773.78452430947;10890.074343680717;592.6207227374484;633.3603060908515;653.3270731146927;667.8664267146493;686.255412877034;4486.528914463999;4524.53529376606;4538.614217791524;4549.658775591844;4592.67851250416;69346.65326673334;71331.64334178295;78000;106054.46972765241;106317;95758;98586;99989.50005249926;101048;101376.49311753394;68042;90743;91581.54209229044;92809.53595231981;93470.0652993475;8800.515971621622;8966.372353935161;9021.548922553715;9076.273898088006;9137;52441;53985.73007134939;55394.67631942096;55658.72170639121;57117;69019.65490172517;78693.60653196697;79923.60038199772;80041.59979200066;80229;11733.823992640288;11822.645320640395;11905.46425410876;12005.63983080509;12186.2078964867;12411.875881241072;12968.221906685629;13178.472861085449;13373.39819708096;15714.607134821264;14239.715205696035;14693.55919322422;14755.55733328002;15038.62403439879;15097.849021509644;14171.362288696828;15111.017783844014;15160.393584256506;15162.090274583561;15171.772423413437;14594.85405145935;14599.708005840037;14691.11853288806;14795.186264755543;15186.924065379602;12144.75710485803;12381.566645167375;12771.680707982003;13159.47362105505;13190.142640728322;12138.575149869712;12645.304508252135;12738.299393533445;12944.611661650166;13001.934990324988 11:09:29 INFO - PROCESS | 10252 | __end_tp_report 11:09:29 INFO - PROCESS | 10252 | __start_cc_report 11:09:29 INFO - PROCESS | 10252 | _x_x_mozilla_cycle_collect,939 11:09:29 INFO - PROCESS | 10252 | __end_cc_report 11:09:29 INFO - PROCESS | 10252 | __startTimestamp1470334169256__endTimestamp 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | ------- Summary: start ------- 11:09:29 INFO - PROCESS | 10252 | Number of tests: 6 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | [#0] dojo.html Cycles:165 Average:5704.79 Median:5908.05 stddev:646.44 (10.9%) stddev-sans-first:623.17 11:09:29 INFO - PROCESS | 10252 | Values: 3424.3 3456.2 3458.7 3468.8 3490.0 5695.1 5772.4 5778.6 5788.4 5795.3 5699.0 5699.3 5743.0 5748.6 5757.4 4925.1 5133.8 5185.8 5211.0 5250.4 5112.5 5200.8 5243.3 5247.4 5249.1 5127.3 5155.9 5175.1 5178.4 5247.0 5253.3 5267.7 5280.8 5282.9 5312.3 4966.9 5054.4 5084.0 5163.9 5178.0 5522.2 5534.3 5543.9 5546.3 5601.8 6127.8 6134.4 6136.0 6142.0 6147.4 6086.1 6092.3 6116.9 6180.4 6204.9 5746.8 5779.9 5797.5 5798.9 5799.4 6066.1 6290.8 6303.0 6303.8 6307.2 6018.8 6072.7 6080.0 6115.0 6116.5 6189.4 6192.3 6193.9 6196.4 6198.2 5841.4 6048.0 6171.0 6175.6 6176.9 6108.0 6167.1 6172.4 6177.1 6187.6 4681.1 4721.8 4724.8 4738.4 4764.7 4081.1 4114.5 4171.7 4223.4 4242.2 5859.9 5865.3 5871.6 5872.5 5900.3 6147.0 6183.6 6199.8 6204.4 6207.7 5609.6 5654.2 5703.5 5726.0 5893.6 5270.2 5270.7 5271.5 5277.4 5284.2 6346.3 6360.5 6360.7 6368.9 6373.2 5987.1 6091.1 6130.9 6140.1 6196.9 6424.8 6456.3 6468.7 6473.6 6476.8 5834.7 6091.9 6100.6 6113.7 6114.4 6139.7 6164.1 6223.6 6227.0 6236.5 6067.6 6068.0 6072.1 6078.8 6110.5 5770.4 5908.1 5960.0 6027.5 6032.8 5872.1 5930.6 5945.2 5952.4 5987.4 6058.0 6063.4 6092.8 6094.7 6098.7 5728.9 5841.4 5885.3 5910.2 5924.1 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | [#1] ext.html Cycles:180 Average:64042.71 Median:21960.82 stddev:129011.59 (587.5%) stddev-sans-first:129285.55 11:09:29 INFO - PROCESS | 10252 | Values: 595.3 648.6 651.4 652.1 658.5 32491.5 35038.5 45597.8 46002.0 46061.0 47688.8 48089.8 48196.8 48230.8 48301.8 8135.4 8873.4 9084.2 9093.4 10995.5 10496.7 10642.2 10996.8 11002.3 11070.6 11130.2 11206.3 11207.7 11211.3 11216.4 11004.5 11071.7 11072.9 11077.6 11082.6 10933.5 10999.7 11006.8 11008.7 11008.9 46266.3 46770.0 46772.5 46805.5 46861.8 3992.6 3994.1 4025.3 4027.5 4660.6 36165.8 36386.5 36514.3 36795.4 38146.4 4754.5 4779.4 4810.0 4893.9 4921.6 390941.0 395228.0 395911.0 396377.0 397120.0 39483.2 40523.4 70673.6 71486.6 71654.0 40629.4 40730.8 40740.0 40813.6 40858.2 15233.0 15265.4 15284.7 15394.1 15413.3 11473.5 12211.9 12341.6 12398.8 12910.2 9502.4 9520.4 9526.3 9551.5 9583.4 3622.9 3623.5 3660.1 3679.3 3732.8 1082.6 1114.9 1130.1 1152.6 1155.2 34163.5 34450.8 34497.0 34510.3 34966.7 1161.3 1206.0 1271.3 1325.1 1325.2 17775.6 17928.5 17989.4 18044.6 18201.1 609251.0 610540.0 614860.0 615709.0 616457.0 64593.4 65213.0 65237.7 65291.3 65509.7 1345.6 1464.9 1473.6 1474.9 1503.9 33941.3 34728.0 34952.3 34972.8 35976.5 54321.0 54556.2 54640.0 54749.5 54865.7 415271.0 417665.0 417810.0 418773.0 419323.0 27550.4 31276.5 31343.0 32032.8 32228.0 52560.7 53032.5 53150.5 53522.5 53997.5 43786.0 44850.3 45161.3 45268.5 45932.8 42369.0 42990.6 47716.5 48021.0 48377.8 45067.5 45375.8 46210.3 46411.5 46722.3 39166.8 39929.0 40686.0 41276.2 41741.4 30061.4 30845.8 31009.5 31031.5 31085.4 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | [#2] jquery.html Cycles:180 Average:28969.39 Median:2843.88 stddev:83005.12 (2918.7%) stddev-sans-first:83210.27 11:09:29 INFO - PROCESS | 10252 | Values: 406.6 421.2 425.2 427.2 437.9 19441.6 20141.5 20662.0 20678.0 21074.8 17911.6 18285.9 18966.0 19116.0 19519.5 5668.5 5897.6 5909.0 5910.7 5913.9 4373.0 5281.1 5750.3 5886.1 6653.7 6572.4 6700.1 6706.6 6708.9 6727.6 6414.8 6453.6 6576.0 6588.9 6600.3 3895.4 5539.0 5702.8 5732.3 5886.3 23902.9 23931.9 23998.3 24195.4 24236.6 2629.6 2684.3 3003.5 3204.6 3209.3 7128.0 7161.6 7194.4 7200.8 7425.1 1950.9 2036.2 2037.8 2041.7 2115.1 57084.7 83731.0 84945.6 85959.6 86140.6 10931.1 11490.5 11668.5 12052.2 12082.8 16419.8 16480.0 16508.8 16560.8 16587.2 8340.9 8552.0 8652.2 8671.7 8715.0 8235.8 8308.0 8367.5 8451.9 8460.7 7103.7 7133.5 7165.2 7194.9 7306.9 2017.7 2044.1 2047.6 2089.8 2090.7 1002.5 1015.4 1049.4 1115.6 1136.7 19568.6 19782.1 20213.3 20299.9 20403.7 1080.2 1105.3 1121.8 1134.7 1134.9 11299.2 11732.8 11868.1 11895.9 12021.9 489423.0 502307.0 508021.0 513941.0 518766.0 51887.5 53041.0 79424.0 85267.1 87493.6 1094.5 1096.5 1113.7 1114.0 1124.7 17647.0 17913.6 18079.5 18139.9 18322.2 37221.4 38480.8 38977.6 40179.8 40191.4 51554.7 54525.2 54578.7 54586.7 54647.2 9030.1 9087.1 9263.4 9476.9 9581.6 13493.6 13500.9 13642.9 13774.4 13926.7 11783.1 11817.9 12137.8 12488.1 12642.6 11225.4 11327.3 11839.6 12056.5 12547.1 11660.0 12247.7 12351.8 12353.6 12850.2 8211.5 8384.2 8706.3 8892.2 8960.0 9140.9 11548.1 11652.7 11945.4 11956.2 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | [#3] mootools.html Cycles:180 Average:6213.43 Median:4767.91 stddev:3614.77 (75.8%) stddev-sans-first:3607.52 11:09:29 INFO - PROCESS | 10252 | Values: 1495.0 1611.3 1637.7 1878.2 1992.5 8991.4 9318.3 9334.0 9696.0 9709.3 9376.9 9550.6 9555.1 9557.0 9632.3 2406.8 2433.7 2435.3 2437.4 2437.5 2354.0 2401.2 2439.6 2439.7 2440.0 2403.2 2421.3 2463.2 2465.7 2469.5 2300.6 2313.3 2318.8 2330.1 2386.0 2327.9 2362.9 2368.3 2369.7 2371.9 8201.3 9010.6 9501.5 9594.3 9595.0 5378.8 5589.9 5601.8 5603.9 5614.6 3483.6 3569.1 3633.8 3646.2 3660.9 1171.2 1194.6 1220.9 1238.5 1243.2 13146.5 13253.5 13265.7 13292.4 13293.9 4763.9 4771.9 4808.7 4817.6 4855.6 11180.6 11213.4 11222.6 11222.8 11244.2 5479.4 5510.4 5545.2 5551.3 5557.3 4984.2 5074.0 5136.8 5153.9 5181.7 4106.0 4165.8 4170.1 4192.1 4200.5 1261.9 1265.2 1274.4 1282.0 1294.6 950.4 968.5 968.6 1034.9 1066.0 6410.6 6421.6 6468.3 6500.4 6516.2 475.2 476.4 478.2 479.1 502.7 3932.7 4217.2 4395.7 4406.6 4447.2 11395.2 12103.3 12104.6 12111.5 12120.9 11181.5 11724.1 11734.1 12020.8 12098.8 8831.6 8850.0 8944.3 8997.4 8998.9 6419.4 6544.8 6591.2 6640.2 6704.6 10549.8 10559.5 10615.7 10619.5 10939.5 11139.2 11264.1 11274.0 11278.7 11406.8 8505.0 8582.4 8694.4 8696.4 8704.9 8269.1 8438.9 8459.7 9273.5 9315.0 8243.4 8359.6 8365.6 8373.7 8385.6 8116.2 8131.8 8171.1 8185.8 8284.3 7734.4 7747.8 7793.5 7795.4 7796.5 5490.7 5566.7 5577.2 5709.0 5710.5 4667.4 5403.9 5652.9 5775.8 5832.5 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | [#4] prototype.html Cycles:180 Average:4845.60 Median:5549.06 stddev:1430.11 (25.8%) stddev-sans-first:1393.30 11:09:29 INFO - PROCESS | 10252 | Values: 325.7 343.7 343.8 347.1 349.7 5515.0 5563.4 5571.7 5585.2 5614.7 5241.8 5286.0 5433.5 5451.8 5518.3 4213.1 4234.3 4236.1 4250.2 4293.6 4251.9 4261.0 4284.8 4299.5 4302.4 4003.9 4010.5 4082.4 4206.1 4221.7 4214.5 4221.6 4228.0 4232.0 4236.0 3730.4 3731.3 3732.9 3742.9 3749.1 5105.6 5203.7 5205.2 5206.6 5245.2 4841.8 4860.2 4868.7 4886.8 4892.0 5618.8 5642.7 5650.9 5654.7 5660.2 4045.3 4090.5 4121.8 4122.5 4156.3 5843.0 5845.3 5869.9 5874.2 5894.6 4265.9 4267.5 4271.7 4277.1 4285.9 4204.4 4259.3 4271.4 4280.8 4311.7 4795.2 4858.3 4863.0 4874.8 4879.7 5625.4 5687.9 5736.3 5811.4 5819.9 1401.3 1440.3 1477.4 1478.8 1478.8 1009.6 1026.9 1027.7 1030.7 1036.8 5522.1 5534.0 5554.1 5565.2 5607.4 5786.3 5795.7 5835.2 5854.8 5855.2 5369.6 5530.8 5544.0 5562.8 5668.5 3131.2 3142.7 3151.7 3157.8 3163.6 6073.2 6193.4 6199.5 6216.4 6217.0 5900.2 5951.8 6035.7 6055.7 6105.1 6113.3 6118.2 6153.9 6158.1 6188.8 5632.0 5891.9 5939.1 5978.2 5991.8 5854.4 5870.2 5886.3 5892.8 5895.6 5929.4 6174.8 6177.8 6184.2 6225.1 4148.2 4194.8 4207.8 4221.6 4229.5 5912.0 5939.0 5963.2 5968.2 5976.6 5612.8 5667.9 5765.3 5795.7 5818.4 5790.3 5809.3 5817.6 5825.8 5832.7 5609.6 5731.0 5751.2 5756.4 5765.2 5798.7 5810.8 5816.6 5836.8 5852.7 5685.2 5688.5 5708.4 5708.9 5731.8 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - PROCESS | 10252 | [#5] yui.html Cycles:180 Average:20615.40 Median:4767.38 stddev:28144.32 (590.4%) stddev-sans-first:28184.11 11:09:29 INFO - PROCESS | 10252 | Values: 842.9 854.1 905.2 905.6 915.4 14641.9 15625.5 16498.4 16765.2 16829.4 14846.2 14927.4 15072.5 15165.8 15378.3 745.9 878.8 888.0 905.4 911.7 891.1 899.6 899.7 903.0 903.1 931.2 931.3 931.8 932.7 934.9 770.6 916.5 936.0 938.3 938.6 686.4 688.5 691.6 691.6 692.4 15740.1 15780.3 15856.5 15874.8 15914.4 15013.7 15485.9 15563.5 15647.5 15856.8 13004.0 13210.8 13255.7 13292.2 13330.7 4651.3 4735.5 4743.9 4745.2 4789.6 74847.6 74860.9 74941.0 76956.0 78423.6 12295.4 12536.2 12571.2 12636.9 12655.9 22898.7 23071.4 23071.7 23133.0 23903.8 9084.3 9151.7 9199.3 9210.0 9286.0 5078.4 5117.1 5120.2 5237.8 5382.9 3708.6 3840.1 3843.1 3846.8 3846.8 682.8 688.9 694.2 694.9 714.7 629.4 697.5 706.5 710.0 716.8 9444.3 9608.0 10486.6 10773.8 10890.1 592.6 633.4 653.3 667.9 686.3 4486.5 4524.5 4538.6 4549.7 4592.7 69346.7 71331.6 78000.0 106054.5 106317.0 95758.0 98586.0 99989.5 101048.0 101376.5 68042.0 90743.0 91581.5 92809.5 93470.1 8800.5 8966.4 9021.5 9076.3 9137.0 52441.0 53985.7 55394.7 55658.7 57117.0 69019.7 78693.6 79923.6 80041.6 80229.0 11733.8 11822.6 11905.5 12005.6 12186.2 12411.9 12968.2 13178.5 13373.4 15714.6 14239.7 14693.6 14755.6 15038.6 15097.8 14171.4 15111.0 15160.4 15162.1 15171.8 14594.9 14599.7 14691.1 14795.2 15186.9 12144.8 12381.6 12771.7 13159.5 13190.1 12138.6 12645.3 12738.3 12944.6 13001.9 11:09:29 INFO - PROCESS | 10252 | -------- Summary: end -------- 11:09:29 INFO - PROCESS | 10252 | 11:09:29 INFO - TEST-INFO | 10252: exit 0 11:09:29 INFO - TEST-OK | dromaeo_css | took 1112839ms 11:09:29 INFO - TEST-START | kraken 11:09:29 INFO - operating with platform_type : linux_ 11:09:29 INFO - Initialising browser for kraken test... 11:09:29 INFO - TEST-INFO | started process 10447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89oemJ/profile http://localhost:49290/getInfo.html) 11:09:33 INFO - PROCESS | 10447 | __metrics Screen width/height:1600/1200 11:09:33 INFO - PROCESS | 10447 | colorDepth:24 11:09:33 INFO - PROCESS | 10447 | Browser inner width/height: 1024/697 11:09:33 INFO - PROCESS | 10447 | __metrics 11:09:34 INFO - PROCESS | 10447 | 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" 11:09:34 ERROR - PROCESS | 10447 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:09:35 INFO - TEST-INFO | 10447: exit 0 11:09:35 INFO - Browser initialized. 11:09:35 INFO - Running cycle 1/1 for kraken test... 11:09:35 INFO - TEST-INFO | started process 10539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89oemJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:47 INFO - PROCESS | 10539 | RSS: Main: 141119488 11:09:47 INFO - PROCESS | 10539 | 11:09:49 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:50 INFO - PROCESS | 10539 | RSS: Main: 192319488 11:09:50 INFO - PROCESS | 10539 | 11:09:53 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-dft) 11:09:54 INFO - PROCESS | 10539 | RSS: Main: 190443520 11:09:54 INFO - PROCESS | 10539 | 11:09:56 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-fft) 11:09:57 INFO - PROCESS | 10539 | RSS: Main: 277471232 11:09:57 INFO - PROCESS | 10539 | 11:09:59 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator) 11:10:00 INFO - PROCESS | 10539 | RSS: Main: 185724928 11:10:00 INFO - PROCESS | 10539 | 11:10:02 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:02 INFO - PROCESS | 10539 | RSS: Main: 186650624 11:10:02 INFO - PROCESS | 10539 | 11:10:05 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:06 INFO - PROCESS | 10539 | RSS: Main: 220561408 11:10:06 INFO - PROCESS | 10539 | 11:10:09 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:10 INFO - PROCESS | 10539 | RSS: Main: 220332032 11:10:10 INFO - PROCESS | 10539 | 11:10:13 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial) 11:10:13 INFO - PROCESS | 10539 | RSS: Main: 220598272 11:10:13 INFO - PROCESS | 10539 | 11:10:15 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:15 INFO - PROCESS | 10539 | RSS: Main: 198545408 11:10:15 INFO - PROCESS | 10539 | 11:10:17 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:18 INFO - PROCESS | 10539 | RSS: Main: 201711616 11:10:18 INFO - PROCESS | 10539 | 11:10:20 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:20 INFO - PROCESS | 10539 | RSS: Main: 208142336 11:10:20 INFO - PROCESS | 10539 | 11:10:23 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:23 INFO - PROCESS | 10539 | RSS: Main: 209838080 11:10:23 INFO - PROCESS | 10539 | 11:10:26 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:27 INFO - PROCESS | 10539 | RSS: Main: 209817600 11:10:27 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49290/tests/kraken/driver.html?testName=ai-astar) 11:10:28 INFO - PROCESS | 10539 | RSS: Main: 252416000 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | __start_tp_report 11:10:28 INFO - PROCESS | 10539 | _x_x_mozilla_page_load 11:10:28 INFO - PROCESS | 10539 | _x_x_mozilla_page_load_details 11:10:28 INFO - PROCESS | 10539 | |i|pagename|runs| 11:10:28 INFO - PROCESS | 10539 | |0;ai-astar;111;104;112;109;110;111;109;111;111;109 11:10:28 INFO - PROCESS | 10539 | |1;audio-beat-detection;167;124;129;169;123;124;152;136;168;125 11:10:28 INFO - PROCESS | 10539 | |2;audio-dft;161;160;160;159;161;160;159;160;160;160 11:10:28 INFO - PROCESS | 10539 | |3;audio-fft;76;76;75;104;75;76;76;73;108;75 11:10:28 INFO - PROCESS | 10539 | |4;audio-oscillator;84;84;115;84;84;83;117;83;84;119 11:10:28 INFO - PROCESS | 10539 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;116;117;117 11:10:28 INFO - PROCESS | 10539 | |6;imaging-darkroom;146;145;145;146;146;145;145;145;146;146 11:10:28 INFO - PROCESS | 10539 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 11:10:28 INFO - PROCESS | 10539 | |8;json-parse-financial;53;51;51;53;53;55;61;52;53;52 11:10:28 INFO - PROCESS | 10539 | |9;json-stringify-tinderbox;59;68;60;60;60;58;60;59;59;60 11:10:28 INFO - PROCESS | 10539 | |10;stanford-crypto-aes;78;76;76;78;82;77;77;77;119;76 11:10:28 INFO - PROCESS | 10539 | |11;stanford-crypto-ccm;117;118;124;123;116;121;115;140;121;122 11:10:28 INFO - PROCESS | 10539 | |12;stanford-crypto-pbkdf2;156;153;158;155;158;156;158;155;157;152 11:10:28 INFO - PROCESS | 10539 | |13;stanford-crypto-sha256-iterative;61;60;61;62;63;63;60;61;60;61 11:10:28 INFO - PROCESS | 10539 | __end_tp_report 11:10:28 INFO - PROCESS | 10539 | __start_cc_report 11:10:28 INFO - PROCESS | 10539 | _x_x_mozilla_cycle_collect,1558 11:10:28 INFO - PROCESS | 10539 | __end_cc_report 11:10:28 INFO - PROCESS | 10539 | __startTimestamp1470334228959__endTimestamp 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | ------- Summary: start ------- 11:10:28 INFO - PROCESS | 10539 | Number of tests: 14 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.35 11:10:28 INFO - PROCESS | 10539 | Values: 111.0 104.0 112.0 109.0 110.0 111.0 109.0 111.0 111.0 109.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:144.00 stddev:20.09 (14.0%) stddev-sans-first:19.11 11:10:28 INFO - PROCESS | 10539 | Values: 167.0 124.0 129.0 169.0 123.0 124.0 152.0 136.0 168.0 125.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 11:10:28 INFO - PROCESS | 10539 | Values: 161.0 160.0 160.0 159.0 161.0 160.0 159.0 160.0 160.0 160.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:13.03 (17.3%) stddev-sans-first:13.67 11:10:28 INFO - PROCESS | 10539 | Values: 76.0 76.0 75.0 104.0 75.0 76.0 76.0 73.0 108.0 75.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:84.00 stddev:16.11 (19.2%) stddev-sans-first:16.70 11:10:28 INFO - PROCESS | 10539 | Values: 84.0 84.0 115.0 84.0 84.0 83.0 117.0 83.0 84.0 119.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:10:28 INFO - PROCESS | 10539 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:10:28 INFO - PROCESS | 10539 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:10:28 INFO - PROCESS | 10539 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:2.91 (5.5%) stddev-sans-first:3.09 11:10:28 INFO - PROCESS | 10539 | Values: 53.0 51.0 51.0 53.0 53.0 55.0 61.0 52.0 53.0 52.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:2.79 (4.7%) stddev-sans-first:2.92 11:10:28 INFO - PROCESS | 10539 | Values: 59.0 68.0 60.0 60.0 60.0 58.0 60.0 59.0 59.0 60.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:77.00 stddev:13.26 (17.2%) stddev-sans-first:14.00 11:10:28 INFO - PROCESS | 10539 | Values: 78.0 76.0 76.0 78.0 82.0 77.0 77.0 77.0 119.0 76.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.50 stddev:7.12 (5.9%) stddev-sans-first:7.34 11:10:28 INFO - PROCESS | 10539 | Values: 117.0 118.0 124.0 123.0 116.0 121.0 115.0 140.0 121.0 122.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.50 stddev:2.10 (1.3%) stddev-sans-first:2.22 11:10:28 INFO - PROCESS | 10539 | Values: 156.0 153.0 158.0 155.0 158.0 156.0 158.0 155.0 157.0 152.0 11:10:28 INFO - PROCESS | 10539 | 11:10:28 INFO - PROCESS | 10539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.14 (1.9%) stddev-sans-first:1.20 11:10:28 INFO - PROCESS | 10539 | Values: 61.0 60.0 61.0 62.0 63.0 63.0 60.0 61.0 60.0 61.0 11:10:28 INFO - PROCESS | 10539 | -------- Summary: end -------- 11:10:28 INFO - PROCESS | 10539 | 11:10:29 INFO - TEST-INFO | 10539: exit 0 11:10:29 INFO - TEST-OK | kraken | took 59941ms 11:10:29 INFO - SUITE-END | took 1172s 11:10:30 INFO - Completed test suite (00:19:33) 11:10:30 INFO - javascript benchmark 11:10:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.298018906123, 3456.2223499712554, 3458.6541345865407, 3468.774529655572, 3490.0402389342926, 5695.145728140781, 5772.422757724225, 5778.59549831512, 5788.363280039198, 5795.3335366432875, 5699.0, 5699.344575373833, 5743.023685973384, 5748.5975981681295, 5757.366689664133, 4925.08885856116, 5133.794648214076, 5185.766640501187, 5211.035958347698, 5250.4487028861995, 5112.463191364909, 5200.817971371002, 5243.2659427680155, 5247.370315562138, 5249.055170069386, 5127.282180494715, 5155.948440515603, 5175.146100893348, 5178.430372659004, 5247.029299579571, 5253.343332083489, 5267.710275934822, 5280.841574752763, 5282.92075618868, 5312.335958005249, 4966.925496117561, 5054.368203974504, 5084.008618319393, 5163.870903227412, 5178.016176926372, 5522.171674248854, 5534.308211473566, 5543.861403464905, 5546.27898373213, 5601.775928962837, 6127.8357112149, 6134.447899689049, 6135.9693201534155, 6142.04798256271, 6147.44672979434, 6086.119437974155, 6092.268927728656, 6116.944513560587, 6180.443760061616, 6204.937950620481, 5746.770129194827, 5779.9422005779825, 5797.4782269595935, 5798.8550286242335, 5799.420057994209, 6066.064870567369, 6290.811275661737, 6303.0, 6303.779367722108, 6307.211598550181, 6018.789342372996, 6072.696365181723, 6080.0, 6115.021596544531, 6116.52178244948, 6189.35011823761, 6192.349803270592, 6193.938060619336, 6196.3803619638575, 6198.163247961557, 5841.44506271912, 6048.032314829694, 6171.012637977902, 6175.567710260329, 6176.8764624707255, 6107.96946015276, 6167.105769663373, 6172.382761723792, 6177.104319873593, 6187.566870319034, 4681.063787242565, 4721.811127554928, 4724.834630787906, 4738.407699037621, 4764.690295130806, 4081.0613558881623, 4114.485689288839, 4171.666266698657, 4223.366495025771, 4242.193983143193, 5859.912101318484, 5865.296164460292, 5871.55963302754, 5872.471477567039, 5900.291964964146, 6146.969265153645, 6183.567150299526, 6199.783007594712, 6204.441600255998, 6207.720652570645, 5609.579281553818, 5654.180143879114, 5703.458171473703, 5725.971370143123, 5893.5874488785375, 5270.235815806686, 5270.657407268515, 5271.499207575274, 5277.445868183862, 5284.233786101071, 6346.333634968354, 6360.459360954278, 6360.681965901779, 6368.872622547523, 6373.235211774617, 5987.072003839412, 6091.086337049478, 6130.856783744145, 6140.078988151813, 6196.938030619636, 6424.807255782334, 6456.257530384066, 6468.708908099241, 6473.611583305017, 6476.805695829133, 5834.679092649945, 6091.939080609137, 6100.633961962297, 6113.694315284307, 6114.449699527064, 6139.676133582418, 6164.075388691732, 6223.626582405071, 6227.0, 6236.532260080603, 6067.635941843503, 6068.0, 6072.089186622042, 6078.756849726138, 6110.450059494667, 5770.3652598215, 5908.05471124618, 5959.970200148971, 6027.457528822427, 6032.758689652364, 5872.0898260769645, 5930.555208359304, 5945.19739835134, 5952.434518720715, 5987.401259873977, 6057.969710151421, 6063.43793650247, 6092.786752463642, 6094.664793436404, 6098.695065246809, 5728.8567785804025, 5841.357450680507, 5885.293764748258, 5910.231669882888, 5924.140999555127], "value": 5662.2961939465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.3153873045997, 648.5589798936722, 651.3519048546697, 652.1359199061242, 658.5423130924008, 32491.512627310578, 35038.47442288364, 45597.77201113998, 46002.0, 46061.0, 47688.76155619217, 48089.759551202194, 48196.75901620496, 48230.758846205805, 48301.75849120758, 8135.389845761562, 8873.423227490224, 9084.182423581877, 9093.363464557484, 10995.505202265877, 10496.737581560485, 10642.201834862377, 10996.780064398707, 11002.33985960841, 11070.612528561502, 11130.220884538086, 11206.327620342765, 11207.719807004849, 11211.271267367636, 11216.439178041106, 11004.504797284102, 11071.667849964433, 11072.944635276852, 11077.612283570037, 11082.61210857616, 10933.507992140372, 10999.725006874813, 11006.779864402748, 11008.669739907735, 11008.889911100867, 46266.30600540995, 46770.0, 46772.532274677156, 46805.53194468046, 46861.76569117133, 3992.640662340403, 3994.1013272013565, 4025.2955732746946, 4027.536833264183, 4660.557247061523, 36165.819170903975, 36386.45420318697, 36514.26971460583, 36795.448068278994, 38146.42780358297, 4754.500777418356, 4779.371672730521, 4809.951900480985, 4893.853184404438, 4921.608657239398, 390941.0, 395227.99999999715, 395911.0, 396377.0, 397120.0, 39483.21033579313, 40523.39214911779, 70673.64663176754, 71486.64256678683, 71654.0, 40629.39055914163, 40730.79634601808, 40740.0, 40813.59186408157, 40858.182836343105, 15233.0, 15265.389384424721, 15284.694306113815, 15394.076355418487, 15413.306401211748, 11473.483693233824, 12211.877881221251, 12341.568045118378, 12398.81401778974, 12910.225386476654, 9502.382345147544, 9520.428774273565, 9526.333156679104, 9551.522423878778, 9583.377080489747, 3622.873199438007, 3623.474596183539, 3660.1215708230366, 3679.300932822755, 3732.832022558937, 1082.5994382078682, 1114.9442527873573, 1130.0959232613875, 1152.6196355202762, 1155.1509640414288, 34163.487547686804, 34450.82774586111, 34497.0, 34510.30979380399, 34966.65033349685, 1161.285809227319, 1205.9698507537207, 1271.3134907150036, 1325.0658285908412, 1325.2247435250295, 17775.644487110185, 17928.462146135636, 17989.370372036916, 18044.639107217783, 18201.08994550267, 609251.0, 610540.0, 614860.0, 615709.0, 616457.0, 64593.35406645967, 65213.0, 65237.67381163064, 65291.34708652853, 65509.67245163744, 1345.6299517632729, 1464.8974571780086, 1473.630685018924, 1474.8967572270053, 1503.9022463539834, 33941.321173575896, 34728.0, 34952.300953981285, 34972.82513587517, 35976.460353094204, 54321.0, 54556.18165727596, 54640.0, 54749.45250547444, 54865.72567137139, 415271.0, 417665.0, 417810.0, 418773.0, 419323.0, 27550.44899102047, 31276.530852037693, 31343.0, 32032.83983580067, 32228.0, 52560.73719631377, 53032.46967530275, 53150.468495314555, 53522.46477535175, 53997.46002539925, 43786.0, 44850.327245092005, 45161.32258016067, 45268.54731452643, 45932.7703361481, 42369.0, 42990.57009429866, 47716.52283477259, 48021.03957920752, 48377.758111209216, 45067.54932450633, 45375.77312113418, 46210.30684539668, 46411.53588464207, 46722.29916551187, 39166.80416597899, 39929.0, 40685.97583629232, 41276.1744765109, 41741.37387939244, 30061.398772024873, 30845.845770771004, 31009.534856976712, 31031.53452698166, 31085.378292434478], "value": 20823.77733438482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.605592575202, 421.18290516398184, 425.1921349436073, 427.20326590907956, 437.85331913808875, 19441.611167776635, 20141.496462588442, 20662.0, 20678.0, 21074.789252107475, 17911.55221119473, 18285.90857045713, 18966.0, 19116.044197790125, 19519.512012199702, 5668.546516278698, 5897.587168898179, 5908.97045514774, 5910.67491287979, 5913.852153696149, 4373.0, 5281.075811732951, 5750.281214848144, 5886.146508756249, 6653.733850645968, 6572.408483236508, 6700.061991321195, 6706.631135287582, 6708.932910670879, 6727.629980351078, 6414.839629009265, 6453.645049522274, 6575.967120164392, 6588.868222635569, 6600.273969863311, 3895.4156876468473, 5538.972305138489, 5702.77188912443, 5732.31212254528, 5886.323072846634, 23902.88048559746, 23931.88034059836, 23998.280051598478, 24195.395115122086, 24236.63645045308, 2629.579267317239, 2684.302081458835, 3003.459377312083, 3204.647488776233, 3209.293955329824, 7127.964360178218, 7161.641917904084, 7194.352508274228, 7200.783976480714, 7425.10898692155, 1950.8927009014499, 2036.1855257896812, 2037.8165965063215, 2041.7039529268172, 2115.1327955538154, 57084.714576427265, 83731.0, 84945.57527212324, 85959.57020214922, 86140.56929715374, 10931.125509959184, 11490.482928268248, 11668.474918628683, 12052.216605920587, 12082.818757718642, 16419.83580164183, 16480.0, 16508.83491165097, 16560.751588725936, 16587.17064146812, 8340.87488687658, 8551.957240213758, 8652.221300082896, 8671.653133874574, 8715.0, 8235.83528329442, 8307.958460207661, 8367.539785311867, 8451.873221901677, 8460.661573536989, 7103.715851365888, 7133.500654954103, 7165.176004759519, 7194.892076618855, 7306.926930730731, 2017.6973453981727, 2044.1312442212, 2047.62119007984, 2089.791020897898, 2090.7491101067667, 1002.4987506246877, 1015.4059874973224, 1049.4333060147587, 1115.576081089181, 1136.710138914588, 19568.60862782765, 19782.109805058808, 20213.292534761214, 20299.898500507403, 20403.693944590843, 1080.184460732158, 1105.2539535813294, 1121.7812526557243, 1134.7049767060623, 1134.8865113488584, 11299.152563557765, 11732.765344693229, 11868.050555955502, 11895.88104118965, 12021.939890300668, 489423.0, 502307.0, 508021.0, 513941.0, 518766.0, 51887.481125188264, 53041.0, 79424.0, 85267.14732852593, 87493.56253218821, 1094.518411898762, 1096.4791723931069, 1113.6881673131536, 1114.0307932099126, 1124.7300647844622, 17647.0, 17913.552161196076, 18079.548011299823, 18139.909300453943, 18322.17550210217, 37221.44167837431, 38480.80759596184, 38977.6102238974, 40179.799101004304, 40191.397129043675, 51554.74222628863, 54525.18212226899, 54578.72710636421, 54586.727066364416, 54647.18029229644, 9030.096990301181, 9087.136722011399, 9263.444193348421, 9476.857847132436, 9581.568829402833, 13493.595192144252, 13500.864991349961, 13642.93178534101, 13774.380152892943, 13926.651833704238, 11783.116266279892, 11817.940910295738, 12137.757244854876, 12488.12583119173, 12642.55751048709, 11225.382603956534, 11327.32036077838, 11839.644810655695, 12056.457459414523, 12547.05897057706, 11660.00889924332, 12247.693807654523, 12351.814722778985, 12353.567625133077, 12850.164739291917, 8211.507309561446, 8384.245417912418, 8706.259967902799, 8892.199702026848, 8960.014398416039, 9140.908590914005, 11548.133889958455, 11652.708682282671, 11945.402729863647, 11956.222845515014], "value": 9556.674770418036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.9775753363695, 1611.2588209423668, 1637.7379619260919, 1878.192377277771, 1992.4919145617873, 8991.370604057718, 9318.347715659907, 9333.953330233357, 9695.951520242406, 9709.271804614664, 9376.8593471098, 9550.570224339905, 9555.140037396633, 9557.04429557044, 9632.325737198398, 2406.783389494945, 2433.6592876997233, 2435.2815919303757, 2437.427204606916, 2437.4515733959806, 2353.964690529635, 2401.1955994741784, 2439.5974664180476, 2439.658447817307, 2439.951200975979, 2403.2429784617875, 2421.2736179146273, 2463.15021317646, 2465.704115506133, 2469.49375378048, 2300.608896487601, 2313.3175713164655, 2318.826088043395, 2330.0563271874917, 2386.021731090245, 2327.8719670418122, 2362.870042147681, 2368.336865677613, 2369.715634123899, 2371.8814059297138, 8201.30288925442, 9010.639574417015, 9501.477418741966, 9594.328397012212, 9594.9520252399, 5378.784848606051, 5589.860253493654, 5601.831945041656, 5603.915941260843, 5614.578906581982, 3483.5645544306963, 3569.1255642367787, 3633.818309084562, 3646.2160635463238, 3660.871869484582, 1171.2152857585438, 1194.6117511808698, 1220.920640158387, 1238.4798384678368, 1243.1919252485866, 13146.539871104465, 13253.536126235536, 13265.734685306239, 13292.401841917137, 13293.86706132936, 4763.893871413164, 4771.928421073687, 4808.735519546459, 4817.590504807061, 4855.6115510759055, 11180.552777888794, 11213.439328033566, 11222.55109795599, 11222.831657525143, 11244.156688248415, 5479.397266300703, 5510.421405752419, 5545.1682247663175, 5551.25058117149, 5557.3331200256225, 4984.180774017457, 5073.9746301269, 5136.8202112925865, 5153.922691159635, 5181.689098654093, 4106.035081755785, 4165.7600632973745, 4170.082581831992, 4192.140611174702, 4200.4959404871615, 1261.8738126187309, 1265.2471779291307, 1274.4456161569747, 1281.9615411537668, 1294.6116165150418, 950.3632566180676, 968.5351031504918, 968.5544649461327, 1034.8551202831609, 1065.9893401066045, 6410.55126141175, 6421.646809425526, 6468.288488266287, 6500.447461965786, 6516.152900122954, 475.237244223024, 476.3616753550259, 478.17992143474106, 479.0706030301204, 502.74862568715645, 3932.7247092703237, 4217.219814334297, 4395.692301538862, 4406.6474682026, 4447.2439685253585, 11395.202335836411, 12103.334316612494, 12104.576339828063, 12111.515539378326, 12120.939395303143, 11181.496832642388, 11724.120690948213, 11734.11994100446, 12020.75958480843, 12098.758024839453, 8831.60257788401, 8849.955750221208, 8944.284457243404, 8997.370184087182, 8998.86501702475, 6419.390157934989, 6544.770933017321, 6591.176102987127, 6640.236372817188, 6704.631245281556, 10549.841752373566, 10559.472026398804, 10615.734606634896, 10619.522121504397, 10939.507722152362, 11139.220254582426, 11264.098872090377, 11274.0, 11278.718032049264, 11406.771864562828, 8505.0, 8582.442141261048, 8694.434861733967, 8696.434731742416, 8704.91295087041, 8269.09040005587, 8438.915610843813, 8459.661613535389, 9273.489958052372, 9315.02192269829, 8243.422960392714, 8359.623816928131, 8365.623546940524, 8373.748787536384, 8385.58072096405, 8116.228958248957, 8131.7560473185895, 8171.101178870438, 8185.836283274421, 8284.337253019865, 7734.381249500139, 7747.845043098993, 7793.532388056735, 7795.41534384912, 7796.493227940393, 5490.725463726878, 5566.749496272597, 5577.2191893135805, 5709.029464990878, 5710.543156547549, 4667.369905062773, 5403.864903377447, 5652.886942261214, 5775.8106226377895, 5832.533397328119], "value": 4846.764976872284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.721646177459, 343.7078483289205, 343.788570029432, 347.0975463794134, 349.66606890419644, 5515.0, 5563.36021357544, 5571.746357069663, 5585.218069470272, 5614.747336369863, 5241.8427447176555, 5286.0, 5433.4566543345645, 5451.836444906659, 5518.310211223597, 4213.094184750278, 4234.30134027885, 4236.131593023439, 4250.192463431938, 4293.570642935712, 4251.8511852085185, 4260.978695106535, 4284.764337961411, 4299.473686841173, 4302.41917341158, 4003.938956176601, 4010.4585880906143, 4082.3672330788777, 4206.1377417629465, 4221.704480686353, 4214.452121224222, 4221.5567365426805, 4227.97886010568, 4231.97884010581, 4235.9788201058955, 3730.365837807552, 3731.253749250161, 3732.861477249438, 3742.850285988557, 3749.0692293468887, 5105.591552675777, 5203.739813009334, 5205.24523944026, 5206.557442617382, 5245.160774276097, 4841.8063277468855, 4860.222364421711, 4868.732219727914, 4886.804527818883, 4891.951080489185, 5618.831435056954, 5642.661440313554, 5650.943490565124, 5654.660720356751, 5660.2075709400715, 4045.271851066807, 4090.4682391288943, 4121.835126594932, 4122.525909520384, 4156.251874662559, 5843.0, 5845.269341332333, 5869.911951320733, 5874.206982057453, 5894.587378883522, 4265.850695225652, 4267.5305716371795, 4271.700980931367, 4277.101808620162, 4285.935710964338, 4204.432401625802, 4259.3185090386005, 4271.3592961055465, 4280.76455794928, 4311.741295522279, 4795.232762757942, 4858.344123543347, 4862.95137048632, 4874.780634871439, 4879.706537927169, 5625.353084395347, 5687.9431205687415, 5736.340320863154, 5811.418858114239, 5819.88360232793, 1401.2993503248376, 1440.2582669924998, 1477.4385733421232, 1478.7633978563379, 1478.7707905274485, 1009.5507499162802, 1026.8921763214905, 1027.6968294353185, 1030.7423144213947, 1036.8133735927606, 5522.144067669517, 5534.007757207402, 5554.1391084381985, 5565.220869078333, 5607.4112218217315, 5786.3056433228285, 5795.739191736382, 5835.153902684087, 5854.765809367577, 5855.209546711139, 5369.597280203922, 5530.751116199781, 5543.972280138573, 5562.805301814417, 5668.489835914787, 3131.1545882611567, 3142.6543080261154, 3151.739304278307, 3157.778955473095, 3163.557102005721, 6073.210482637317, 6193.4425901669065, 6199.473044791153, 6216.378362163838, 6216.968915155486, 5900.1739756434135, 5951.791687290924, 6035.668038257938, 6055.666938318347, 6105.053716673922, 6113.32753397126, 6118.20463339763, 6153.923063463965, 6158.137860699506, 6188.752449902044, 5631.971840140773, 5891.911621325769, 5939.10913362999, 5978.206538038484, 5991.820245392645, 5854.443827836349, 5870.236869207147, 5886.293644762484, 5892.7642894283745, 5895.587308888336, 5929.407059294209, 6174.845628859314, 6177.84555386119, 6184.196054512884, 6225.128482012431, 4148.211839750437, 4194.769287689206, 4207.75871118027, 4221.577842215754, 4229.53475117743, 5911.970440147772, 5939.0, 5963.165156877953, 5968.2247754794225, 5976.551758618034, 5612.803551875828, 5667.858303542444, 5765.279340082489, 5795.7254151406005, 5818.418158184148, 5790.276215473066, 5809.331926828469, 5817.556626216914, 5825.76696932118, 5832.737526811219, 5609.579281553818, 5730.971345143247, 5751.223584816164, 5756.42435756421, 5765.192872997867, 5798.652080875161, 5810.796622118375, 5816.592838501433, 5836.766529338949, 5852.678102704393, 5685.175649530877, 5688.516476099412, 5708.429157084258, 5708.885822283448, 5731.799387021434], "value": 4392.294504304319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.9157084291568, 854.1458541458542, 905.2034209895293, 905.6151135767298, 915.4324318922268, 14641.853581464182, 15625.453109141183, 16498.42255521057, 16765.245563949622, 16829.41097061603, 14846.1834599097, 14927.402903883858, 15072.47246346378, 15165.848341516581, 15378.307976141072, 745.8620155271265, 878.7978764884049, 887.9778005549848, 905.3752910491772, 911.7447114807832, 891.131147131548, 899.5906862377602, 899.7435730816718, 902.9503377314245, 903.1329923273665, 931.175909320253, 931.3015238571072, 931.7950050988771, 932.6689025395989, 934.8924873639517, 770.5761830992959, 916.4821875640275, 936.0452338614643, 938.3009657804911, 938.558877327655, 686.3685409423342, 688.4767576641739, 691.550492180082, 691.5746815708303, 692.4218277738045, 15740.134292613902, 15780.289886955115, 15856.52430427089, 15874.80938929585, 15914.363425462967, 15013.69972600542, 15485.922570387076, 15563.533094007085, 15647.452339168074, 15856.762148567665, 13004.0, 13210.801837972438, 13255.734885302336, 13292.202467851863, 13330.73338533224, 4651.279051746985, 4735.526447355272, 4743.905121897577, 4745.1695953208055, 4789.592884604813, 74847.62576187085, 74860.87708684374, 74941.0, 76956.0, 78423.6078819608, 12295.4467048983, 12536.185147965352, 12571.245725256515, 12636.936815315865, 12655.93672031634, 22898.65652015221, 23071.423214419774, 23071.653925191134, 23133.0, 23903.7609623905, 9084.31867609932, 9151.725448236564, 9199.310051746146, 9209.953950230207, 9286.0, 5078.390593128848, 5117.130087885069, 5120.206368012964, 5237.8428647140645, 5382.946170538323, 3708.6291370862696, 3840.135969406917, 3843.0584506795453, 3846.769193848322, 3846.8268927897752, 682.754208484945, 688.9379955804002, 694.2259380790382, 694.8853439182478, 714.706381449578, 629.3989240275525, 697.4594689115976, 706.5019161491136, 709.989350159748, 716.7957132217293, 9444.338896277332, 9607.991160928143, 10486.632967846088, 10773.78452430947, 10890.074343680717, 592.6207227374484, 633.3603060908515, 653.3270731146927, 667.8664267146493, 686.255412877034, 4486.528914463999, 4524.53529376606, 4538.614217791524, 4549.658775591844, 4592.67851250416, 69346.65326673334, 71331.64334178295, 78000.0, 106054.46972765241, 106317.0, 95758.0, 98586.0, 99989.50005249926, 101048.0, 101376.49311753394, 68042.0, 90743.0, 91581.54209229044, 92809.53595231981, 93470.0652993475, 8800.515971621622, 8966.372353935161, 9021.548922553715, 9076.273898088006, 9137.0, 52441.0, 53985.73007134939, 55394.67631942096, 55658.72170639121, 57117.0, 69019.65490172517, 78693.60653196697, 79923.60038199772, 80041.59979200066, 80229.0, 11733.823992640288, 11822.645320640395, 11905.46425410876, 12005.63983080509, 12186.2078964867, 12411.875881241072, 12968.221906685629, 13178.472861085449, 13373.39819708096, 15714.607134821264, 14239.715205696035, 14693.55919322422, 14755.55733328002, 15038.62403439879, 15097.849021509644, 14171.362288696828, 15111.017783844014, 15160.393584256506, 15162.090274583561, 15171.772423413437, 14594.85405145935, 14599.708005840037, 14691.11853288806, 14795.186264755543, 15186.924065379602, 12144.75710485803, 12381.566645167375, 12771.680707982003, 13159.47362105505, 13190.142640728322, 12138.575149869712, 12645.304508252135, 12738.299393533445, 12944.611661650166, 13001.934990324988], "value": 7906.8915712446305, "unit": "score"}], "name": "dromaeo_css", "value": 7580.103254479347, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 112.0, 109.0, 110.0, 111.0, 109.0, 111.0, 111.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 124.0, 129.0, 169.0, 123.0, 124.0, 152.0, 136.0, 168.0, 125.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 159.0, 160.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 104.0, 75.0, 76.0, 76.0, 73.0, 108.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 84.0, 84.0, 83.0, 117.0, 83.0, 84.0, 119.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 53.0, 53.0, 55.0, 61.0, 52.0, 53.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 68.0, 60.0, 60.0, 60.0, 58.0, 60.0, 59.0, 59.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 78.0, 82.0, 77.0, 77.0, 77.0, 119.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 124.0, 123.0, 116.0, 121.0, 115.0, 140.0, 121.0, 122.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 158.0, 155.0, 158.0, 156.0, 158.0, 155.0, 157.0, 152.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 62.0, 63.0, 63.0, 60.0, 61.0, 60.0, 61.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1477.3999999999999, "alertThreshold": 2.0}]} 11:10:30 INFO - Return code: 0 11:10:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:30 ERROR - # TBPL SUCCESS # 11:10:30 INFO - Running post-action listener: _resource_record_post_action 11:10:30 INFO - ##### 11:10:30 INFO - ##### Finished run-tests step (success) 11:10:30 INFO - ##### 11:10:30 INFO - Running post-run listener: _resource_record_post_run 11:10:30 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 28672; Write bytes: 457052160; Read time: 16; Write time: 375772 11:10:30 INFO - TinderboxPrint: CPU usage
13.0% 11:10:30 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 16 11:10:30 INFO - TinderboxPrint: I/O write bytes / time
457,052,160 / 375,772 11:10:30 INFO - TinderboxPrint: CPU idle
8,242.2 (87.0%) 11:10:30 INFO - TinderboxPrint: CPU user
1,191.6 (12.6%) 11:10:30 INFO - TinderboxPrint: Swap in / out
0 / 0 11:10:30 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234995712; Read time: 0; Write time: 278512 11:10:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221745152; Read time: 8; Write time: 97240 11:10:30 INFO - Running post-run listener: _upload_blobber_files 11:10:30 INFO - Blob upload gear active. 11:10:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:10:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:31 INFO - (blobuploader) - INFO - Done attempting. 11:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:10:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:36 INFO - (blobuploader) - INFO - Done attempting. 11:10:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:10:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:10:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:37 INFO - (blobuploader) - INFO - Done attempting. 11:10:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:37 INFO - Return code: 0 11:10:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:10:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29c598f10db27817d75539e9814e73b669ac48eeaaa5ce84955bac177be454ce7f4391ef0a5b0cee9655d97e3fd761ccef15641789e5767f40ed7712a6667ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0804e74f5b14df98b49b7b8ccde9741462093834f998ac72e1cc02e740f24bca9c6838e811fcdddc27cecb30a21b1e65d3b5f4b20bbbc236f569e58ec45c8043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b16bbdbb6a3fe56c5a1ad84f394589c83b639be9ff5119815497999c00a8249f7d4017810aa6eef05ab960d9f66e948b4f25f5ec558bb833a04b6b93cfece864"} 11:10:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:10:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:10:37 INFO - Contents: 11:10:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29c598f10db27817d75539e9814e73b669ac48eeaaa5ce84955bac177be454ce7f4391ef0a5b0cee9655d97e3fd761ccef15641789e5767f40ed7712a6667ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0804e74f5b14df98b49b7b8ccde9741462093834f998ac72e1cc02e740f24bca9c6838e811fcdddc27cecb30a21b1e65d3b5f4b20bbbc236f569e58ec45c8043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b16bbdbb6a3fe56c5a1ad84f394589c83b639be9ff5119815497999c00a8249f7d4017810aa6eef05ab960d9f66e948b4f25f5ec558bb833a04b6b93cfece864"} 11:10:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:37 INFO - Copying logs to upload dir... 11:10:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:10:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.722263 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 11:10:37.206760) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:37.210313) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987 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/29c598f10db27817d75539e9814e73b669ac48eeaaa5ce84955bac177be454ce7f4391ef0a5b0cee9655d97e3fd761ccef15641789e5767f40ed7712a6667ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0804e74f5b14df98b49b7b8ccde9741462093834f998ac72e1cc02e740f24bca9c6838e811fcdddc27cecb30a21b1e65d3b5f4b20bbbc236f569e58ec45c8043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b16bbdbb6a3fe56c5a1ad84f394589c83b639be9ff5119815497999c00a8249f7d4017810aa6eef05ab960d9f66e948b4f25f5ec558bb833a04b6b93cfece864"} build_url:https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29c598f10db27817d75539e9814e73b669ac48eeaaa5ce84955bac177be454ce7f4391ef0a5b0cee9655d97e3fd761ccef15641789e5767f40ed7712a6667ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0804e74f5b14df98b49b7b8ccde9741462093834f998ac72e1cc02e740f24bca9c6838e811fcdddc27cecb30a21b1e65d3b5f4b20bbbc236f569e58ec45c8043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b16bbdbb6a3fe56c5a1ad84f394589c83b639be9ff5119815497999c00a8249f7d4017810aa6eef05ab960d9f66e948b4f25f5ec558bb833a04b6b93cfece864"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:37.235100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:37.235465) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470332749.749590-859654987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:37.321007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:10:37.321390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:10:37.322169) ========= ========= Total master_lag: 0.19 =========