builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1466677879.44 results: success (0) buildid: 20160623004024 builduid: 61a15d0049e24a2691cbd59e469d3be7 revision: 08127897283dd05ae78e32ed71ce727bdb39285c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.441306) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.441698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.442144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.484504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.484766) ========= 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=d2a8c569965ab8367867b893000001a1-1466677726.819464-806118363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 03:31:19-- 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% 2.10M=0.006s 2016-06-23 03:31:19 (2.10 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.583104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.583397) ========= 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=d2a8c569965ab8367867b893000001a1-1466677726.819464-806118363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:19.632798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 03:31:19.633106) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08127897283dd05ae78e32ed71ce727bdb39285c --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-aurora --rev 08127897283dd05ae78e32ed71ce727bdb39285c --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=d2a8c569965ab8367867b893000001a1-1466677726.819464-806118363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 03:31:19,703 truncating revision to first 12 chars 2016-06-23 03:31:19,703 Setting DEBUG logging. 2016-06-23 03:31:19,703 attempt 1/10 2016-06-23 03:31:19,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08127897283d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 03:31:20,820 unpacking tar archive at: mozilla-aurora-08127897283d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.478361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 03:31:21.125550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:21.125881) ========= script_repo_revision: 08127897283dd05ae78e32ed71ce727bdb39285c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:21.126342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:21.126676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 03:31:21.136210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-23 03:31:21.136672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d2a8c569965ab8367867b893000001a1-1466677726.819464-806118363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:21 INFO - MultiFileLogger online at 20160623 03:31:21 in /builds/slave/test 03:31:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:21 INFO - {'append_to_log': False, 03:31:21 INFO - 'base_work_dir': '/builds/slave/test', 03:31:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:21 INFO - 'branch': 'Mozilla-Aurora', 03:31:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:21 INFO - 'config_files': ('talos/linux_config.py',), 03:31:21 INFO - 'default_actions': ('clobber', 03:31:21 INFO - 'read-buildbot-config', 03:31:21 INFO - 'download-and-extract', 03:31:21 INFO - 'populate-webroot', 03:31:21 INFO - 'create-virtualenv', 03:31:21 INFO - 'install', 03:31:21 INFO - 'run-tests'), 03:31:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:21 INFO - 'download_minidump_stackwalk': True, 03:31:21 INFO - 'download_symbols': 'ondemand', 03:31:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:21 INFO - 'installer_path': 'installer.exe', 03:31:21 INFO - 'log_level': 'info', 03:31:21 INFO - 'log_name': 'talos', 03:31:21 INFO - 'log_to_console': True, 03:31:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:21 INFO - 'opt_config_files': (), 03:31:21 INFO - 'pip_index': False, 03:31:21 INFO - 'sps_profile': False, 03:31:21 INFO - 'sps_profile_interval': 0, 03:31:21 INFO - 'suite': 'dromaeojs', 03:31:21 INFO - 'system_bits': '32', 03:31:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:21 INFO - 'title': 'talos-linux64-ix-043', 03:31:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:21 INFO - 'use_talos_json': True, 03:31:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:21 INFO - 'work_dir': 'build'} 03:31:21 INFO - ##### 03:31:21 INFO - ##### Running clobber step. 03:31:21 INFO - ##### 03:31:21 INFO - Running pre-action listener: _resource_record_pre_action 03:31:21 INFO - Running main action method: clobber 03:31:21 INFO - rmtree: /builds/slave/test/build 03:31:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:21 INFO - Running post-action listener: _resource_record_post_action 03:31:21 INFO - ##### 03:31:21 INFO - ##### Finished clobber step (success) 03:31:21 INFO - ##### 03:31:21 INFO - ##### 03:31:21 INFO - ##### Running read-buildbot-config step. 03:31:21 INFO - ##### 03:31:21 INFO - Running pre-action listener: _resource_record_pre_action 03:31:21 INFO - Running main action method: read_buildbot_config 03:31:21 INFO - Using buildbot properties: 03:31:21 INFO - { 03:31:21 INFO - "project": "", 03:31:21 INFO - "product": "firefox", 03:31:21 INFO - "script_repo_revision": "production", 03:31:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:31:21 INFO - "repository": "", 03:31:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:31:21 INFO - "buildid": "20160623004024", 03:31:21 INFO - "stage_platform": "linux64-pgo", 03:31:21 INFO - "basedir": "/builds/slave/test", 03:31:21 INFO - "nightly_build": "True", 03:31:21 INFO - "buildnumber": 389, 03:31:21 INFO - "slavename": "talos-linux64-ix-043", 03:31:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:21 INFO - "platform": "ubuntu64_hw", 03:31:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:21 INFO - "branch": "mozilla-aurora", 03:31:21 INFO - "repo_path": "releases/mozilla-aurora", 03:31:21 INFO - "revision": "08127897283dd05ae78e32ed71ce727bdb39285c", 03:31:21 INFO - "pgo_build": "True", 03:31:21 INFO - "builduid": "61a15d0049e24a2691cbd59e469d3be7", 03:31:21 INFO - "slavebuilddir": "test" 03:31:21 INFO - } 03:31:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:31:21 INFO - Running post-action listener: _resource_record_post_action 03:31:21 INFO - ##### 03:31:21 INFO - ##### Finished read-buildbot-config step (success) 03:31:21 INFO - ##### 03:31:21 INFO - ##### 03:31:21 INFO - ##### Running download-and-extract step. 03:31:21 INFO - ##### 03:31:21 INFO - Running pre-action listener: _resource_record_pre_action 03:31:21 INFO - Running main action method: download_and_extract 03:31:21 INFO - mkdir: /builds/slave/test/build/tests 03:31:21 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')]} 03:31:21 INFO - https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:23 INFO - Downloaded 1361 bytes. 03:31:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:23 INFO - Using the following test package requirements: 03:31:23 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:23 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:23 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:23 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'jsshell-linux-x86_64.zip'], 03:31:23 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:23 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:23 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:23 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:23 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:23 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:23 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31: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')]} 03:31:23 INFO - https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:24 INFO - Downloaded 24473575 bytes. 03:31:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:26 INFO - Return code: 0 03:31:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:26 INFO - https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:43 INFO - Downloaded 24473575 bytes. 03:31:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:45 INFO - Return code: 0 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:45 INFO - https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:46 INFO - Downloaded 10833369 bytes. 03:31:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:31:46 INFO - Return code: 0 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:47 INFO - Downloaded 63597854 bytes. 03:31:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:47 INFO - mkdir: /builds/slave/test/properties 03:31:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:47 INFO - Contents: 03:31:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:48 INFO - Running post-action listener: _resource_record_post_action 03:31:48 INFO - Running post-action listener: set_extra_try_arguments 03:31:48 INFO - ##### 03:31:48 INFO - ##### Finished download-and-extract step (success) 03:31:48 INFO - ##### 03:31:48 INFO - ##### 03:31:48 INFO - ##### Running populate-webroot step. 03:31:48 INFO - ##### 03:31:48 INFO - Running pre-action listener: _resource_record_pre_action 03:31:48 INFO - Running main action method: populate_webroot 03:31:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:48 INFO - '--tppagecycles', 03:31:48 INFO - '7'], 03:31:48 INFO - 'tests': ['tsvgm']}}, 03:31:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['damp', 'tps']}, 03:31:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'tests': ['damp', 'tps']}, 03:31:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['dromaeo_dom']}, 03:31:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['a11yr', 03:31:48 INFO - 'ts_paint', 03:31:48 INFO - 'tpaint', 03:31:48 INFO - 'sessionrestore', 03:31:48 INFO - 'sessionrestore_no_auto_restore', 03:31:48 INFO - 'tabpaint']}, 03:31:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:48 INFO - 'ts_paint', 03:31:48 INFO - 'tpaint', 03:31:48 INFO - 'sessionrestore', 03:31:48 INFO - 'sessionrestore_no_auto_restore', 03:31:48 INFO - 'tabpaint']}, 03:31:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:48 INFO - 'ts_paint', 03:31:48 INFO - 'tpaint', 03:31:48 INFO - 'sessionrestore', 03:31:48 INFO - 'sessionrestore_no_auto_restore', 03:31:48 INFO - 'tabpaint']}, 03:31:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:48 INFO - 'ts_paint', 03:31:48 INFO - 'tpaint', 03:31:48 INFO - 'sessionrestore', 03:31:48 INFO - 'sessionrestore_no_auto_restore', 03:31:48 INFO - 'tabpaint']}, 03:31:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['a11yr', 03:31:48 INFO - 'ts_paint', 03:31:48 INFO - 'tpaint', 03:31:48 INFO - 'sessionrestore', 03:31:48 INFO - 'sessionrestore_no_auto_restore', 03:31:48 INFO - 'tabpaint']}, 03:31:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['a11yr', 03:31:48 INFO - 'ts_paint', 03:31:48 INFO - 'tpaint', 03:31:48 INFO - 'sessionrestore', 03:31:48 INFO - 'sessionrestore_no_auto_restore', 03:31:48 INFO - 'tabpaint']}, 03:31:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['tsvgx', 03:31:48 INFO - 'tsvgr_opacity', 03:31:48 INFO - 'tart', 03:31:48 INFO - 'tscrollx', 03:31:48 INFO - 'cart']}, 03:31:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:48 INFO - 'tsvgr_opacity', 03:31:48 INFO - 'tart', 03:31:48 INFO - 'tscrollx', 03:31:48 INFO - 'cart']}, 03:31:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'talos_options': ['--disable-e10s'], 03:31:48 INFO - 'tests': ['tp5o']}, 03:31:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'tests': ['tp5o']}, 03:31:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'talos_options': ['--disable-e10s', 03:31:48 INFO - '--xperf_path', 03:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:48 INFO - 'tests': ['tp5n']}, 03:31:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:48 INFO - 'talos_options': ['--xperf_path', 03:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:48 INFO - 'tests': ['tp5n']}}, 03:31:48 INFO - 'talos.zip': {'path': '', 03:31:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:48 INFO - Running post-action listener: _resource_record_post_action 03:31:48 INFO - ##### 03:31:48 INFO - ##### Finished populate-webroot step (success) 03:31:48 INFO - ##### 03:31:48 INFO - ##### 03:31:48 INFO - ##### Running create-virtualenv step. 03:31:48 INFO - ##### 03:31:48 INFO - Running pre-action listener: _resource_record_pre_action 03:31:48 INFO - Running main action method: create_virtualenv 03:31:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:48 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 03:31:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:48 INFO - Using real prefix '/usr' 03:31:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:51 INFO - Installing pip.................done. 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:31:51 INFO - Cleaning up... 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:51 INFO - Downloading/unpacking psutil>=3.1.1 03:31:51 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 03:31:51 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 03:31:51 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 03:31:51 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 03:31:51 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 03:31:51 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 03:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:53 INFO - Installing collected packages: psutil 03:31:53 INFO - Running setup.py install for psutil 03:31:53 INFO - building 'psutil._psutil_linux' extension 03:31:53 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 03:31:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:31:54 INFO - building 'psutil._psutil_posix' extension 03:31:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:31:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:54 INFO - Successfully installed psutil 03:31:54 INFO - Cleaning up... 03:31:54 INFO - Return code: 0 03:31:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:31:54 INFO - Using env: {'DISPLAY': ':0', 03:31:54 INFO - 'HOME': '/home/cltbld', 03:31:54 INFO - 'LANG': 'en_US.UTF-8', 03:31:54 INFO - 'LANGUAGE': 'en_US:en', 03:31:54 INFO - 'LOGNAME': 'cltbld', 03:31:54 INFO - 'MAIL': '/var/mail/cltbld', 03:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:54 INFO - 'MOZ_NO_REMOTE': '1', 03:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:54 INFO - 'NO_EM_RESTART': '1', 03:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:54 INFO - 'PWD': '/builds/slave/test', 03:31:54 INFO - 'SHELL': '/bin/bash', 03:31:54 INFO - 'SHLVL': '1', 03:31:54 INFO - 'TERM': 'linux', 03:31:54 INFO - 'TMOUT': '86400', 03:31:54 INFO - 'USER': 'cltbld', 03:31:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:54 INFO - '_': '/tools/buildbot/bin/python'} 03:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:56 INFO - Installing collected packages: mozsystemmonitor 03:31:56 INFO - Running setup.py install for mozsystemmonitor 03:31:56 INFO - Successfully installed mozsystemmonitor 03:31:56 INFO - Cleaning up... 03:31:56 INFO - Return code: 0 03:31:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:31:56 INFO - Using env: {'DISPLAY': ':0', 03:31:56 INFO - 'HOME': '/home/cltbld', 03:31:56 INFO - 'LANG': 'en_US.UTF-8', 03:31:56 INFO - 'LANGUAGE': 'en_US:en', 03:31:56 INFO - 'LOGNAME': 'cltbld', 03:31:56 INFO - 'MAIL': '/var/mail/cltbld', 03:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:56 INFO - 'MOZ_NO_REMOTE': '1', 03:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:56 INFO - 'NO_EM_RESTART': '1', 03:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:56 INFO - 'PWD': '/builds/slave/test', 03:31:56 INFO - 'SHELL': '/bin/bash', 03:31:56 INFO - 'SHLVL': '1', 03:31:56 INFO - 'TERM': 'linux', 03:31:56 INFO - 'TMOUT': '86400', 03:31:56 INFO - 'USER': 'cltbld', 03:31:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:56 INFO - '_': '/tools/buildbot/bin/python'} 03:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:59 INFO - warning: no files found matching '*.txt' 03:31:59 INFO - no previously-included directories found matching 'build' 03:31:59 INFO - no previously-included directories found matching 'dist' 03:31:59 INFO - no previously-included directories found matching '.git*' 03:31:59 INFO - Installing collected packages: jsonschema, functools32 03:31:59 INFO - Running setup.py install for functools32 03:31:59 INFO - warning: no files found matching '*.txt' 03:31:59 INFO - no previously-included directories found matching 'build' 03:31:59 INFO - no previously-included directories found matching 'dist' 03:31:59 INFO - no previously-included directories found matching '.git*' 03:31:59 INFO - Successfully installed jsonschema functools32 03:31:59 INFO - Cleaning up... 03:31:59 INFO - Return code: 0 03:31:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:59 INFO - Using env: {'DISPLAY': ':0', 03:31:59 INFO - 'HOME': '/home/cltbld', 03:31:59 INFO - 'LANG': 'en_US.UTF-8', 03:31:59 INFO - 'LANGUAGE': 'en_US:en', 03:31:59 INFO - 'LOGNAME': 'cltbld', 03:31:59 INFO - 'MAIL': '/var/mail/cltbld', 03:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:59 INFO - 'MOZ_NO_REMOTE': '1', 03:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:59 INFO - 'NO_EM_RESTART': '1', 03:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:59 INFO - 'PWD': '/builds/slave/test', 03:31:59 INFO - 'SHELL': '/bin/bash', 03:31:59 INFO - 'SHLVL': '1', 03:31:59 INFO - 'TERM': 'linux', 03:31:59 INFO - 'TMOUT': '86400', 03:31:59 INFO - 'USER': 'cltbld', 03:31:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:59 INFO - '_': '/tools/buildbot/bin/python'} 03:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:01 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 03:32:01 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 03:32:01 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 03:32:01 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 03:32:01 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 03:32:01 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 03:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:02 INFO - Downloading docopt-0.6.1.tar.gz 03:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:02 INFO - Running setup.py install for blobuploader 03:32:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:02 INFO - Running setup.py install for requests 03:32:03 INFO - Running setup.py install for docopt 03:32:03 INFO - Successfully installed blobuploader requests docopt 03:32:03 INFO - Cleaning up... 03:32:03 INFO - Return code: 0 03:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 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 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:32:03 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 03:32:03 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 03:32:03 INFO - Using env: {'DISPLAY': ':0', 03:32:03 INFO - 'HOME': '/home/cltbld', 03:32:03 INFO - 'LANG': 'en_US.UTF-8', 03:32:03 INFO - 'LANGUAGE': 'en_US:en', 03:32:03 INFO - 'LOGNAME': 'cltbld', 03:32:03 INFO - 'MAIL': '/var/mail/cltbld', 03:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:03 INFO - 'MOZ_NO_REMOTE': '1', 03:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:03 INFO - 'NO_EM_RESTART': '1', 03:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:03 INFO - 'PWD': '/builds/slave/test', 03:32:03 INFO - 'SHELL': '/bin/bash', 03:32:03 INFO - 'SHLVL': '1', 03:32:03 INFO - 'TERM': 'linux', 03:32:03 INFO - 'TMOUT': '86400', 03:32:03 INFO - 'USER': 'cltbld', 03:32:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:03 INFO - '_': '/tools/buildbot/bin/python'} 03:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:03 INFO - Running setup.py (path:/tmp/pip-55c6eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:03 INFO - Running setup.py (path:/tmp/pip-hjAQ00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:03 INFO - Running setup.py (path:/tmp/pip-DCUeEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:03 INFO - Running setup.py (path:/tmp/pip-RVZ4xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:03 INFO - Running setup.py (path:/tmp/pip-IthyB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:03 INFO - Running setup.py (path:/tmp/pip-uBvb79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:03 INFO - Running setup.py (path:/tmp/pip-_h15Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:03 INFO - Running setup.py (path:/tmp/pip-dSmOYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:03 INFO - Running setup.py (path:/tmp/pip-uDrd7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:04 INFO - Running setup.py (path:/tmp/pip-rsohIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:04 INFO - Running setup.py (path:/tmp/pip-ctrJxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:04 INFO - Running setup.py (path:/tmp/pip-gyz7O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:04 INFO - Running setup.py (path:/tmp/pip-nXuHZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:04 INFO - Running setup.py (path:/tmp/pip-PGGpl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:04 INFO - Running setup.py (path:/tmp/pip-68jpSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:04 INFO - Running setup.py (path:/tmp/pip-f6mQeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:04 INFO - Running setup.py (path:/tmp/pip-0F7h6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:04 INFO - Running setup.py install for manifestparser 03:32:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:04 INFO - Running setup.py install for mozcrash 03:32:04 INFO - Running setup.py install for mozdebug 03:32:04 INFO - Running setup.py install for mozdevice 03:32:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for mozfile 03:32:05 INFO - Running setup.py install for mozhttpd 03:32:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for mozinfo 03:32:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for mozInstall 03:32:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for mozleak 03:32:05 INFO - Running setup.py install for mozlog 03:32:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for moznetwork 03:32:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for mozprocess 03:32:05 INFO - Running setup.py install for mozprofile 03:32:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:05 INFO - Running setup.py install for mozrunner 03:32:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:06 INFO - Running setup.py install for mozscreenshot 03:32:06 INFO - Running setup.py install for moztest 03:32:06 INFO - Running setup.py install for mozversion 03:32:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:06 INFO - Cleaning up... 03:32:06 INFO - Return code: 0 03:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:06 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 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:32:06 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 03:32:06 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 03:32:06 INFO - Using env: {'DISPLAY': ':0', 03:32:06 INFO - 'HOME': '/home/cltbld', 03:32:06 INFO - 'LANG': 'en_US.UTF-8', 03:32:06 INFO - 'LANGUAGE': 'en_US:en', 03:32:06 INFO - 'LOGNAME': 'cltbld', 03:32:06 INFO - 'MAIL': '/var/mail/cltbld', 03:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:06 INFO - 'MOZ_NO_REMOTE': '1', 03:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:06 INFO - 'NO_EM_RESTART': '1', 03:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:06 INFO - 'PWD': '/builds/slave/test', 03:32:06 INFO - 'SHELL': '/bin/bash', 03:32:06 INFO - 'SHLVL': '1', 03:32:06 INFO - 'TERM': 'linux', 03:32:06 INFO - 'TMOUT': '86400', 03:32:06 INFO - 'USER': 'cltbld', 03:32:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:06 INFO - '_': '/tools/buildbot/bin/python'} 03:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:06 INFO - Running setup.py (path:/tmp/pip-mF7Ifd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:06 INFO - Running setup.py (path:/tmp/pip-bhQK5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:06 INFO - Running setup.py (path:/tmp/pip-DlQF9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:06 INFO - Running setup.py (path:/tmp/pip-HA4gV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:06 INFO - Running setup.py (path:/tmp/pip-obNghK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:06 INFO - Running setup.py (path:/tmp/pip-tyZ4td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:07 INFO - Running setup.py (path:/tmp/pip-S212le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:07 INFO - Running setup.py (path:/tmp/pip-lEjc3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:07 INFO - Running setup.py (path:/tmp/pip-P78drs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:07 INFO - Running setup.py (path:/tmp/pip-U_sy09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:07 INFO - Running setup.py (path:/tmp/pip-27YLhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:07 INFO - Running setup.py (path:/tmp/pip-eoDEqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:07 INFO - Running setup.py (path:/tmp/pip-0yJtwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:07 INFO - Running setup.py (path:/tmp/pip-jYq9RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:07 INFO - Running setup.py (path:/tmp/pip-76E2w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:07 INFO - Running setup.py (path:/tmp/pip-deBBGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:07 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)) 03:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:07 INFO - Running setup.py (path:/tmp/pip-vM2jWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 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)) 03:32:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:09 INFO - Downloading blessings-1.6.tar.gz 03:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:09 INFO - Installing collected packages: blessings 03:32:09 INFO - Running setup.py install for blessings 03:32:09 INFO - Successfully installed blessings 03:32:09 INFO - Cleaning up... 03:32:10 INFO - Return code: 0 03:32:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:10 INFO - Reading from file tmpfile_stdout 03:32:10 INFO - Current package versions: 03:32:10 INFO - argparse == 1.2.1 03:32:10 INFO - blessings == 1.6 03:32:10 INFO - blobuploader == 1.2.4 03:32:10 INFO - docopt == 0.6.1 03:32:10 INFO - functools32 == 3.2.3-2 03:32:10 INFO - jsonschema == 2.5.1 03:32:10 INFO - manifestparser == 1.1 03:32:10 INFO - mozInstall == 1.12 03:32:10 INFO - mozcrash == 0.17 03:32:10 INFO - mozdebug == 0.1 03:32:10 INFO - mozdevice == 0.48 03:32:10 INFO - mozfile == 1.2 03:32:10 INFO - mozhttpd == 0.7 03:32:10 INFO - mozinfo == 0.9 03:32:10 INFO - mozleak == 0.1 03:32:10 INFO - mozlog == 3.2 03:32:10 INFO - moznetwork == 0.27 03:32:10 INFO - mozprocess == 0.22 03:32:10 INFO - mozprofile == 0.28 03:32:10 INFO - mozrunner == 6.11 03:32:10 INFO - mozscreenshot == 0.1 03:32:10 INFO - mozsystemmonitor == 0.3 03:32:10 INFO - moztest == 0.7 03:32:10 INFO - mozversion == 1.4 03:32:10 INFO - psutil == 3.1.1 03:32:10 INFO - requests == 1.2.3 03:32:10 INFO - wsgiref == 0.1.2 03:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 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 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:32:10 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 03:32:10 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 03:32:10 INFO - Using env: {'DISPLAY': ':0', 03:32:10 INFO - 'HOME': '/home/cltbld', 03:32:10 INFO - 'LANG': 'en_US.UTF-8', 03:32:10 INFO - 'LANGUAGE': 'en_US:en', 03:32:10 INFO - 'LOGNAME': 'cltbld', 03:32:10 INFO - 'MAIL': '/var/mail/cltbld', 03:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:10 INFO - 'MOZ_NO_REMOTE': '1', 03:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:10 INFO - 'NO_EM_RESTART': '1', 03:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:10 INFO - 'PWD': '/builds/slave/test', 03:32:10 INFO - 'SHELL': '/bin/bash', 03:32:10 INFO - 'SHLVL': '1', 03:32:10 INFO - 'TERM': 'linux', 03:32:10 INFO - 'TMOUT': '86400', 03:32:10 INFO - 'USER': 'cltbld', 03:32:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:10 INFO - '_': '/tools/buildbot/bin/python'} 03:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 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)) 03:32:10 INFO - Cleaning up... 03:32:10 INFO - Return code: 0 03:32:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:10 INFO - Using env: {'DISPLAY': ':0', 03:32:10 INFO - 'HOME': '/home/cltbld', 03:32:10 INFO - 'LANG': 'en_US.UTF-8', 03:32:10 INFO - 'LANGUAGE': 'en_US:en', 03:32:10 INFO - 'LOGNAME': 'cltbld', 03:32:10 INFO - 'MAIL': '/var/mail/cltbld', 03:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:10 INFO - 'MOZ_NO_REMOTE': '1', 03:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:10 INFO - 'NO_EM_RESTART': '1', 03:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:10 INFO - 'PWD': '/builds/slave/test', 03:32:10 INFO - 'SHELL': '/bin/bash', 03:32:10 INFO - 'SHLVL': '1', 03:32:10 INFO - 'TERM': 'linux', 03:32:10 INFO - 'TMOUT': '86400', 03:32:10 INFO - 'USER': 'cltbld', 03:32:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:10 INFO - '_': '/tools/buildbot/bin/python'} 03:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:10 INFO - Cleaning up... 03:32:10 INFO - Return code: 0 03:32:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6586835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, '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': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', '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 03:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:32:10 INFO - Using env: {'DISPLAY': ':0', 03:32:10 INFO - 'HOME': '/home/cltbld', 03:32:10 INFO - 'LANG': 'en_US.UTF-8', 03:32:10 INFO - 'LANGUAGE': 'en_US:en', 03:32:10 INFO - 'LOGNAME': 'cltbld', 03:32:10 INFO - 'MAIL': '/var/mail/cltbld', 03:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:10 INFO - 'MOZ_NO_REMOTE': '1', 03:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:10 INFO - 'NO_EM_RESTART': '1', 03:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:10 INFO - 'PWD': '/builds/slave/test', 03:32:10 INFO - 'SHELL': '/bin/bash', 03:32:10 INFO - 'SHLVL': '1', 03:32:10 INFO - 'TERM': 'linux', 03:32:10 INFO - 'TMOUT': '86400', 03:32:10 INFO - 'USER': 'cltbld', 03:32:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:10 INFO - '_': '/tools/buildbot/bin/python'} 03:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:10 INFO - Downloading/unpacking flake8 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:13 INFO - no previously-included directories found matching 'docs/_build' 03:32:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:13 INFO - Running setup.py install for pep8 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:13 INFO - no previously-included directories found matching 'docs/_build' 03:32:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:13 INFO - Cleaning up... 03:32:13 INFO - Return code: 0 03:32:13 INFO - Running post-action listener: _resource_record_post_action 03:32:13 INFO - Running post-action listener: _start_resource_monitoring 03:32:13 INFO - Starting resource monitoring. 03:32:13 INFO - ##### 03:32:13 INFO - ##### Finished create-virtualenv step (success) 03:32:13 INFO - ##### 03:32:13 INFO - ##### 03:32:13 INFO - ##### Running install step. 03:32:13 INFO - ##### 03:32:13 INFO - Running pre-action listener: _resource_record_pre_action 03:32:13 INFO - Running main action method: install 03:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:14 INFO - Reading from file tmpfile_stdout 03:32:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:14 INFO - Reading from file tmpfile_stdout 03:32:14 INFO - Output received: 03:32:14 INFO - Usage: mozinstall [options] installer 03:32:14 INFO - Options: 03:32:14 INFO - -h, --help show this help message and exit 03:32:14 INFO - -d DEST, --destination=DEST 03:32:14 INFO - Directory to install application into. [default: 03:32:14 INFO - "/builds/slave/test"] 03:32:14 INFO - --app=APP Application being installed. [default: firefox] 03:32:14 INFO - mkdir: /builds/slave/test/build/application 03:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:32:29 INFO - Reading from file tmpfile_stdout 03:32:29 INFO - Output received: 03:32:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:29 INFO - Running post-action listener: _resource_record_post_action 03:32:29 INFO - ##### 03:32:29 INFO - ##### Finished install step (success) 03:32:29 INFO - ##### 03:32:29 INFO - ##### 03:32:29 INFO - ##### Running run-tests step. 03:32:29 INFO - ##### 03:32:29 INFO - Running pre-action listener: _resource_record_pre_action 03:32:29 INFO - Running main action method: run_tests 03:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:29 INFO - Python 2.7.3 03:32:29 INFO - Return code: 0 03:32:29 INFO - grabbing minidump binary from tooltool 03:32:29 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')]} 03:32:29 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 0x210e1c0>, '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 0x210f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:29 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 03:32:29 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 03:32:29 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 03:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:29 INFO - Return code: 0 03:32:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:30 INFO - Return code: 0 03:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 03:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test', 03:32:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466677726.819464-806118363', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:32:31 INFO - mozversion application_buildid: 20160623004024 03:32:31 INFO - mozversion application_changeset: 08127897283dd05ae78e32ed71ce727bdb39285c 03:32:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:31 INFO - mozversion application_name: Firefox 03:32:31 INFO - mozversion application_remotingname: firefox-dev 03:32:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:31 INFO - mozversion application_vendor: Mozilla 03:32:31 INFO - mozversion application_version: 49.0a2 03:32:31 INFO - mozversion platform_buildid: 20160623004024 03:32:31 INFO - mozversion platform_changeset: 08127897283dd05ae78e32ed71ce727bdb39285c 03:32:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:31 INFO - mozversion platform_version: 49.0a2 03:32:31 INFO - using testdate: 1466677951 03:32:31 INFO - actual date: 1466677951 03:32:31 INFO - starting webserver on 'localhost:48085' 03:32:31 INFO - SUITE-START | Running 2 tests 03:32:31 INFO - TEST-START | dromaeo_css 03:32:31 INFO - operating with platform_type : linux_ 03:32:31 INFO - Initialising browser for dromaeo_css test... 03:32:31 INFO - TEST-INFO | started process 9107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7apvoZ/profile http://localhost:48085/getInfo.html) 03:32:35 INFO - PROCESS | 9107 | __metrics Screen width/height:1600/1200 03:32:35 INFO - PROCESS | 9107 | colorDepth:24 03:32:35 INFO - PROCESS | 9107 | Browser inner width/height: 1024/697 03:32:35 INFO - PROCESS | 9107 | __metrics 03:32:36 ERROR - PROCESS | 9107 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:32:36 INFO - PROCESS | 9107 | console.error: PushService: 03:32:36 INFO - PROCESS | 9107 | stateChangeProcessEnqueue: Error transitioning state 03:32:36 INFO - PROCESS | 9107 | UnknownError 03:32:37 INFO - TEST-INFO | 9107: exit 0 03:32:37 INFO - Browser initialized. 03:32:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:37 INFO - TEST-INFO | started process 9196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7apvoZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:49 INFO - PROCESS | 9196 | RSS: Main: 145002496 03:32:49 INFO - PROCESS | 9196 | 03:33:40 INFO - PROCESS | 9196 | 1466678020468 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] 03:35:48 INFO - PROCESS | 9196 | Cycle 1(1): loaded http://localhost:48085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48085/tests/dromaeo/cssquery-ext.html) 03:35:49 INFO - PROCESS | 9196 | RSS: Main: 255918080 03:35:49 INFO - PROCESS | 9196 | 03:38:51 INFO - PROCESS | 9196 | Cycle 1(1): loaded http://localhost:48085/tests/dromaeo/cssquery-ext.html (next: http://localhost:48085/tests/dromaeo/cssquery-jquery.html) 03:38:52 INFO - PROCESS | 9196 | RSS: Main: 224768000 03:38:52 INFO - PROCESS | 9196 | 03:41:54 INFO - PROCESS | 9196 | Cycle 1(1): loaded http://localhost:48085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48085/tests/dromaeo/cssquery-mootools.html) 03:41:55 INFO - PROCESS | 9196 | RSS: Main: 219103232 03:41:55 INFO - PROCESS | 9196 | 03:44:56 INFO - PROCESS | 9196 | Cycle 1(1): loaded http://localhost:48085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48085/tests/dromaeo/cssquery-prototype.html) 03:44:57 INFO - PROCESS | 9196 | RSS: Main: 222294016 03:44:57 INFO - PROCESS | 9196 | 03:47:59 INFO - PROCESS | 9196 | Cycle 1(1): loaded http://localhost:48085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48085/tests/dromaeo/cssquery-yui.html) 03:48:00 INFO - PROCESS | 9196 | RSS: Main: 218902528 03:48:00 INFO - PROCESS | 9196 | 03:51:02 INFO - PROCESS | 9196 | Cycle 1(1): loaded http://localhost:48085/tests/dromaeo/cssquery-yui.html (next: http://localhost:48085/tests/dromaeo/cssquery-dojo.html) 03:51:03 INFO - PROCESS | 9196 | RSS: Main: 258412544 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | __start_tp_report 03:51:03 INFO - PROCESS | 9196 | _x_x_mozilla_page_load 03:51:03 INFO - PROCESS | 9196 | _x_x_mozilla_page_load_details 03:51:03 INFO - PROCESS | 9196 | |i|pagename|runs| 03:51:03 INFO - PROCESS | 9196 | |0;dojo.html;3346.263821959169;3363.192833719908;3380.239446124621;3380.4084285250083;3414.982925085376;5573.47052030057;5666.886662266752;5672.886542269162;5688.260526131608;5690.231818704474;5517.834464966048;5587.972060139704;5593.8601534961645;5595.776168953237;5601.271834661488;5005.224190250498;5054.393472783271;5066.746662666861;5068.645194836345;5117.181250999841;5134.794608215667;5183.688978661274;5185.118529849935;5187.714675692835;5192.40287366952;5067.087924173666;5092.567131793802;5108.6168537359845;5132.820351287705;5142.845714628548;5183.844484665466;5210.296609957645;5212.192110222922;5212.244224587452;5245.134552798783;4987.526185012418;5020.146575082244;5029.371328583927;5108.3359163308905;5115.258287548322;5481.506664400223;5497.47773961477;5524.392316845144;5558.055130627803;5559.027170245231;6068.264241616243;6081.726322315506;6098.817035488898;6099.57302988791;6102.420270074336;5988.461038506555;6041.516678665696;6050.42520960508;6075.197264466469;6102.21509212113;5647.717614119278;5695.45893140151;5706.429357064302;5706.486416222477;5713.885722285572;5934.198883150806;6187.752489900444;6191.783287584913;6192.349803270682;6196.504279657616;5823.330317013513;5884.764609415575;5885.852853678607;5948.167256584082;5985.610935289193;6040.275166979991;6051.364606716232;6068.666223357758;6073;6076.908846367308;5788.565857560699;5901.232839730807;6005.939940600538;6014.0377539593455;6018.8194354169445;5970.9701451492465;6003.6397816131175;6031.60794548353;6034.306054803754;6070.696465176724;4528.841490547815;4548.545145485491;4567.611753001032;4571.9314210286875;4584.679072464895;4031.0930040741187;4063.349864021742;4073.6333729964445;4075.816588253536;4113.4446849675505;5701.4013528579735;5728.312602487645;5733.684647344436;5737.139429085671;5755.59710820247;6017.729202185912;6068.241469816273;6075.33171351151;6076.908846367308;6099.69501524922;5539.335279766454;5649.4633009864;5660.037793575102;5661.46216109469;5729.169270455761;5161.406438259573;5167.560757335594;5169.560587350042;5181.1969144782615;5187.118189907725;6278.340774218733;6286.717097730613;6289.276733175743;6309.085182648582;6310.873782524415;5818.127280907897;5912.911306330322;5969.462748352669;6014.518838492822;6017.458428741435;6165.445109940127;6195.845103872439;6198.876022479615;6205.317415084247;6217.689115544114;5774.9133762994425;5864.354920958776;5878.147668588116;5892.204552385373;5894.852628684317;5979.820605381846;5980.910286345621;6018.638881667114;6069.180660610938;6090.23872015998;5865.5600829937075;5902.734376952962;5905.202797622438;5909.202257695328;5912.852178695567;5681.948839464712;5747.224124743107;5879.176915231786;5914.378990205966;5940.524758019435;5726.112452569859;5757.193992840922;5803.65178089316;5810.448007439287;5844.824655260349;5883.588148829541;5901.05583106718;5902.2327097477055;5937.821865344046;5953.1070339449425;5579.19101730255;5711.314642242791;5714.8571285716525;5787.826365209051;5806.912896306643 03:51:03 INFO - PROCESS | 9196 | |1;ext.html;615.7906311853968;649.6816559885656;656.2977613953069;668.1447746883987;668.8762878364346;34047.659523404756;46992.76503617482;47883.52116478834;47911.5208847911;47963;48662.27006594904;48937.26594101091;49235.50764492354;49502.50497495024;49521.25718114231;8305.086440491541;9064.002959674446;9235.353525253235;9239.58421871014;10099.747506312364;10516.789664206712;10977.560897564088;10986.066184374338;10988.615398461056;10991.06575941046;10580.206484513692;10595.417252051135;10628.043476087189;10635.096016838577;10635.415052172128;8401.3698972577;10916.672499825017;10925.399103049329;11112.333260004345;11134.10927125828;10531.578736850517;10926.453677316102;10929.836052459219;10935.56257749689;10947.069499092508;43993.78003109996;44280.778596107135;44451.333230001575;44590.33114503285;44749.552504474865;3595.928081438383;3708.42519409492;3721.5720192177973;3978.562358140602;4485.058137791068;31327;31400.528992065138;31505;31693.52459713106;31738.523922141187;4761.285807128924;4762.6904251223905;4793.616510679172;4819.807207711722;4820.39745031871;412279;414462;416896;417300;417689;39119.217615647525;40005.19989600192;67862;67986.32013679898;68626;41116.17767644631;41145.177096457905;41224.58775412267;41284;41337.1732565353;16050.759238611197;16171.272292746855;16180.838191617933;16192;16199.919000404923;11857.762844743056;12099.879001209874;12289.016878649687;12296.20074695142;12761.808572871414;9326.533673316308;9331.253499720142;9340.112689294507;9355.391899526508;9408.529573521297;3435.879744208941;3487.2851065532013;3535.52270443492;3556.448750443685;3576.8748093816594;1065.387402243713;1092.7978324010085;1123.326004397355;1198.3169593331718;1225.307701148848;34841.12897177591;34926.82536587301;35128.29743405118;35138.29723405518;35153.296934061684;1158.25871442277;1164;1169.041386063437;1240.7332423528985;1249.1630607493003;17658.205380757896;18236.908815455838;18364.908175459037;18462.630747384977;18520.722189167172;579158;580967;582256;582433;584772;65351.67324163444;65896.34103658902;65989;65991;66066.33933660698;1366.5217173989024;1401.726663300667;1402.705431859321;1458.3437453145914;1462;32611.34777304393;35249;35897.28205435929;35973.64026359703;36020.81989590035;56165.15752263801;57123;57130;57255.71372143113;57335.42664573301;414115;418495;419200;419425;419502;28340.433191335644;30018.549721753756;30801.691983079883;31300.843495782374;31541.211469713442;53088.469115308355;53146.73426632842;53505.7324713374;53777.73111134419;54127.72936135294;44900.326495101945;45213.32180017368;45250.54749452463;46062;46308.30537542007;44165.11669766651;44403.77798110989;44485.33272000987;45736.54263457456;45877.770611146734;44879.551204487536;45328.77335613301;46703.766481167375;46803.29795053145;47912.520874790804;38149.80925095357;39794;40167;40342.59657403389;40929.38605920973;30335;30382.848085760314;31037;31079.378412432077;31086.222844428165 03:51:03 INFO - PROCESS | 9196 | |2;jquery.html;414.4881071876233;415.5304505908323;418.73410384405895;421.0757387534362;437.34180059011186;18762.2495100196;19668.409947701555;19962.101705423273;20103.899480502594;20135.59728805423;19300.903495482537;19456.902715486438;19473.610527789435;19707;19738.605227895434;5609.38296787352;5848.327442344121;5889.911651325234;5896.587238893279;5898.557608179382;4276.914461710764;5095.898082038357;5860.443257890493;5907.143464197688;6644.833879153011;6518.93481065188;6528.51036172289;6546.18172728409;6559.212894452672;6563.1796025496815;6417.262014868304;6449.967750161266;6475.417212450902;6477.190351206099;6487.481001519891;3878.2437424702193;5441.918371224435;5735.4551317624755;5803.21656576361;5806.477417032445;22998.08007679691;23199.76800231993;23207.187748428725;23659.88170059156;23680.763192368202;2366.9881650591637;2429.1619391310146;2519.307190522621;2535.239428171541;2723.700392956793;14526.709465810625;14633.341499632543;14670;14875.47935822241;15121.16833574153;1898.943031709051;1920.4430715092747;1937.2832052140657;1943.9708404373946;1952.6094781043848;77898;79589.99999999942;80206.59896700479;80765.19234807695;80814;10387.428691421894;10499.895001049892;10699.89300106989;10730.19523535738;10838;13953.302334883418;13969.371378288002;13978.370973306226;13988.58034258974;14031.087979281314;7926.603669816486;8128.943237379103;8148.26665600087;8305.750827475185;8306.169383061646;7906.248906353887;7954.602269886483;7975.282224599814;8011.238932301422;8059.234372734581;6505.284418713938;6632.369924857131;6670.899936500859;6671.5997040177745;6685.156610485653;2003.9522944161533;2024.4736368544284;2061.2167376396874;2061.2579471390286;2072.3161356752234;973.9610415583297;1007.3250921882357;1017.0693815159046;1025.410389026313;1097.3470784882982;18747.906260468884;19420;19649.410517684493;19811.50471238202;20542.17831286732;1038.5170895533613;1051.6792378324685;1077.5217000897903;1098.2202636128438;1124.887511248885;10403.687889363331;10716.624918127829;10787.946060269649;10892.292001019909;10929.617463388744;501262;503391;542214;570540;576728;61021.694891526146;81633;95416;98093.5095324533;98897;1088.8094583447864;1100.6697990602788;1103.8675358956816;1113.432149603708;1113.7382715061954;13156.342182890625;16713.331466741194;17444.21501032431;17855.821441785414;17924.641507170043;40489;43148.352774707775;43542.56457435385;43689;44943.1011379764;61904;62223.6888815553;63228;67046.32953670401;67058.66470667615;7708.229177082247;7836.804079898048;8078.676852926053;8138.755837324889;8810.766492691157;13052.34738263064;13550.728985420434;13667.658308542366;14011.299435028004;14417.855821441652;6236.376362363727;7017.684204210925;11695.538057742782;12386.5664701735;12590.93704531508;12368.877405684243;12426.937865310616;12449.25304481734;12659.620211393672;12805.487780488676;11291.3789741565;11688.766224675288;12524.248545087325;12606.369681515704;12796.296203708886;8651.351148663749;8693.304535637008;8725.52009639476;8748.65005399777;9075.2286055686;8707.346948978726;10939.890601093886;11247.718807029889;11440.599579014695;12409.689757756129 03:51:03 INFO - PROCESS | 9196 | |3;mootools.html;1371.9657008574777;1513.2282535906688;1571.4814111343255;1744.7295669171274;1879.0886420086247;9186.816263674722;9516.666916657918;9537.90462095378;9766.072223138808;9826.557804898779;9581.137697607213;9735.415875047502;9736.610535578568;9748.658796942109;9757.902420975788;2444.2789377133745;2464.2360868130845;2465.2973902437807;2467.3091534370405;2469.148143890364;2392.102961389479;2436.987815060931;2456.9631455528183;2458.704955405345;2460.3849037740565;2409.0604664180983;2425.7695518925675;2491.2152671908293;2500.599904015358;2505.1607711416605;2320.396696858812;2360.0913648245464;2369.5853225685437;2377.132346693462;2391.366287933699;2284.303287497313;2323.93028209154;2326.999390262187;2331.953360932772;2332.93001209964;8109.75670729879;9209.539523023888;9661.71014869555;9696.70909872705;9712.61149554024;5471.7264136793;5689.317281926154;5706.686132262724;5708.828735137952;5712.457316554921;3380.408428525023;3398.7790793598338;3475.5308033415417;3477.0959550516795;3550.6271841456532;1150.246588484544;1173.4074292482242;1190.8749581294012;1219.3842109734528;2308;13378.598642040753;13979.860201397958;13990.930045349809;13996.650083747885;14015.719685606231;4735.2423612222565;4767.188468382062;4793.808247670124;4810.831620893252;4882.438519570295;10734.78530429387;10798.838017429745;10800.945995269973;10818.783624327469;10820.296680715886;5622.044252477089;5626.831195064155;5627.8593035174445;5630.042892708249;5630.127330263816;5078.97460512695;5197.272381866542;5201.479852014768;5218.034663587173;5281.973590132025;3730.123420996064;3761.191343861083;3783.5270591176104;3832.405977073558;3833.463315135883;1068.4871261794383;1084.9457527123611;1093.6554985179644;1100.0429626225075;1100.5033154909318;940.5297351324338;1051.353417648141;1053.1995683280609;1081.432248069754;1088.9618863339745;6411.166548348778;6423.614583125028;6500.089987401768;6504.447121994684;6643.30245324234;437.4400767018222;444.32019010913353;444.37343345882795;444.87098741365287;447.05671034117984;4409.316555933835;4555.521670224579;4572.7713614319155;4673.415823022122;4707.529247075265;11988.400579971141;12112;12222.449989750483;12390.3185324808;12405.875941240472;11893.583724569598;12288.324142172267;12337.814932776015;12344.197627154206;12349.506019759288;8798.252148567444;8821;8838.690645827364;9310.534473276444;9337.253019758538;6432.163818703539;6572.047053177358;6591.967040164768;6715.3620406061345;6731.158605174353;10893.455327233449;11145.777084458428;11280.09759219244;11406.942965285121;11408.630964284008;11275.436228188722;11409.030232430336;11455.427228638702;11557;11699.590514331958;8079.111297757125;8081.676732930617;8121.75634730959;8160.673573057249;8163.877541836759;8894.33292503052;9026.052264512131;9057.456552606865;9062.22971047442;9067.183953444222;8440.53577053268;8622.26710729595;8625.094365091574;8854.29165666758;8883.244924181517;8244.958775206085;8408.621612027597;8427.95786021066;8447.281981031681;8721.781955451164;7117.110361204849;7340.96329518349;7353.77938661841;7489.251074892467;7490.325870671666;5617.269754931833;5794.594378393472;5877.4122587740885;5962.9105563415715;5967.194428752063;5751.137329400456;5752.108423194411;5806.82579522615;5825.970870145622;5908.3796201399955 03:51:03 INFO - PROCESS | 9196 | |4;prototype.html;328.6450633316018;333.77136661386953;337.71631829263424;339.9456087026076;340.657639072732;5523.530499907508;5567.805126820557;5579.33048034236;5580.162975553659;5580.386157522669;5467.726613669321;5487.777450132693;5517.730921887968;5517.751701173447;5549.556035517159;4134.772587507693;4136.379543068549;4309.590588894066;4311.030018245885;4324.956750432487;4258.957410425887;4274.850380236692;4277.401163837066;4301.26878430666;4316.136772645484;4097.713160078795;4267.423897773808;4270.743755374688;4284.764337961411;4288.641247313981;3996.860109896169;4200.222958752625;4266.957330426687;4267.210566045292;4268.59448352406;3766.832281992591;3771.9622803771886;3788.1855401088897;3801.182745709658;3804.1821008483034;5169.302144210558;5273.393559740641;5285.022270879899;5301.224089929879;5311.973440132813;4888.193448081062;4892.19278818998;4909.435414927258;4921.384826896638;4937.925931111036;5669.518090962273;5712.571557133231;5713.657180569137;5753.309602847643;5779.1620215069;4027.1744292419985;4178.206140833232;4189.581041895816;4190.120074784299;4204.747715137101;5966.612170208966;5970.432808883149;5997.160397544348;6009.909851352233;6030.396960303979;4293.69944103916;4308.66431406265;4310.784460776948;4324.8486302979245;4334.133173365277;4018.6985976051915;4331.6534677225745;4340.175366680321;4354.238008348526;4374.475062992461;4882.26765985098;4906.632002599819;4907.190313598217;4910;4920.114379411669;5830.854228644318;5840.328362238312;5855.209546711225;5862.941370586324;5870.383609721003;1414.7241287948957;1455.396010655566;1457.4024649893704;1465.728840164573;1468.2218424235173;905.3571963905569;922.2898368256405;926.5737760630186;968.7820240445984;1002.4185972136144;5493.862653433696;5508.91736623951;5524.364698059694;5527.55779537636;5548.528375088082;5840.678762668094;5851.64890106595;5866.354700982888;5889.705514724246;5896.852578685567;5378.354597448331;5483.533899618497;5531.1426728857095;5559.972200139055;5614.550835933115;3105.4254962831947;3131.373725254958;3142.71715545602;3153.810771353726;3157.7842530625417;5914.3439836845755;6000.279966403972;6029.6683682397015;6047.909281360783;6118.3269840317525;5985.132155837379;6000.159977603139;6013.278406591149;6013.639181649115;6017.405387572209;6040.345590917432;6057.939420605914;6113.816585502442;6114.633122012693;6117.632942023404;5692.31692196939;5822.359540450462;5856.824295271149;5860.413958604106;5877.647341159544;5744.368119506935;5757.884842303047;5760.8271751847515;5778.8266352009505;5810.4189581041555;5843.444872737083;5979.940200597938;6059.697015149313;6064.666443345658;6078.878422431615;4094.3244364680686;4140.91718165641;4172.749635021908;4190.958090419057;4205.810738516835;5882.058870580687;5903.734331955158;5922.200502932049;5928.229330187048;5929.377415371324;5445.074337362737;5695.971520142372;5723.656580605177;5733.111367738007;5807.564432667482;5678.971605141948;5681.77272909079;5685.8862822742485;5688;5696.715164241854;5507.8984203158725;5509.338879334506;5638.746256418389;5651.350094739158;5752.913706294493;5812.157237200667;5841.474267315962;5843.386444423444;5848.356680765198;5857.736401861841;5481.068218402801;5632.873425314871;5674.432556744293;5705.172749951317;5730.770769169187 03:51:03 INFO - PROCESS | 9196 | |5;yui.html;798.7523867601047;798.9720359787409;808.1595141053305;822.8354329134173;905.6830109461687;13908.582742517729;14596.854031459708;14681.559553213407;15178.544643660694;15213.315400806963;14924.776128358084;14967.92516037421;15058.171800550965;15073.39706411745;15077.246137693126;723.8769409200448;850.1880703927765;859.9441036332634;867.0679020053436;872.4808738800403;865.5023361567092;866.1208872993916;869.1178453869328;869.3436455476138;869.3697069624535;920.5029284186564;921.3964853021282;922.0825278847523;922.2621902478024;922.4557511068468;753.5968256982516;866.1857853617611;895.0959530873799;896.3770179725094;913.456493386434;660.9603423794588;660.9702563384659;661.077796473921;661.3948237362807;661.6294874870088;13689;13728.313584320844;13743.175409475463;13753;13755.518556850562;14336.139831610137;14598.92700536501;14825.851741482555;14859.628509287246;14962.47631332909;12479.251244925243;12619.558315458915;12730.681732956658;12809.231446113263;13044;4587.977060114711;4606.101810147023;4611.631069514431;4616.838410655644;4654.464736555272;66035.66982165059;75065.24934750637;75103.62448187779;75188.62405687991;75307.62346188289;10874.619388321371;11281.477000604813;11622.360770157722;11667;11792.58725944605;20748.170073197205;20790.896045519676;20799;20820.958952052337;20839.687404688942;9325.533723313943;9368.203702685349;9387.62449502026;9476.241900647932;9690.37012594179;5042.369703787027;5099.260607211933;5164.9741751291;5193.454687257859;5321.547668448148;3513.648635136466;3592.586852511942;3626.0028492164865;3626.6917312028245;3629.183433727443;671.9126513553207;682.0723815610766;689.0387908867102;710.8720430322488;729.5768454296496;674.942629876466;722.3679280629449;749.3817600479626;757.806759276392;771.267296068737;10144.695659130239;10333.22500812442;10367.429791361548;10426.426546540013;10466;689.9655017249218;693.9722411103601;712.5510928115255;724.0334153904491;725.6734469488752;4781.282807578891;4881.731504767272;4947.233178857283;4955.380577427822;5006.849794506171;128007.35996320145;128746.35626821993;130214.34892825475;134283;138218.6158089239;113013;114947;116387;116997.4150129244;117498.41250793691;91967.54016229876;101916.49041754744;102871.48564257131;104475.47762261292;105138;8799.560021998746;9107.271418286653;9130.771730706785;9200.171984521157;9244.445333280024;56962.430375695716;58777.4122258772;59815;60155.097673535805;60432;51573.7421312906;51704;61367.693161535695;90052;90579;11310.4910279036;11318.094552435621;11383.487743051417;11599.88400115988;11754.177207595387;13266.602001939957;13433.932830335785;13557.118787278796;13655.04414690962;13997.790033149715;11032.944835276094;12680.492780288685;12770.744585108432;12890.29103399322;13009.284489353176;11941.104417168573;12343.876561234272;12481.875181248071;13017.609471715863;13618.18290902549;12560.811587826007;12956.870431295567;13336.333183340601;13405;13741.793873091712;11090.223684342018;11664.825027624423;11728.354940478355;11729.589464368706;11927.10546708983;10908.454577270946;11396.202265841643;11529.365884876077;11565.363904985306;11597.884021160018 03:51:03 INFO - PROCESS | 9196 | __end_tp_report 03:51:03 INFO - PROCESS | 9196 | __start_cc_report 03:51:03 INFO - PROCESS | 9196 | _x_x_mozilla_cycle_collect,880 03:51:03 INFO - PROCESS | 9196 | __end_cc_report 03:51:03 INFO - PROCESS | 9196 | __startTimestamp1466679063182__endTimestamp 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | ------- Summary: start ------- 03:51:03 INFO - PROCESS | 9196 | Number of tests: 6 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | [#0] dojo.html Cycles:165 Average:5587.81 Median:5774.91 stddev:626.32 (10.8%) stddev-sans-first:603.05 03:51:03 INFO - PROCESS | 9196 | Values: 3346.3 3363.2 3380.2 3380.4 3415.0 5573.5 5666.9 5672.9 5688.3 5690.2 5517.8 5588.0 5593.9 5595.8 5601.3 5005.2 5054.4 5066.7 5068.6 5117.2 5134.8 5183.7 5185.1 5187.7 5192.4 5067.1 5092.6 5108.6 5132.8 5142.8 5183.8 5210.3 5212.2 5212.2 5245.1 4987.5 5020.1 5029.4 5108.3 5115.3 5481.5 5497.5 5524.4 5558.1 5559.0 6068.3 6081.7 6098.8 6099.6 6102.4 5988.5 6041.5 6050.4 6075.2 6102.2 5647.7 5695.5 5706.4 5706.5 5713.9 5934.2 6187.8 6191.8 6192.3 6196.5 5823.3 5884.8 5885.9 5948.2 5985.6 6040.3 6051.4 6068.7 6073.0 6076.9 5788.6 5901.2 6005.9 6014.0 6018.8 5971.0 6003.6 6031.6 6034.3 6070.7 4528.8 4548.5 4567.6 4571.9 4584.7 4031.1 4063.3 4073.6 4075.8 4113.4 5701.4 5728.3 5733.7 5737.1 5755.6 6017.7 6068.2 6075.3 6076.9 6099.7 5539.3 5649.5 5660.0 5661.5 5729.2 5161.4 5167.6 5169.6 5181.2 5187.1 6278.3 6286.7 6289.3 6309.1 6310.9 5818.1 5912.9 5969.5 6014.5 6017.5 6165.4 6195.8 6198.9 6205.3 6217.7 5774.9 5864.4 5878.1 5892.2 5894.9 5979.8 5980.9 6018.6 6069.2 6090.2 5865.6 5902.7 5905.2 5909.2 5912.9 5681.9 5747.2 5879.2 5914.4 5940.5 5726.1 5757.2 5803.7 5810.4 5844.8 5883.6 5901.1 5902.2 5937.8 5953.1 5579.2 5711.3 5714.9 5787.8 5806.9 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | [#1] ext.html Cycles:180 Average:63692.71 Median:40635.99 stddev:126940.37 (312.4%) stddev-sans-first:127208.13 03:51:03 INFO - PROCESS | 9196 | Values: 615.8 649.7 656.3 668.1 668.9 34047.7 46992.8 47883.5 47911.5 47963.0 48662.3 48937.3 49235.5 49502.5 49521.3 8305.1 9064.0 9235.4 9239.6 10099.7 10516.8 10977.6 10986.1 10988.6 10991.1 10580.2 10595.4 10628.0 10635.1 10635.4 8401.4 10916.7 10925.4 11112.3 11134.1 10531.6 10926.5 10929.8 10935.6 10947.1 43993.8 44280.8 44451.3 44590.3 44749.6 3595.9 3708.4 3721.6 3978.6 4485.1 31327.0 31400.5 31505.0 31693.5 31738.5 4761.3 4762.7 4793.6 4819.8 4820.4 412279.0 414462.0 416896.0 417300.0 417689.0 39119.2 40005.2 67862.0 67986.3 68626.0 41116.2 41145.2 41224.6 41284.0 41337.2 16050.8 16171.3 16180.8 16192.0 16199.9 11857.8 12099.9 12289.0 12296.2 12761.8 9326.5 9331.3 9340.1 9355.4 9408.5 3435.9 3487.3 3535.5 3556.4 3576.9 1065.4 1092.8 1123.3 1198.3 1225.3 34841.1 34926.8 35128.3 35138.3 35153.3 1158.3 1164.0 1169.0 1240.7 1249.2 17658.2 18236.9 18364.9 18462.6 18520.7 579158.0 580967.0 582256.0 582433.0 584772.0 65351.7 65896.3 65989.0 65991.0 66066.3 1366.5 1401.7 1402.7 1458.3 1462.0 32611.3 35249.0 35897.3 35973.6 36020.8 56165.2 57123.0 57130.0 57255.7 57335.4 414115.0 418495.0 419200.0 419425.0 419502.0 28340.4 30018.5 30801.7 31300.8 31541.2 53088.5 53146.7 53505.7 53777.7 54127.7 44900.3 45213.3 45250.5 46062.0 46308.3 44165.1 44403.8 44485.3 45736.5 45877.8 44879.6 45328.8 46703.8 46803.3 47912.5 38149.8 39794.0 40167.0 40342.6 40929.4 30335.0 30382.8 31037.0 31079.4 31086.2 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | [#2] jquery.html Cycles:180 Average:30584.71 Median:13023.88 stddev:88706.73 (681.1%) stddev-sans-first:88926.64 03:51:03 INFO - PROCESS | 9196 | Values: 414.5 415.5 418.7 421.1 437.3 18762.2 19668.4 19962.1 20103.9 20135.6 19300.9 19456.9 19473.6 19707.0 19738.6 5609.4 5848.3 5889.9 5896.6 5898.6 4276.9 5095.9 5860.4 5907.1 6644.8 6518.9 6528.5 6546.2 6559.2 6563.2 6417.3 6450.0 6475.4 6477.2 6487.5 3878.2 5441.9 5735.5 5803.2 5806.5 22998.1 23199.8 23207.2 23659.9 23680.8 2367.0 2429.2 2519.3 2535.2 2723.7 14526.7 14633.3 14670.0 14875.5 15121.2 1898.9 1920.4 1937.3 1944.0 1952.6 77898.0 79590.0 80206.6 80765.2 80814.0 10387.4 10499.9 10699.9 10730.2 10838.0 13953.3 13969.4 13978.4 13988.6 14031.1 7926.6 8128.9 8148.3 8305.8 8306.2 7906.2 7954.6 7975.3 8011.2 8059.2 6505.3 6632.4 6670.9 6671.6 6685.2 2004.0 2024.5 2061.2 2061.3 2072.3 974.0 1007.3 1017.1 1025.4 1097.3 18747.9 19420.0 19649.4 19811.5 20542.2 1038.5 1051.7 1077.5 1098.2 1124.9 10403.7 10716.6 10787.9 10892.3 10929.6 501262.0 503391.0 542214.0 570540.0 576728.0 61021.7 81633.0 95416.0 98093.5 98897.0 1088.8 1100.7 1103.9 1113.4 1113.7 13156.3 16713.3 17444.2 17855.8 17924.6 40489.0 43148.4 43542.6 43689.0 44943.1 61904.0 62223.7 63228.0 67046.3 67058.7 7708.2 7836.8 8078.7 8138.8 8810.8 13052.3 13550.7 13667.7 14011.3 14417.9 6236.4 7017.7 11695.5 12386.6 12590.9 12368.9 12426.9 12449.3 12659.6 12805.5 11291.4 11688.8 12524.2 12606.4 12796.3 8651.4 8693.3 8725.5 8748.7 9075.2 8707.3 10939.9 11247.7 11440.6 12409.7 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | [#3] mootools.html Cycles:180 Average:6293.69 Median:4564.15 stddev:3713.60 (81.4%) stddev-sans-first:3705.60 03:51:03 INFO - PROCESS | 9196 | Values: 1372.0 1513.2 1571.5 1744.7 1879.1 9186.8 9516.7 9537.9 9766.1 9826.6 9581.1 9735.4 9736.6 9748.7 9757.9 2444.3 2464.2 2465.3 2467.3 2469.1 2392.1 2437.0 2457.0 2458.7 2460.4 2409.1 2425.8 2491.2 2500.6 2505.2 2320.4 2360.1 2369.6 2377.1 2391.4 2284.3 2323.9 2327.0 2332.0 2332.9 8109.8 9209.5 9661.7 9696.7 9712.6 5471.7 5689.3 5706.7 5708.8 5712.5 3380.4 3398.8 3475.5 3477.1 3550.6 1150.2 1173.4 1190.9 1219.4 2308.0 13378.6 13979.9 13990.9 13996.7 14015.7 4735.2 4767.2 4793.8 4810.8 4882.4 10734.8 10798.8 10800.9 10818.8 10820.3 5622.0 5626.8 5627.9 5630.0 5630.1 5079.0 5197.3 5201.5 5218.0 5282.0 3730.1 3761.2 3783.5 3832.4 3833.5 1068.5 1084.9 1093.7 1100.0 1100.5 940.5 1051.4 1053.2 1081.4 1089.0 6411.2 6423.6 6500.1 6504.4 6643.3 437.4 444.3 444.4 444.9 447.1 4409.3 4555.5 4572.8 4673.4 4707.5 11988.4 12112.0 12222.4 12390.3 12405.9 11893.6 12288.3 12337.8 12344.2 12349.5 8798.3 8821.0 8838.7 9310.5 9337.3 6432.2 6572.0 6592.0 6715.4 6731.2 10893.5 11145.8 11280.1 11406.9 11408.6 11275.4 11409.0 11455.4 11557.0 11699.6 8079.1 8081.7 8121.8 8160.7 8163.9 8894.3 9026.1 9057.5 9062.2 9067.2 8440.5 8622.3 8625.1 8854.3 8883.2 8245.0 8408.6 8428.0 8447.3 8721.8 7117.1 7341.0 7353.8 7489.3 7490.3 5617.3 5794.6 5877.4 5962.9 5967.2 5751.1 5752.1 5806.8 5826.0 5908.4 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | [#4] prototype.html Cycles:180 Average:4840.89 Median:5529.35 stddev:1424.09 (25.8%) stddev-sans-first:1387.23 03:51:03 INFO - PROCESS | 9196 | Values: 328.6 333.8 337.7 339.9 340.7 5523.5 5567.8 5579.3 5580.2 5580.4 5467.7 5487.8 5517.7 5517.8 5549.6 4134.8 4136.4 4309.6 4311.0 4325.0 4259.0 4274.9 4277.4 4301.3 4316.1 4097.7 4267.4 4270.7 4284.8 4288.6 3996.9 4200.2 4267.0 4267.2 4268.6 3766.8 3772.0 3788.2 3801.2 3804.2 5169.3 5273.4 5285.0 5301.2 5312.0 4888.2 4892.2 4909.4 4921.4 4937.9 5669.5 5712.6 5713.7 5753.3 5779.2 4027.2 4178.2 4189.6 4190.1 4204.7 5966.6 5970.4 5997.2 6009.9 6030.4 4293.7 4308.7 4310.8 4324.8 4334.1 4018.7 4331.7 4340.2 4354.2 4374.5 4882.3 4906.6 4907.2 4910.0 4920.1 5830.9 5840.3 5855.2 5862.9 5870.4 1414.7 1455.4 1457.4 1465.7 1468.2 905.4 922.3 926.6 968.8 1002.4 5493.9 5508.9 5524.4 5527.6 5548.5 5840.7 5851.6 5866.4 5889.7 5896.9 5378.4 5483.5 5531.1 5560.0 5614.6 3105.4 3131.4 3142.7 3153.8 3157.8 5914.3 6000.3 6029.7 6047.9 6118.3 5985.1 6000.2 6013.3 6013.6 6017.4 6040.3 6057.9 6113.8 6114.6 6117.6 5692.3 5822.4 5856.8 5860.4 5877.6 5744.4 5757.9 5760.8 5778.8 5810.4 5843.4 5979.9 6059.7 6064.7 6078.9 4094.3 4140.9 4172.7 4191.0 4205.8 5882.1 5903.7 5922.2 5928.2 5929.4 5445.1 5696.0 5723.7 5733.1 5807.6 5679.0 5681.8 5685.9 5688.0 5696.7 5507.9 5509.3 5638.7 5651.4 5752.9 5812.2 5841.5 5843.4 5848.4 5857.7 5481.1 5632.9 5674.4 5705.2 5730.8 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - PROCESS | 9196 | [#5] yui.html Cycles:180 Average:22068.74 Median:3609.29 stddev:33660.82 (932.6%) stddev-sans-first:33717.36 03:51:03 INFO - PROCESS | 9196 | Values: 798.8 799.0 808.2 822.8 905.7 13908.6 14596.9 14681.6 15178.5 15213.3 14924.8 14967.9 15058.2 15073.4 15077.2 723.9 850.2 859.9 867.1 872.5 865.5 866.1 869.1 869.3 869.4 920.5 921.4 922.1 922.3 922.5 753.6 866.2 895.1 896.4 913.5 661.0 661.0 661.1 661.4 661.6 13689.0 13728.3 13743.2 13753.0 13755.5 14336.1 14598.9 14825.9 14859.6 14962.5 12479.3 12619.6 12730.7 12809.2 13044.0 4588.0 4606.1 4611.6 4616.8 4654.5 66035.7 75065.2 75103.6 75188.6 75307.6 10874.6 11281.5 11622.4 11667.0 11792.6 20748.2 20790.9 20799.0 20821.0 20839.7 9325.5 9368.2 9387.6 9476.2 9690.4 5042.4 5099.3 5165.0 5193.5 5321.5 3513.6 3592.6 3626.0 3626.7 3629.2 671.9 682.1 689.0 710.9 729.6 674.9 722.4 749.4 757.8 771.3 10144.7 10333.2 10367.4 10426.4 10466.0 690.0 694.0 712.6 724.0 725.7 4781.3 4881.7 4947.2 4955.4 5006.8 128007.4 128746.4 130214.3 134283.0 138218.6 113013.0 114947.0 116387.0 116997.4 117498.4 91967.5 101916.5 102871.5 104475.5 105138.0 8799.6 9107.3 9130.8 9200.2 9244.4 56962.4 58777.4 59815.0 60155.1 60432.0 51573.7 51704.0 61367.7 90052.0 90579.0 11310.5 11318.1 11383.5 11599.9 11754.2 13266.6 13433.9 13557.1 13655.0 13997.8 11032.9 12680.5 12770.7 12890.3 13009.3 11941.1 12343.9 12481.9 13017.6 13618.2 12560.8 12956.9 13336.3 13405.0 13741.8 11090.2 11664.8 11728.4 11729.6 11927.1 10908.5 11396.2 11529.4 11565.4 11597.9 03:51:03 INFO - PROCESS | 9196 | -------- Summary: end -------- 03:51:03 INFO - PROCESS | 9196 | 03:51:03 INFO - TEST-INFO | 9196: exit 0 03:51:03 INFO - TEST-OK | dromaeo_css | took 1112768ms 03:51:03 INFO - TEST-START | kraken 03:51:03 INFO - operating with platform_type : linux_ 03:51:03 INFO - Initialising browser for kraken test... 03:51:03 INFO - TEST-INFO | started process 9388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdI_jGq/profile http://localhost:48085/getInfo.html) 03:51:07 INFO - PROCESS | 9388 | __metrics Screen width/height:1600/1200 03:51:07 INFO - PROCESS | 9388 | colorDepth:24 03:51:07 INFO - PROCESS | 9388 | Browser inner width/height: 1024/697 03:51:07 INFO - PROCESS | 9388 | __metrics 03:51:08 ERROR - PROCESS | 9388 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:51:09 INFO - PROCESS | 9388 | console.error: PushService: 03:51:09 INFO - PROCESS | 9388 | stateChangeProcessEnqueue: Error transitioning state 03:51:09 INFO - PROCESS | 9388 | UnknownError 03:51:09 INFO - TEST-INFO | 9388: exit 0 03:51:09 INFO - Browser initialized. 03:51:09 INFO - Running cycle 1/1 for kraken test... 03:51:09 INFO - TEST-INFO | started process 9480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdI_jGq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:21 INFO - PROCESS | 9480 | RSS: Main: 145526784 03:51:21 INFO - PROCESS | 9480 | 03:51:24 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48085/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:24 INFO - PROCESS | 9480 | RSS: Main: 194260992 03:51:24 INFO - PROCESS | 9480 | 03:51:27 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48085/tests/kraken/driver.html?testName=audio-dft) 03:51:28 INFO - PROCESS | 9480 | RSS: Main: 193019904 03:51:28 INFO - PROCESS | 9480 | 03:51:30 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48085/tests/kraken/driver.html?testName=audio-fft) 03:51:31 INFO - PROCESS | 9480 | RSS: Main: 278257664 03:51:31 INFO - PROCESS | 9480 | 03:51:33 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48085/tests/kraken/driver.html?testName=audio-oscillator) 03:51:34 INFO - PROCESS | 9480 | RSS: Main: 186875904 03:51:34 INFO - PROCESS | 9480 | 03:51:36 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:36 INFO - PROCESS | 9480 | RSS: Main: 188026880 03:51:36 INFO - PROCESS | 9480 | 03:51:39 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48085/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:40 INFO - PROCESS | 9480 | RSS: Main: 222756864 03:51:40 INFO - PROCESS | 9480 | 03:51:43 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48085/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:44 INFO - PROCESS | 9480 | RSS: Main: 222052352 03:51:44 INFO - PROCESS | 9480 | 03:51:47 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48085/tests/kraken/driver.html?testName=json-parse-financial) 03:51:47 INFO - PROCESS | 9480 | RSS: Main: 222023680 03:51:47 INFO - PROCESS | 9480 | 03:51:49 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:49 INFO - PROCESS | 9480 | RSS: Main: 200724480 03:51:49 INFO - PROCESS | 9480 | 03:51:51 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:52 INFO - PROCESS | 9480 | RSS: Main: 202792960 03:51:52 INFO - PROCESS | 9480 | 03:51:54 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:54 INFO - PROCESS | 9480 | RSS: Main: 209108992 03:51:54 INFO - PROCESS | 9480 | 03:51:57 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:58 INFO - PROCESS | 9480 | RSS: Main: 213090304 03:51:58 INFO - PROCESS | 9480 | 03:52:00 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:01 INFO - PROCESS | 9480 | RSS: Main: 213405696 03:52:01 INFO - PROCESS | 9480 | 03:52:02 INFO - PROCESS | 9480 | Cycle 1(1): loaded http://localhost:48085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48085/tests/kraken/driver.html?testName=ai-astar) 03:52:03 INFO - PROCESS | 9480 | RSS: Main: 255184896 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | __start_tp_report 03:52:03 INFO - PROCESS | 9480 | _x_x_mozilla_page_load 03:52:03 INFO - PROCESS | 9480 | _x_x_mozilla_page_load_details 03:52:03 INFO - PROCESS | 9480 | |i|pagename|runs| 03:52:03 INFO - PROCESS | 9480 | |0;ai-astar;109;103;108;109;109;109;108;108;109;110 03:52:03 INFO - PROCESS | 9480 | |1;audio-beat-detection;149;136;126;183;125;126;155;124;156;131 03:52:03 INFO - PROCESS | 9480 | |2;audio-dft;161;161;159;158;159;160;159;160;159;160 03:52:03 INFO - PROCESS | 9480 | |3;audio-fft;75;75;75;118;76;76;74;75;117;74 03:52:03 INFO - PROCESS | 9480 | |4;audio-oscillator;85;85;114;84;84;85;111;84;84;125 03:52:03 INFO - PROCESS | 9480 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 03:52:03 INFO - PROCESS | 9480 | |6;imaging-darkroom;146;145;146;145;146;146;146;145;146;147 03:52:03 INFO - PROCESS | 9480 | |7;imaging-desaturate;95;96;95;94;95;94;94;94;95;95 03:52:03 INFO - PROCESS | 9480 | |8;json-parse-financial;52;53;50;51;50;50;52;51;51;52 03:52:03 INFO - PROCESS | 9480 | |9;json-stringify-tinderbox;59;60;60;60;60;60;60;59;60;60 03:52:03 INFO - PROCESS | 9480 | |10;stanford-crypto-aes;76;76;77;77;78;78;78;82;106;78 03:52:03 INFO - PROCESS | 9480 | |11;stanford-crypto-ccm;121;121;117;122;123;118;116;123;131;129 03:52:03 INFO - PROCESS | 9480 | |12;stanford-crypto-pbkdf2;156;154;156;154;152;151;152;158;154;153 03:52:03 INFO - PROCESS | 9480 | |13;stanford-crypto-sha256-iterative;62;61;66;61;62;62;65;62;63;59 03:52:03 INFO - PROCESS | 9480 | __end_tp_report 03:52:03 INFO - PROCESS | 9480 | __start_cc_report 03:52:03 INFO - PROCESS | 9480 | _x_x_mozilla_cycle_collect,1575 03:52:03 INFO - PROCESS | 9480 | __end_cc_report 03:52:03 INFO - PROCESS | 9480 | __startTimestamp1466679123175__endTimestamp 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | ------- Summary: start ------- 03:52:03 INFO - PROCESS | 9480 | Number of tests: 14 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:1.93 (1.8%) stddev-sans-first:2.03 03:52:03 INFO - PROCESS | 9480 | Values: 109.0 103.0 108.0 109.0 109.0 109.0 108.0 108.0 109.0 110.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:142.50 stddev:19.35 (13.6%) stddev-sans-first:20.31 03:52:03 INFO - PROCESS | 9480 | Values: 149.0 136.0 126.0 183.0 125.0 126.0 155.0 124.0 156.0 131.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#2] audio-dft Cycles:10 Average:159.60 Median:160.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 03:52:03 INFO - PROCESS | 9480 | Values: 161.0 161.0 159.0 158.0 159.0 160.0 159.0 160.0 159.0 160.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:17.93 (23.9%) stddev-sans-first:18.76 03:52:03 INFO - PROCESS | 9480 | Values: 75.0 75.0 75.0 118.0 76.0 76.0 74.0 75.0 117.0 74.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:15.96 (19.0%) stddev-sans-first:16.59 03:52:03 INFO - PROCESS | 9480 | Values: 85.0 85.0 114.0 84.0 84.0 85.0 111.0 84.0 84.0 125.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:52:03 INFO - PROCESS | 9480 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:52:03 INFO - PROCESS | 9480 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 147.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:52:03 INFO - PROCESS | 9480 | Values: 95.0 96.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:1.03 (2.0%) stddev-sans-first:1.05 03:52:03 INFO - PROCESS | 9480 | Values: 52.0 53.0 50.0 51.0 50.0 50.0 52.0 51.0 51.0 52.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 03:52:03 INFO - PROCESS | 9480 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 60.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:78.00 stddev:9.08 (11.6%) stddev-sans-first:9.48 03:52:03 INFO - PROCESS | 9480 | Values: 76.0 76.0 77.0 77.0 78.0 78.0 78.0 82.0 106.0 78.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.50 stddev:4.84 (4.0%) stddev-sans-first:5.12 03:52:03 INFO - PROCESS | 9480 | Values: 121.0 121.0 117.0 122.0 123.0 118.0 116.0 123.0 131.0 129.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:2.16 (1.4%) stddev-sans-first:2.17 03:52:03 INFO - PROCESS | 9480 | Values: 156.0 154.0 156.0 154.0 152.0 151.0 152.0 158.0 154.0 153.0 03:52:03 INFO - PROCESS | 9480 | 03:52:03 INFO - PROCESS | 9480 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:2.00 (3.2%) stddev-sans-first:2.12 03:52:03 INFO - PROCESS | 9480 | Values: 62.0 61.0 66.0 61.0 62.0 62.0 65.0 62.0 63.0 59.0 03:52:03 INFO - PROCESS | 9480 | -------- Summary: end -------- 03:52:03 INFO - PROCESS | 9480 | 03:52:04 INFO - TEST-INFO | 9480: exit 0 03:52:04 INFO - TEST-OK | kraken | took 60225ms 03:52:04 INFO - SUITE-END | took 1172s 03:52:04 INFO - Completed test suite (00:19:33) 03:52:04 INFO - javascript benchmark 03:52:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.263821959169, 3363.192833719908, 3380.239446124621, 3380.4084285250083, 3414.982925085376, 5573.47052030057, 5666.886662266752, 5672.886542269162, 5688.260526131608, 5690.231818704474, 5517.834464966048, 5587.972060139704, 5593.8601534961645, 5595.776168953237, 5601.271834661488, 5005.224190250498, 5054.393472783271, 5066.746662666861, 5068.645194836345, 5117.181250999841, 5134.794608215667, 5183.688978661274, 5185.118529849935, 5187.714675692835, 5192.40287366952, 5067.087924173666, 5092.567131793802, 5108.6168537359845, 5132.820351287705, 5142.845714628548, 5183.844484665466, 5210.296609957645, 5212.192110222922, 5212.244224587452, 5245.134552798783, 4987.526185012418, 5020.146575082244, 5029.371328583927, 5108.3359163308905, 5115.258287548322, 5481.506664400223, 5497.47773961477, 5524.392316845144, 5558.055130627803, 5559.027170245231, 6068.264241616243, 6081.726322315506, 6098.817035488898, 6099.57302988791, 6102.420270074336, 5988.461038506555, 6041.516678665696, 6050.42520960508, 6075.197264466469, 6102.21509212113, 5647.717614119278, 5695.45893140151, 5706.429357064302, 5706.486416222477, 5713.885722285572, 5934.198883150806, 6187.752489900444, 6191.783287584913, 6192.349803270682, 6196.504279657616, 5823.330317013513, 5884.764609415575, 5885.852853678607, 5948.167256584082, 5985.610935289193, 6040.275166979991, 6051.364606716232, 6068.666223357758, 6073.0, 6076.908846367308, 5788.565857560699, 5901.232839730807, 6005.939940600538, 6014.0377539593455, 6018.8194354169445, 5970.9701451492465, 6003.6397816131175, 6031.60794548353, 6034.306054803754, 6070.696465176724, 4528.841490547815, 4548.545145485491, 4567.611753001032, 4571.9314210286875, 4584.679072464895, 4031.0930040741187, 4063.349864021742, 4073.6333729964445, 4075.816588253536, 4113.4446849675505, 5701.4013528579735, 5728.312602487645, 5733.684647344436, 5737.139429085671, 5755.59710820247, 6017.729202185912, 6068.241469816273, 6075.33171351151, 6076.908846367308, 6099.69501524922, 5539.335279766454, 5649.4633009864, 5660.037793575102, 5661.46216109469, 5729.169270455761, 5161.406438259573, 5167.560757335594, 5169.560587350042, 5181.1969144782615, 5187.118189907725, 6278.340774218733, 6286.717097730613, 6289.276733175743, 6309.085182648582, 6310.873782524415, 5818.127280907897, 5912.911306330322, 5969.462748352669, 6014.518838492822, 6017.458428741435, 6165.445109940127, 6195.845103872439, 6198.876022479615, 6205.317415084247, 6217.689115544114, 5774.9133762994425, 5864.354920958776, 5878.147668588116, 5892.204552385373, 5894.852628684317, 5979.820605381846, 5980.910286345621, 6018.638881667114, 6069.180660610938, 6090.23872015998, 5865.5600829937075, 5902.734376952962, 5905.202797622438, 5909.202257695328, 5912.852178695567, 5681.948839464712, 5747.224124743107, 5879.176915231786, 5914.378990205966, 5940.524758019435, 5726.112452569859, 5757.193992840922, 5803.65178089316, 5810.448007439287, 5844.824655260349, 5883.588148829541, 5901.05583106718, 5902.2327097477055, 5937.821865344046, 5953.1070339449425, 5579.19101730255, 5711.314642242791, 5714.8571285716525, 5787.826365209051, 5806.912896306643], "value": 5546.692629162656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.7906311853968, 649.6816559885656, 656.2977613953069, 668.1447746883987, 668.8762878364346, 34047.659523404756, 46992.76503617482, 47883.52116478834, 47911.5208847911, 47963.0, 48662.27006594904, 48937.26594101091, 49235.50764492354, 49502.50497495024, 49521.25718114231, 8305.086440491541, 9064.002959674446, 9235.353525253235, 9239.58421871014, 10099.747506312364, 10516.789664206712, 10977.560897564088, 10986.066184374338, 10988.615398461056, 10991.06575941046, 10580.206484513692, 10595.417252051135, 10628.043476087189, 10635.096016838577, 10635.415052172128, 8401.3698972577, 10916.672499825017, 10925.399103049329, 11112.333260004345, 11134.10927125828, 10531.578736850517, 10926.453677316102, 10929.836052459219, 10935.56257749689, 10947.069499092508, 43993.78003109996, 44280.778596107135, 44451.333230001575, 44590.33114503285, 44749.552504474865, 3595.928081438383, 3708.42519409492, 3721.5720192177973, 3978.562358140602, 4485.058137791068, 31327.0, 31400.528992065138, 31505.0, 31693.52459713106, 31738.523922141187, 4761.285807128924, 4762.6904251223905, 4793.616510679172, 4819.807207711722, 4820.39745031871, 412279.0, 414462.0, 416896.0, 417300.0, 417689.0, 39119.217615647525, 40005.19989600192, 67862.0, 67986.32013679898, 68626.0, 41116.17767644631, 41145.177096457905, 41224.58775412267, 41284.0, 41337.1732565353, 16050.759238611197, 16171.272292746855, 16180.838191617933, 16192.0, 16199.919000404923, 11857.762844743056, 12099.879001209874, 12289.016878649687, 12296.20074695142, 12761.808572871414, 9326.533673316308, 9331.253499720142, 9340.112689294507, 9355.391899526508, 9408.529573521297, 3435.879744208941, 3487.2851065532013, 3535.52270443492, 3556.448750443685, 3576.8748093816594, 1065.387402243713, 1092.7978324010085, 1123.326004397355, 1198.3169593331718, 1225.307701148848, 34841.12897177591, 34926.82536587301, 35128.29743405118, 35138.29723405518, 35153.296934061684, 1158.25871442277, 1164.0, 1169.041386063437, 1240.7332423528985, 1249.1630607493003, 17658.205380757896, 18236.908815455838, 18364.908175459037, 18462.630747384977, 18520.722189167172, 579158.0, 580967.0, 582256.0, 582433.0, 584772.0, 65351.67324163444, 65896.34103658902, 65989.0, 65991.0, 66066.33933660698, 1366.5217173989024, 1401.726663300667, 1402.705431859321, 1458.3437453145914, 1462.0, 32611.34777304393, 35249.0, 35897.28205435929, 35973.64026359703, 36020.81989590035, 56165.15752263801, 57123.0, 57130.0, 57255.71372143113, 57335.42664573301, 414115.0, 418495.0, 419200.0, 419425.0, 419502.0, 28340.433191335644, 30018.549721753756, 30801.691983079883, 31300.843495782374, 31541.211469713442, 53088.469115308355, 53146.73426632842, 53505.7324713374, 53777.73111134419, 54127.72936135294, 44900.326495101945, 45213.32180017368, 45250.54749452463, 46062.0, 46308.30537542007, 44165.11669766651, 44403.77798110989, 44485.33272000987, 45736.54263457456, 45877.770611146734, 44879.551204487536, 45328.77335613301, 46703.766481167375, 46803.29795053145, 47912.520874790804, 38149.80925095357, 39794.0, 40167.0, 40342.59657403389, 40929.38605920973, 30335.0, 30382.848085760314, 31037.0, 31079.378412432077, 31086.222844428165], "value": 20653.12395082212, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.4881071876233, 415.5304505908323, 418.73410384405895, 421.0757387534362, 437.34180059011186, 18762.2495100196, 19668.409947701555, 19962.101705423273, 20103.899480502594, 20135.59728805423, 19300.903495482537, 19456.902715486438, 19473.610527789435, 19707.0, 19738.605227895434, 5609.38296787352, 5848.327442344121, 5889.911651325234, 5896.587238893279, 5898.557608179382, 4276.914461710764, 5095.898082038357, 5860.443257890493, 5907.143464197688, 6644.833879153011, 6518.93481065188, 6528.51036172289, 6546.18172728409, 6559.212894452672, 6563.1796025496815, 6417.262014868304, 6449.967750161266, 6475.417212450902, 6477.190351206099, 6487.481001519891, 3878.2437424702193, 5441.918371224435, 5735.4551317624755, 5803.21656576361, 5806.477417032445, 22998.08007679691, 23199.76800231993, 23207.187748428725, 23659.88170059156, 23680.763192368202, 2366.9881650591637, 2429.1619391310146, 2519.307190522621, 2535.239428171541, 2723.700392956793, 14526.709465810625, 14633.341499632543, 14670.0, 14875.47935822241, 15121.16833574153, 1898.943031709051, 1920.4430715092747, 1937.2832052140657, 1943.9708404373946, 1952.6094781043848, 77898.0, 79589.99999999942, 80206.59896700479, 80765.19234807695, 80814.0, 10387.428691421894, 10499.895001049892, 10699.89300106989, 10730.19523535738, 10838.0, 13953.302334883418, 13969.371378288002, 13978.370973306226, 13988.58034258974, 14031.087979281314, 7926.603669816486, 8128.943237379103, 8148.26665600087, 8305.750827475185, 8306.169383061646, 7906.248906353887, 7954.602269886483, 7975.282224599814, 8011.238932301422, 8059.234372734581, 6505.284418713938, 6632.369924857131, 6670.899936500859, 6671.5997040177745, 6685.156610485653, 2003.9522944161533, 2024.4736368544284, 2061.2167376396874, 2061.2579471390286, 2072.3161356752234, 973.9610415583297, 1007.3250921882357, 1017.0693815159046, 1025.410389026313, 1097.3470784882982, 18747.906260468884, 19420.0, 19649.410517684493, 19811.50471238202, 20542.17831286732, 1038.5170895533613, 1051.6792378324685, 1077.5217000897903, 1098.2202636128438, 1124.887511248885, 10403.687889363331, 10716.624918127829, 10787.946060269649, 10892.292001019909, 10929.617463388744, 501262.0, 503391.0, 542214.0, 570540.0, 576728.0, 61021.694891526146, 81633.0, 95416.0, 98093.5095324533, 98897.0, 1088.8094583447864, 1100.6697990602788, 1103.8675358956816, 1113.432149603708, 1113.7382715061954, 13156.342182890625, 16713.331466741194, 17444.21501032431, 17855.821441785414, 17924.641507170043, 40489.0, 43148.352774707775, 43542.56457435385, 43689.0, 44943.1011379764, 61904.0, 62223.6888815553, 63228.0, 67046.32953670401, 67058.66470667615, 7708.229177082247, 7836.804079898048, 8078.676852926053, 8138.755837324889, 8810.766492691157, 13052.34738263064, 13550.728985420434, 13667.658308542366, 14011.299435028004, 14417.855821441652, 6236.376362363727, 7017.684204210925, 11695.538057742782, 12386.5664701735, 12590.93704531508, 12368.877405684243, 12426.937865310616, 12449.25304481734, 12659.620211393672, 12805.487780488676, 11291.3789741565, 11688.766224675288, 12524.248545087325, 12606.369681515704, 12796.296203708886, 8651.351148663749, 8693.304535637008, 8725.52009639476, 8748.65005399777, 9075.2286055686, 8707.346948978726, 10939.890601093886, 11247.718807029889, 11440.599579014695, 12409.689757756129], "value": 9549.738659480236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.9657008574777, 1513.2282535906688, 1571.4814111343255, 1744.7295669171274, 1879.0886420086247, 9186.816263674722, 9516.666916657918, 9537.90462095378, 9766.072223138808, 9826.557804898779, 9581.137697607213, 9735.415875047502, 9736.610535578568, 9748.658796942109, 9757.902420975788, 2444.2789377133745, 2464.2360868130845, 2465.2973902437807, 2467.3091534370405, 2469.148143890364, 2392.102961389479, 2436.987815060931, 2456.9631455528183, 2458.704955405345, 2460.3849037740565, 2409.0604664180983, 2425.7695518925675, 2491.2152671908293, 2500.599904015358, 2505.1607711416605, 2320.396696858812, 2360.0913648245464, 2369.5853225685437, 2377.132346693462, 2391.366287933699, 2284.303287497313, 2323.93028209154, 2326.999390262187, 2331.953360932772, 2332.93001209964, 8109.75670729879, 9209.539523023888, 9661.71014869555, 9696.70909872705, 9712.61149554024, 5471.7264136793, 5689.317281926154, 5706.686132262724, 5708.828735137952, 5712.457316554921, 3380.408428525023, 3398.7790793598338, 3475.5308033415417, 3477.0959550516795, 3550.6271841456532, 1150.246588484544, 1173.4074292482242, 1190.8749581294012, 1219.3842109734528, 2308.0, 13378.598642040753, 13979.860201397958, 13990.930045349809, 13996.650083747885, 14015.719685606231, 4735.2423612222565, 4767.188468382062, 4793.808247670124, 4810.831620893252, 4882.438519570295, 10734.78530429387, 10798.838017429745, 10800.945995269973, 10818.783624327469, 10820.296680715886, 5622.044252477089, 5626.831195064155, 5627.8593035174445, 5630.042892708249, 5630.127330263816, 5078.97460512695, 5197.272381866542, 5201.479852014768, 5218.034663587173, 5281.973590132025, 3730.123420996064, 3761.191343861083, 3783.5270591176104, 3832.405977073558, 3833.463315135883, 1068.4871261794383, 1084.9457527123611, 1093.6554985179644, 1100.0429626225075, 1100.5033154909318, 940.5297351324338, 1051.353417648141, 1053.1995683280609, 1081.432248069754, 1088.9618863339745, 6411.166548348778, 6423.614583125028, 6500.089987401768, 6504.447121994684, 6643.30245324234, 437.4400767018222, 444.32019010913353, 444.37343345882795, 444.87098741365287, 447.05671034117984, 4409.316555933835, 4555.521670224579, 4572.7713614319155, 4673.415823022122, 4707.529247075265, 11988.400579971141, 12112.0, 12222.449989750483, 12390.3185324808, 12405.875941240472, 11893.583724569598, 12288.324142172267, 12337.814932776015, 12344.197627154206, 12349.506019759288, 8798.252148567444, 8821.0, 8838.690645827364, 9310.534473276444, 9337.253019758538, 6432.163818703539, 6572.047053177358, 6591.967040164768, 6715.3620406061345, 6731.158605174353, 10893.455327233449, 11145.777084458428, 11280.09759219244, 11406.942965285121, 11408.630964284008, 11275.436228188722, 11409.030232430336, 11455.427228638702, 11557.0, 11699.590514331958, 8079.111297757125, 8081.676732930617, 8121.75634730959, 8160.673573057249, 8163.877541836759, 8894.33292503052, 9026.052264512131, 9057.456552606865, 9062.22971047442, 9067.183953444222, 8440.53577053268, 8622.26710729595, 8625.094365091574, 8854.29165666758, 8883.244924181517, 8244.958775206085, 8408.621612027597, 8427.95786021066, 8447.281981031681, 8721.781955451164, 7117.110361204849, 7340.96329518349, 7353.77938661841, 7489.251074892467, 7490.325870671666, 5617.269754931833, 5794.594378393472, 5877.4122587740885, 5962.9105563415715, 5967.194428752063, 5751.137329400456, 5752.108423194411, 5806.82579522615, 5825.970870145622, 5908.3796201399955], "value": 4873.313087092358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6450633316018, 333.77136661386953, 337.71631829263424, 339.9456087026076, 340.657639072732, 5523.530499907508, 5567.805126820557, 5579.33048034236, 5580.162975553659, 5580.386157522669, 5467.726613669321, 5487.777450132693, 5517.730921887968, 5517.751701173447, 5549.556035517159, 4134.772587507693, 4136.379543068549, 4309.590588894066, 4311.030018245885, 4324.956750432487, 4258.957410425887, 4274.850380236692, 4277.401163837066, 4301.26878430666, 4316.136772645484, 4097.713160078795, 4267.423897773808, 4270.743755374688, 4284.764337961411, 4288.641247313981, 3996.860109896169, 4200.222958752625, 4266.957330426687, 4267.210566045292, 4268.59448352406, 3766.832281992591, 3771.9622803771886, 3788.1855401088897, 3801.182745709658, 3804.1821008483034, 5169.302144210558, 5273.393559740641, 5285.022270879899, 5301.224089929879, 5311.973440132813, 4888.193448081062, 4892.19278818998, 4909.435414927258, 4921.384826896638, 4937.925931111036, 5669.518090962273, 5712.571557133231, 5713.657180569137, 5753.309602847643, 5779.1620215069, 4027.1744292419985, 4178.206140833232, 4189.581041895816, 4190.120074784299, 4204.747715137101, 5966.612170208966, 5970.432808883149, 5997.160397544348, 6009.909851352233, 6030.396960303979, 4293.69944103916, 4308.66431406265, 4310.784460776948, 4324.8486302979245, 4334.133173365277, 4018.6985976051915, 4331.6534677225745, 4340.175366680321, 4354.238008348526, 4374.475062992461, 4882.26765985098, 4906.632002599819, 4907.190313598217, 4910.0, 4920.114379411669, 5830.854228644318, 5840.328362238312, 5855.209546711225, 5862.941370586324, 5870.383609721003, 1414.7241287948957, 1455.396010655566, 1457.4024649893704, 1465.728840164573, 1468.2218424235173, 905.3571963905569, 922.2898368256405, 926.5737760630186, 968.7820240445984, 1002.4185972136144, 5493.862653433696, 5508.91736623951, 5524.364698059694, 5527.55779537636, 5548.528375088082, 5840.678762668094, 5851.64890106595, 5866.354700982888, 5889.705514724246, 5896.852578685567, 5378.354597448331, 5483.533899618497, 5531.1426728857095, 5559.972200139055, 5614.550835933115, 3105.4254962831947, 3131.373725254958, 3142.71715545602, 3153.810771353726, 3157.7842530625417, 5914.3439836845755, 6000.279966403972, 6029.6683682397015, 6047.909281360783, 6118.3269840317525, 5985.132155837379, 6000.159977603139, 6013.278406591149, 6013.639181649115, 6017.405387572209, 6040.345590917432, 6057.939420605914, 6113.816585502442, 6114.633122012693, 6117.632942023404, 5692.31692196939, 5822.359540450462, 5856.824295271149, 5860.413958604106, 5877.647341159544, 5744.368119506935, 5757.884842303047, 5760.8271751847515, 5778.8266352009505, 5810.4189581041555, 5843.444872737083, 5979.940200597938, 6059.697015149313, 6064.666443345658, 6078.878422431615, 4094.3244364680686, 4140.91718165641, 4172.749635021908, 4190.958090419057, 4205.810738516835, 5882.058870580687, 5903.734331955158, 5922.200502932049, 5928.229330187048, 5929.377415371324, 5445.074337362737, 5695.971520142372, 5723.656580605177, 5733.111367738007, 5807.564432667482, 5678.971605141948, 5681.77272909079, 5685.8862822742485, 5688.0, 5696.715164241854, 5507.8984203158725, 5509.338879334506, 5638.746256418389, 5651.350094739158, 5752.913706294493, 5812.157237200667, 5841.474267315962, 5843.386444423444, 5848.356680765198, 5857.736401861841, 5481.068218402801, 5632.873425314871, 5674.432556744293, 5705.172749951317, 5730.770769169187], "value": 4380.957565326659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.7523867601047, 798.9720359787409, 808.1595141053305, 822.8354329134173, 905.6830109461687, 13908.582742517729, 14596.854031459708, 14681.559553213407, 15178.544643660694, 15213.315400806963, 14924.776128358084, 14967.92516037421, 15058.171800550965, 15073.39706411745, 15077.246137693126, 723.8769409200448, 850.1880703927765, 859.9441036332634, 867.0679020053436, 872.4808738800403, 865.5023361567092, 866.1208872993916, 869.1178453869328, 869.3436455476138, 869.3697069624535, 920.5029284186564, 921.3964853021282, 922.0825278847523, 922.2621902478024, 922.4557511068468, 753.5968256982516, 866.1857853617611, 895.0959530873799, 896.3770179725094, 913.456493386434, 660.9603423794588, 660.9702563384659, 661.077796473921, 661.3948237362807, 661.6294874870088, 13689.0, 13728.313584320844, 13743.175409475463, 13753.0, 13755.518556850562, 14336.139831610137, 14598.92700536501, 14825.851741482555, 14859.628509287246, 14962.47631332909, 12479.251244925243, 12619.558315458915, 12730.681732956658, 12809.231446113263, 13044.0, 4587.977060114711, 4606.101810147023, 4611.631069514431, 4616.838410655644, 4654.464736555272, 66035.66982165059, 75065.24934750637, 75103.62448187779, 75188.62405687991, 75307.62346188289, 10874.619388321371, 11281.477000604813, 11622.360770157722, 11667.0, 11792.58725944605, 20748.170073197205, 20790.896045519676, 20799.0, 20820.958952052337, 20839.687404688942, 9325.533723313943, 9368.203702685349, 9387.62449502026, 9476.241900647932, 9690.37012594179, 5042.369703787027, 5099.260607211933, 5164.9741751291, 5193.454687257859, 5321.547668448148, 3513.648635136466, 3592.586852511942, 3626.0028492164865, 3626.6917312028245, 3629.183433727443, 671.9126513553207, 682.0723815610766, 689.0387908867102, 710.8720430322488, 729.5768454296496, 674.942629876466, 722.3679280629449, 749.3817600479626, 757.806759276392, 771.267296068737, 10144.695659130239, 10333.22500812442, 10367.429791361548, 10426.426546540013, 10466.0, 689.9655017249218, 693.9722411103601, 712.5510928115255, 724.0334153904491, 725.6734469488752, 4781.282807578891, 4881.731504767272, 4947.233178857283, 4955.380577427822, 5006.849794506171, 128007.35996320145, 128746.35626821993, 130214.34892825475, 134283.0, 138218.6158089239, 113013.0, 114947.0, 116387.0, 116997.4150129244, 117498.41250793691, 91967.54016229876, 101916.49041754744, 102871.48564257131, 104475.47762261292, 105138.0, 8799.560021998746, 9107.271418286653, 9130.771730706785, 9200.171984521157, 9244.445333280024, 56962.430375695716, 58777.4122258772, 59815.0, 60155.097673535805, 60432.0, 51573.7421312906, 51704.0, 61367.693161535695, 90052.0, 90579.0, 11310.4910279036, 11318.094552435621, 11383.487743051417, 11599.88400115988, 11754.177207595387, 13266.602001939957, 13433.932830335785, 13557.118787278796, 13655.04414690962, 13997.790033149715, 11032.944835276094, 12680.492780288685, 12770.744585108432, 12890.29103399322, 13009.284489353176, 11941.104417168573, 12343.876561234272, 12481.875181248071, 13017.609471715863, 13618.18290902549, 12560.811587826007, 12956.870431295567, 13336.333183340601, 13405.0, 13741.793873091712, 11090.223684342018, 11664.825027624423, 11728.354940478355, 11729.589464368706, 11927.10546708983, 10908.454577270946, 11396.202265841643, 11529.365884876077, 11565.363904985306, 11597.884021160018], "value": 7777.658277625406, "unit": "score"}], "name": "dromaeo_css", "value": 7525.742680210937, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 108.0, 109.0, 109.0, 109.0, 108.0, 108.0, 109.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 136.0, 126.0, 183.0, 125.0, 126.0, 155.0, 124.0, 156.0, 131.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 158.0, 159.0, 160.0, 159.0, 160.0, 159.0, 160.0], "value": 159.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 118.0, 76.0, 76.0, 74.0, 75.0, 117.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 114.0, 84.0, 84.0, 85.0, 111.0, 84.0, 84.0, 125.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 50.0, 51.0, 50.0, 50.0, 52.0, 51.0, 51.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 77.0, 78.0, 78.0, 78.0, 82.0, 106.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 117.0, 122.0, 123.0, 118.0, 116.0, 123.0, 131.0, 129.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 156.0, 154.0, 152.0, 151.0, 152.0, 158.0, 154.0, 153.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 66.0, 61.0, 62.0, 62.0, 65.0, 62.0, 63.0, 59.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1473.8999999999999, "alertThreshold": 2.0}]} 03:52:04 INFO - Return code: 0 03:52:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:04 ERROR - # TBPL SUCCESS # 03:52:04 INFO - Running post-action listener: _resource_record_post_action 03:52:04 INFO - ##### 03:52:04 INFO - ##### Finished run-tests step (success) 03:52:04 INFO - ##### 03:52:04 INFO - Running post-run listener: _resource_record_post_run 03:52:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 606208; Write bytes: 255791104; Read time: 320; Write time: 168732 03:52:04 INFO - TinderboxPrint: CPU usage
13.0% 03:52:04 INFO - TinderboxPrint: I/O read bytes / time
606,208 / 320 03:52:04 INFO - TinderboxPrint: I/O write bytes / time
255,791,104 / 168,732 03:52:04 INFO - TinderboxPrint: CPU idle
8,258.6 (87.0%) 03:52:04 INFO - TinderboxPrint: CPU user
1,194.7 (12.6%) 03:52:04 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5435392; Read time: 0; Write time: 784 03:52:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 606208; Write bytes: 250355712; Read time: 320; Write time: 167948 03:52:05 INFO - Running post-run listener: _upload_blobber_files 03:52:05 INFO - Blob upload gear active. 03:52:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:08 INFO - (blobuploader) - INFO - Done attempting. 03:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:09 INFO - (blobuploader) - INFO - Done attempting. 03:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:10 INFO - (blobuploader) - INFO - Done attempting. 03:52:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:10 INFO - Return code: 0 03:52:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2502e5ee834611f1006b60d71a9940f297a9f12943b5ddaf2378e2c793773e53d6a53042d91d6da2dae9177e99b1ffe07d74a60131f347c18ffba7fca0839e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0d6bcb88c34a3dc43f93d159710f6b392ddfee9da0c33e87ed4279130c1d6884fe1f0ed07a8c3236f8b04813f0dd7d9915b6a028cb5d5c8cd445653b9364811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5686b6c618837374083ed489788bce777bdd1300d56c96ec61b31579c027be2b155f0b798382c1c18912608939efd8ad88bc61d5f2c206e0630b10af623ef5dd"} 03:52:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:10 INFO - Contents: 03:52:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2502e5ee834611f1006b60d71a9940f297a9f12943b5ddaf2378e2c793773e53d6a53042d91d6da2dae9177e99b1ffe07d74a60131f347c18ffba7fca0839e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0d6bcb88c34a3dc43f93d159710f6b392ddfee9da0c33e87ed4279130c1d6884fe1f0ed07a8c3236f8b04813f0dd7d9915b6a028cb5d5c8cd445653b9364811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5686b6c618837374083ed489788bce777bdd1300d56c96ec61b31579c027be2b155f0b798382c1c18912608939efd8ad88bc61d5f2c206e0630b10af623ef5dd"} 03:52:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:10 INFO - Copying logs to upload dir... 03:52:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.345506 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-23 03:52:10.495533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 03:52:10.498676) ========= 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=d2a8c569965ab8367867b893000001a1-1466677726.819464-806118363 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-Aurora/sha512/2502e5ee834611f1006b60d71a9940f297a9f12943b5ddaf2378e2c793773e53d6a53042d91d6da2dae9177e99b1ffe07d74a60131f347c18ffba7fca0839e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0d6bcb88c34a3dc43f93d159710f6b392ddfee9da0c33e87ed4279130c1d6884fe1f0ed07a8c3236f8b04813f0dd7d9915b6a028cb5d5c8cd445653b9364811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5686b6c618837374083ed489788bce777bdd1300d56c96ec61b31579c027be2b155f0b798382c1c18912608939efd8ad88bc61d5f2c206e0630b10af623ef5dd"} build_url:https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/HAcvtr1fStKd36OywTguWg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2502e5ee834611f1006b60d71a9940f297a9f12943b5ddaf2378e2c793773e53d6a53042d91d6da2dae9177e99b1ffe07d74a60131f347c18ffba7fca0839e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0d6bcb88c34a3dc43f93d159710f6b392ddfee9da0c33e87ed4279130c1d6884fe1f0ed07a8c3236f8b04813f0dd7d9915b6a028cb5d5c8cd445653b9364811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5686b6c618837374083ed489788bce777bdd1300d56c96ec61b31579c027be2b155f0b798382c1c18912608939efd8ad88bc61d5f2c206e0630b10af623ef5dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 03:52:10.523802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:52:10.524126) ========= 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=d2a8c569965ab8367867b893000001a1-1466677726.819464-806118363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:52:10.607304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 03:52:10.607654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 03:52:10.607961) ========= ========= Total master_lag: 0.16 =========