builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1465899699.09 results: success (0) buildid: 20160614004007 builduid: 74cb225111f64d189aac63caf17d31da revision: 1a585c67e88e31e89aa165f6b706600a2ef92386 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.087482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.087922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.088236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.156621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.157054) ========= 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=745a4373a2a16df560f216e000000264-1465892094.12891-370948961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 03:21:39-- 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% 226M=0s 2016-06-14 03:21:39 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208894 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.423339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.423676) ========= 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=745a4373a2a16df560f216e000000264-1465892094.12891-370948961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.068654 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.505019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:39.505362) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a585c67e88e31e89aa165f6b706600a2ef92386 --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 1a585c67e88e31e89aa165f6b706600a2ef92386 --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=745a4373a2a16df560f216e000000264-1465892094.12891-370948961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 03:21:39,646 truncating revision to first 12 chars 2016-06-14 03:21:39,646 Setting DEBUG logging. 2016-06-14 03:21:39,646 attempt 1/10 2016-06-14 03:21:39,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a585c67e88e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 03:21:39,944 unpacking tar archive at: mozilla-aurora-1a585c67e88e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:40.155768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:40.156082) ========= script_repo_revision: 1a585c67e88e31e89aa165f6b706600a2ef92386 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:40.156526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:40.156897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 03:21:40.175158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-14 03:21:40.175480) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1465892094.12891-370948961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:40 INFO - MultiFileLogger online at 20160614 03:21:40 in /builds/slave/test 03:21:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:21:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:40 INFO - {'append_to_log': False, 03:21:40 INFO - 'base_work_dir': '/builds/slave/test', 03:21:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:40 INFO - 'branch': 'Mozilla-Aurora', 03:21:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:40 INFO - 'config_files': ('talos/linux_config.py',), 03:21:40 INFO - 'default_actions': ('clobber', 03:21:40 INFO - 'read-buildbot-config', 03:21:40 INFO - 'download-and-extract', 03:21:40 INFO - 'populate-webroot', 03:21:40 INFO - 'create-virtualenv', 03:21:40 INFO - 'install', 03:21:40 INFO - 'run-tests'), 03:21:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:40 INFO - 'download_minidump_stackwalk': True, 03:21:40 INFO - 'download_symbols': 'ondemand', 03:21:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:40 INFO - 'installer_path': 'installer.exe', 03:21:40 INFO - 'log_level': 'info', 03:21:40 INFO - 'log_name': 'talos', 03:21:40 INFO - 'log_to_console': True, 03:21:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:40 INFO - 'opt_config_files': (), 03:21:40 INFO - 'pip_index': False, 03:21:40 INFO - 'sps_profile': False, 03:21:40 INFO - 'sps_profile_interval': 0, 03:21:40 INFO - 'suite': 'dromaeojs-e10s', 03:21:40 INFO - 'system_bits': '32', 03:21:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:40 INFO - 'title': 'talos-linux64-ix-032', 03:21:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:40 INFO - 'use_talos_json': True, 03:21:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:40 INFO - 'work_dir': 'build'} 03:21:40 INFO - ##### 03:21:40 INFO - ##### Running clobber step. 03:21:40 INFO - ##### 03:21:40 INFO - Running pre-action listener: _resource_record_pre_action 03:21:40 INFO - Running main action method: clobber 03:21:40 INFO - rmtree: /builds/slave/test/build 03:21:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:48 INFO - Running post-action listener: _resource_record_post_action 03:21:48 INFO - ##### 03:21:48 INFO - ##### Finished clobber step (success) 03:21:48 INFO - ##### 03:21:48 INFO - ##### 03:21:48 INFO - ##### Running read-buildbot-config step. 03:21:48 INFO - ##### 03:21:48 INFO - Running pre-action listener: _resource_record_pre_action 03:21:48 INFO - Running main action method: read_buildbot_config 03:21:48 INFO - Using buildbot properties: 03:21:48 INFO - { 03:21:48 INFO - "project": "", 03:21:48 INFO - "product": "firefox", 03:21:48 INFO - "script_repo_revision": "production", 03:21:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:21:48 INFO - "repository": "", 03:21:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:21:48 INFO - "buildid": "20160614004007", 03:21:48 INFO - "stage_platform": "linux64-pgo", 03:21:48 INFO - "basedir": "/builds/slave/test", 03:21:48 INFO - "nightly_build": "True", 03:21:48 INFO - "buildnumber": 402, 03:21:48 INFO - "slavename": "talos-linux64-ix-032", 03:21:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:21:48 INFO - "platform": "ubuntu64_hw", 03:21:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:48 INFO - "branch": "mozilla-aurora", 03:21:48 INFO - "repo_path": "releases/mozilla-aurora", 03:21:48 INFO - "revision": "1a585c67e88e31e89aa165f6b706600a2ef92386", 03:21:48 INFO - "pgo_build": "True", 03:21:48 INFO - "builduid": "74cb225111f64d189aac63caf17d31da", 03:21:48 INFO - "slavebuilddir": "test" 03:21:48 INFO - } 03:21:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:21:48 INFO - Running post-action listener: _resource_record_post_action 03:21:48 INFO - ##### 03:21:48 INFO - ##### Finished read-buildbot-config step (success) 03:21:48 INFO - ##### 03:21:48 INFO - ##### 03:21:48 INFO - ##### Running download-and-extract step. 03:21:48 INFO - ##### 03:21:48 INFO - Running pre-action listener: _resource_record_pre_action 03:21:48 INFO - Running main action method: download_and_extract 03:21:48 INFO - mkdir: /builds/slave/test/build/tests 03:21:48 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:21:48 INFO - https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:50 INFO - Downloaded 1361 bytes. 03:21:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:50 INFO - Using the following test package requirements: 03:21:50 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:50 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:50 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:21:50 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'jsshell-linux-x86_64.zip'], 03:21:50 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:50 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:50 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:21:50 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:21:50 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:50 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:50 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:50 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:50 INFO - https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:55 INFO - Downloaded 24472846 bytes. 03:21:55 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:21:55 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:21:56 INFO - Return code: 0 03:21:56 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:21: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:21:56 INFO - https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:57 INFO - Downloaded 24472846 bytes. 03:21:57 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:21:57 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:21:58 INFO - Return code: 0 03:21:58 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:21:58 INFO - https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:21:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:59 INFO - Downloaded 10833369 bytes. 03:21:59 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:21:59 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:21:59 INFO - Return code: 0 03:21: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:21:59 INFO - https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:21:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S6_KfU2qRGmTLayIqER-Jw/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:22:02 INFO - Downloaded 63551440 bytes. 03:22:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:22:03 INFO - mkdir: /builds/slave/test/properties 03:22:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:03 INFO - Contents: 03:22:03 INFO - build_url:https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:22:04 INFO - Running post-action listener: _resource_record_post_action 03:22:04 INFO - Running post-action listener: set_extra_try_arguments 03:22:04 INFO - ##### 03:22:04 INFO - ##### Finished download-and-extract step (success) 03:22:04 INFO - ##### 03:22:04 INFO - ##### 03:22:04 INFO - ##### Running populate-webroot step. 03:22:04 INFO - ##### 03:22:04 INFO - Running pre-action listener: _resource_record_pre_action 03:22:04 INFO - Running main action method: populate_webroot 03:22:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:04 INFO - '--tppagecycles', 03:22:04 INFO - '7'], 03:22:04 INFO - 'tests': ['tsvgm']}}, 03:22:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['damp', 'tps']}, 03:22:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'tests': ['damp', 'tps']}, 03:22:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['dromaeo_dom']}, 03:22:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['a11yr', 03:22:04 INFO - 'ts_paint', 03:22:04 INFO - 'tpaint', 03:22:04 INFO - 'sessionrestore', 03:22:04 INFO - 'sessionrestore_no_auto_restore', 03:22:04 INFO - 'tabpaint']}, 03:22:04 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:04 INFO - 'ts_paint', 03:22:04 INFO - 'tpaint', 03:22:04 INFO - 'sessionrestore', 03:22:04 INFO - 'sessionrestore_no_auto_restore', 03:22:04 INFO - 'tabpaint']}, 03:22:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:04 INFO - 'ts_paint', 03:22:04 INFO - 'tpaint', 03:22:04 INFO - 'sessionrestore', 03:22:04 INFO - 'sessionrestore_no_auto_restore', 03:22:04 INFO - 'tabpaint']}, 03:22:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:04 INFO - 'ts_paint', 03:22:04 INFO - 'tpaint', 03:22:04 INFO - 'sessionrestore', 03:22:04 INFO - 'sessionrestore_no_auto_restore', 03:22:04 INFO - 'tabpaint']}, 03:22:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['a11yr', 03:22:04 INFO - 'ts_paint', 03:22:04 INFO - 'tpaint', 03:22:04 INFO - 'sessionrestore', 03:22:04 INFO - 'sessionrestore_no_auto_restore', 03:22:04 INFO - 'tabpaint']}, 03:22:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['a11yr', 03:22:04 INFO - 'ts_paint', 03:22:04 INFO - 'tpaint', 03:22:04 INFO - 'sessionrestore', 03:22:04 INFO - 'sessionrestore_no_auto_restore', 03:22:04 INFO - 'tabpaint']}, 03:22:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['tsvgx', 03:22:04 INFO - 'tsvgr_opacity', 03:22:04 INFO - 'tart', 03:22:04 INFO - 'tscrollx', 03:22:04 INFO - 'cart']}, 03:22:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:04 INFO - 'tsvgr_opacity', 03:22:04 INFO - 'tart', 03:22:04 INFO - 'tscrollx', 03:22:04 INFO - 'cart']}, 03:22:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'talos_options': ['--disable-e10s'], 03:22:04 INFO - 'tests': ['tp5o']}, 03:22:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'tests': ['tp5o']}, 03:22:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'talos_options': ['--disable-e10s', 03:22:04 INFO - '--xperf_path', 03:22:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:04 INFO - 'tests': ['tp5n']}, 03:22:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:04 INFO - 'talos_options': ['--xperf_path', 03:22:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:04 INFO - 'tests': ['tp5n']}}, 03:22:04 INFO - 'talos.zip': {'path': '', 03:22:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:04 INFO - Running post-action listener: _resource_record_post_action 03:22:04 INFO - ##### 03:22:04 INFO - ##### Finished populate-webroot step (success) 03:22:04 INFO - ##### 03:22:04 INFO - ##### 03:22:04 INFO - ##### Running create-virtualenv step. 03:22:04 INFO - ##### 03:22:04 INFO - Running pre-action listener: _resource_record_pre_action 03:22:04 INFO - Running main action method: create_virtualenv 03:22:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:04 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:22:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:04 INFO - Using real prefix '/usr' 03:22:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:06 INFO - Installing pip.................done. 03:22:06 INFO - Return code: 0 03:22:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22: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:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:06 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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:06 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:22:06 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:22:07 INFO - Using env: {'DISPLAY': ':0', 03:22:07 INFO - 'HOME': '/home/cltbld', 03:22:07 INFO - 'LANG': 'en_US.UTF-8', 03:22:07 INFO - 'LANGUAGE': 'en_US:en', 03:22:07 INFO - 'LOGNAME': 'cltbld', 03:22:07 INFO - 'MAIL': '/var/mail/cltbld', 03:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:07 INFO - 'MOZ_NO_REMOTE': '1', 03:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:07 INFO - 'NO_EM_RESTART': '1', 03:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:07 INFO - 'PWD': '/builds/slave/test', 03:22:07 INFO - 'SHELL': '/bin/bash', 03:22:07 INFO - 'SHLVL': '1', 03:22:07 INFO - 'TERM': 'linux', 03:22:07 INFO - 'TMOUT': '86400', 03:22:07 INFO - 'USER': 'cltbld', 03:22:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:07 INFO - '_': '/tools/buildbot/bin/python'} 03:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:08 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:22:08 INFO - Cleaning up... 03:22:08 INFO - Return code: 0 03:22:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:08 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:22:08 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:22:08 INFO - Using env: {'DISPLAY': ':0', 03:22:08 INFO - 'HOME': '/home/cltbld', 03:22:08 INFO - 'LANG': 'en_US.UTF-8', 03:22:08 INFO - 'LANGUAGE': 'en_US:en', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MAIL': '/var/mail/cltbld', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SHLVL': '1', 03:22:08 INFO - 'TERM': 'linux', 03:22:08 INFO - 'TMOUT': '86400', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - '_': '/tools/buildbot/bin/python'} 03:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:08 INFO - Downloading/unpacking psutil>=3.1.1 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:10 INFO - Installing collected packages: psutil 03:22:10 INFO - Running setup.py install for psutil 03:22:10 INFO - building 'psutil._psutil_linux' extension 03:22:10 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:22:12 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:22:12 INFO - building 'psutil._psutil_posix' extension 03:22:12 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:22:12 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:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:12 INFO - Successfully installed psutil 03:22:12 INFO - Cleaning up... 03:22:12 INFO - Return code: 0 03:22:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:22:12 INFO - Using env: {'DISPLAY': ':0', 03:22:12 INFO - 'HOME': '/home/cltbld', 03:22:12 INFO - 'LANG': 'en_US.UTF-8', 03:22:12 INFO - 'LANGUAGE': 'en_US:en', 03:22:12 INFO - 'LOGNAME': 'cltbld', 03:22:12 INFO - 'MAIL': '/var/mail/cltbld', 03:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:12 INFO - 'MOZ_NO_REMOTE': '1', 03:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:12 INFO - 'NO_EM_RESTART': '1', 03:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:12 INFO - 'PWD': '/builds/slave/test', 03:22:12 INFO - 'SHELL': '/bin/bash', 03:22:12 INFO - 'SHLVL': '1', 03:22:12 INFO - 'TERM': 'linux', 03:22:12 INFO - 'TMOUT': '86400', 03:22:12 INFO - 'USER': 'cltbld', 03:22:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:12 INFO - '_': '/tools/buildbot/bin/python'} 03:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22: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:22: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:22: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:22: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:22: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:22: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:22:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:14 INFO - Installing collected packages: mozsystemmonitor 03:22:14 INFO - Running setup.py install for mozsystemmonitor 03:22:14 INFO - Successfully installed mozsystemmonitor 03:22:14 INFO - Cleaning up... 03:22:14 INFO - Return code: 0 03:22:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:14 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:22:14 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:22:15 INFO - Using env: {'DISPLAY': ':0', 03:22:15 INFO - 'HOME': '/home/cltbld', 03:22:15 INFO - 'LANG': 'en_US.UTF-8', 03:22:15 INFO - 'LANGUAGE': 'en_US:en', 03:22:15 INFO - 'LOGNAME': 'cltbld', 03:22:15 INFO - 'MAIL': '/var/mail/cltbld', 03:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:15 INFO - 'MOZ_NO_REMOTE': '1', 03:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:15 INFO - 'NO_EM_RESTART': '1', 03:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:15 INFO - 'PWD': '/builds/slave/test', 03:22:15 INFO - 'SHELL': '/bin/bash', 03:22:15 INFO - 'SHLVL': '1', 03:22:15 INFO - 'TERM': 'linux', 03:22:15 INFO - 'TMOUT': '86400', 03:22:15 INFO - 'USER': 'cltbld', 03:22:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:15 INFO - '_': '/tools/buildbot/bin/python'} 03:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:15 INFO - Downloading/unpacking jsonschema==2.5.1 03:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:17 INFO - warning: no files found matching '*.txt' 03:22:17 INFO - no previously-included directories found matching 'build' 03:22:17 INFO - no previously-included directories found matching 'dist' 03:22:17 INFO - no previously-included directories found matching '.git*' 03:22:17 INFO - Installing collected packages: jsonschema, functools32 03:22:17 INFO - Running setup.py install for functools32 03:22:17 INFO - warning: no files found matching '*.txt' 03:22:17 INFO - no previously-included directories found matching 'build' 03:22:17 INFO - no previously-included directories found matching 'dist' 03:22:17 INFO - no previously-included directories found matching '.git*' 03:22:17 INFO - Successfully installed jsonschema functools32 03:22:17 INFO - Cleaning up... 03:22:17 INFO - Return code: 0 03:22:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:22:17 INFO - Using env: {'DISPLAY': ':0', 03:22:17 INFO - 'HOME': '/home/cltbld', 03:22:17 INFO - 'LANG': 'en_US.UTF-8', 03:22:17 INFO - 'LANGUAGE': 'en_US:en', 03:22:17 INFO - 'LOGNAME': 'cltbld', 03:22:17 INFO - 'MAIL': '/var/mail/cltbld', 03:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:17 INFO - 'MOZ_NO_REMOTE': '1', 03:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:17 INFO - 'NO_EM_RESTART': '1', 03:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:17 INFO - 'PWD': '/builds/slave/test', 03:22:17 INFO - 'SHELL': '/bin/bash', 03:22:17 INFO - 'SHLVL': '1', 03:22:17 INFO - 'TERM': 'linux', 03:22:17 INFO - 'TMOUT': '86400', 03:22:17 INFO - 'USER': 'cltbld', 03:22:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:17 INFO - '_': '/tools/buildbot/bin/python'} 03:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:20 INFO - Downloading docopt-0.6.1.tar.gz 03:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:20 INFO - Running setup.py install for blobuploader 03:22:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:20 INFO - Running setup.py install for requests 03:22:20 INFO - Running setup.py install for docopt 03:22:20 INFO - Successfully installed blobuploader requests docopt 03:22:20 INFO - Cleaning up... 03:22:21 INFO - Return code: 0 03:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:21 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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:21 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:22:21 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:22:21 INFO - Using env: {'DISPLAY': ':0', 03:22:21 INFO - 'HOME': '/home/cltbld', 03:22:21 INFO - 'LANG': 'en_US.UTF-8', 03:22:21 INFO - 'LANGUAGE': 'en_US:en', 03:22:21 INFO - 'LOGNAME': 'cltbld', 03:22:21 INFO - 'MAIL': '/var/mail/cltbld', 03:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:21 INFO - 'MOZ_NO_REMOTE': '1', 03:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:21 INFO - 'NO_EM_RESTART': '1', 03:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:21 INFO - 'PWD': '/builds/slave/test', 03:22:21 INFO - 'SHELL': '/bin/bash', 03:22:21 INFO - 'SHLVL': '1', 03:22:21 INFO - 'TERM': 'linux', 03:22:21 INFO - 'TMOUT': '86400', 03:22:21 INFO - 'USER': 'cltbld', 03:22:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:21 INFO - '_': '/tools/buildbot/bin/python'} 03:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:21 INFO - Running setup.py (path:/tmp/pip-6v4sIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:21 INFO - Running setup.py (path:/tmp/pip-L7oNY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:21 INFO - Running setup.py (path:/tmp/pip-BzTYyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:21 INFO - Running setup.py (path:/tmp/pip-kyqGzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:21 INFO - Running setup.py (path:/tmp/pip-ZGhkZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:21 INFO - Running setup.py (path:/tmp/pip-PvLary-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:21 INFO - Running setup.py (path:/tmp/pip-O7zPJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:21 INFO - Running setup.py (path:/tmp/pip-g64Ehp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:21 INFO - Running setup.py (path:/tmp/pip-UHu83F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:21 INFO - Running setup.py (path:/tmp/pip-tGQgW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:21 INFO - Running setup.py (path:/tmp/pip-Vroo4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:22 INFO - Running setup.py (path:/tmp/pip-nKXx0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:22 INFO - Running setup.py (path:/tmp/pip-mViaMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:22 INFO - Running setup.py (path:/tmp/pip-Qe_rX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:22 INFO - Running setup.py (path:/tmp/pip-e_hcyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:22 INFO - Running setup.py (path:/tmp/pip-5rfD4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:22 INFO - Running setup.py (path:/tmp/pip-lSUSRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:22 INFO - Running setup.py install for manifestparser 03:22:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozcrash 03:22:22 INFO - Running setup.py install for mozdebug 03:22:22 INFO - Running setup.py install for mozdevice 03:22:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozfile 03:22:23 INFO - Running setup.py install for mozhttpd 03:22:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozinfo 03:22:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozInstall 03:22:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozleak 03:22:23 INFO - Running setup.py install for mozlog 03:22:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for moznetwork 03:22:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozprocess 03:22:23 INFO - Running setup.py install for mozprofile 03:22:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozrunner 03:22:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozscreenshot 03:22:24 INFO - Running setup.py install for moztest 03:22:24 INFO - Running setup.py install for mozversion 03:22:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:24 INFO - Cleaning up... 03:22:24 INFO - Return code: 0 03:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:24 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:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:24 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:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:24 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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:24 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:22:24 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:22:24 INFO - Using env: {'DISPLAY': ':0', 03:22:24 INFO - 'HOME': '/home/cltbld', 03:22:24 INFO - 'LANG': 'en_US.UTF-8', 03:22:24 INFO - 'LANGUAGE': 'en_US:en', 03:22:24 INFO - 'LOGNAME': 'cltbld', 03:22:24 INFO - 'MAIL': '/var/mail/cltbld', 03:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:24 INFO - 'MOZ_NO_REMOTE': '1', 03:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:24 INFO - 'NO_EM_RESTART': '1', 03:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:24 INFO - 'PWD': '/builds/slave/test', 03:22:24 INFO - 'SHELL': '/bin/bash', 03:22:24 INFO - 'SHLVL': '1', 03:22:24 INFO - 'TERM': 'linux', 03:22:24 INFO - 'TMOUT': '86400', 03:22:24 INFO - 'USER': 'cltbld', 03:22:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:24 INFO - '_': '/tools/buildbot/bin/python'} 03:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:24 INFO - Running setup.py (path:/tmp/pip-oz5zBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:24 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:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:24 INFO - Running setup.py (path:/tmp/pip-MONkqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:24 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:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:24 INFO - Running setup.py (path:/tmp/pip-284VzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:24 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:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:24 INFO - Running setup.py (path:/tmp/pip-JfOIHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:24 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:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:24 INFO - Running setup.py (path:/tmp/pip-qlxz4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:24 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:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:24 INFO - Running setup.py (path:/tmp/pip-RAGptW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:24 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:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:24 INFO - Running setup.py (path:/tmp/pip-NC1fAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:25 INFO - Running setup.py (path:/tmp/pip-FD5UNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:25 INFO - Running setup.py (path:/tmp/pip-uupksd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:25 INFO - Running setup.py (path:/tmp/pip-nL1L4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:25 INFO - Running setup.py (path:/tmp/pip-B4oj7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:25 INFO - Running setup.py (path:/tmp/pip-0Bvfqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:25 INFO - Running setup.py (path:/tmp/pip-XwHTsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:25 INFO - Running setup.py (path:/tmp/pip-LhPbBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:25 INFO - Running setup.py (path:/tmp/pip-AzP6m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:25 INFO - Running setup.py (path:/tmp/pip-iWFqWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:25 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:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:25 INFO - Running setup.py (path:/tmp/pip-76KDSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:25 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:22:25 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:22:25 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:22:25 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:22:25 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:22:25 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:22:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:25 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:22:25 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:22:25 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:22:25 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:22:25 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:22:25 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:22:27 INFO - Downloading blessings-1.6.tar.gz 03:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:27 INFO - Installing collected packages: blessings 03:22:27 INFO - Running setup.py install for blessings 03:22:27 INFO - Successfully installed blessings 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:28 INFO - Reading from file tmpfile_stdout 03:22:28 INFO - Current package versions: 03:22:28 INFO - argparse == 1.2.1 03:22:28 INFO - blessings == 1.6 03:22:28 INFO - blobuploader == 1.2.4 03:22:28 INFO - docopt == 0.6.1 03:22:28 INFO - functools32 == 3.2.3-2 03:22:28 INFO - jsonschema == 2.5.1 03:22:28 INFO - manifestparser == 1.1 03:22:28 INFO - mozInstall == 1.12 03:22:28 INFO - mozcrash == 0.17 03:22:28 INFO - mozdebug == 0.1 03:22:28 INFO - mozdevice == 0.48 03:22:28 INFO - mozfile == 1.2 03:22:28 INFO - mozhttpd == 0.7 03:22:28 INFO - mozinfo == 0.9 03:22:28 INFO - mozleak == 0.1 03:22:28 INFO - mozlog == 3.2 03:22:28 INFO - moznetwork == 0.27 03:22:28 INFO - mozprocess == 0.22 03:22:28 INFO - mozprofile == 0.28 03:22:28 INFO - mozrunner == 6.11 03:22:28 INFO - mozscreenshot == 0.1 03:22:28 INFO - mozsystemmonitor == 0.3 03:22:28 INFO - moztest == 0.7 03:22:28 INFO - mozversion == 1.4 03:22:28 INFO - psutil == 3.1.1 03:22:28 INFO - requests == 1.2.3 03:22:28 INFO - wsgiref == 0.1.2 03:22:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:28 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 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:28 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:22:28 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:22:28 INFO - Using env: {'DISPLAY': ':0', 03:22:28 INFO - 'HOME': '/home/cltbld', 03:22:28 INFO - 'LANG': 'en_US.UTF-8', 03:22:28 INFO - 'LANGUAGE': 'en_US:en', 03:22:28 INFO - 'LOGNAME': 'cltbld', 03:22:28 INFO - 'MAIL': '/var/mail/cltbld', 03:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:28 INFO - 'MOZ_NO_REMOTE': '1', 03:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:28 INFO - 'NO_EM_RESTART': '1', 03:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:28 INFO - 'PWD': '/builds/slave/test', 03:22:28 INFO - 'SHELL': '/bin/bash', 03:22:28 INFO - 'SHLVL': '1', 03:22:28 INFO - 'TERM': 'linux', 03:22:28 INFO - 'TMOUT': '86400', 03:22:28 INFO - 'USER': 'cltbld', 03:22:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:28 INFO - '_': '/tools/buildbot/bin/python'} 03:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 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:22:28 INFO - Cleaning up... 03:22:28 INFO - Return code: 0 03:22:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:22:28 INFO - Using env: {'DISPLAY': ':0', 03:22:28 INFO - 'HOME': '/home/cltbld', 03:22:28 INFO - 'LANG': 'en_US.UTF-8', 03:22:28 INFO - 'LANGUAGE': 'en_US:en', 03:22:28 INFO - 'LOGNAME': 'cltbld', 03:22:28 INFO - 'MAIL': '/var/mail/cltbld', 03:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:28 INFO - 'MOZ_NO_REMOTE': '1', 03:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:28 INFO - 'NO_EM_RESTART': '1', 03:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:28 INFO - 'PWD': '/builds/slave/test', 03:22:28 INFO - 'SHELL': '/bin/bash', 03:22:28 INFO - 'SHLVL': '1', 03:22:28 INFO - 'TERM': 'linux', 03:22:28 INFO - 'TMOUT': '86400', 03:22:28 INFO - 'USER': 'cltbld', 03:22:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:28 INFO - '_': '/tools/buildbot/bin/python'} 03:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:22:28 INFO - Cleaning up... 03:22:28 INFO - Return code: 0 03:22:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dda582f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, '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': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', '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:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:22:28 INFO - Using env: {'DISPLAY': ':0', 03:22:28 INFO - 'HOME': '/home/cltbld', 03:22:28 INFO - 'LANG': 'en_US.UTF-8', 03:22:28 INFO - 'LANGUAGE': 'en_US:en', 03:22:28 INFO - 'LOGNAME': 'cltbld', 03:22:28 INFO - 'MAIL': '/var/mail/cltbld', 03:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:28 INFO - 'MOZ_NO_REMOTE': '1', 03:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:28 INFO - 'NO_EM_RESTART': '1', 03:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:28 INFO - 'PWD': '/builds/slave/test', 03:22:28 INFO - 'SHELL': '/bin/bash', 03:22:28 INFO - 'SHLVL': '1', 03:22:28 INFO - 'TERM': 'linux', 03:22:28 INFO - 'TMOUT': '86400', 03:22:28 INFO - 'USER': 'cltbld', 03:22:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:28 INFO - '_': '/tools/buildbot/bin/python'} 03:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:28 INFO - Downloading/unpacking flake8 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:31 INFO - no previously-included directories found matching 'docs/_build' 03:22:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:31 INFO - Running setup.py install for pep8 03:22:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:31 INFO - no previously-included directories found matching 'docs/_build' 03:22:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:22:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:31 INFO - Cleaning up... 03:22:31 INFO - Return code: 0 03:22:31 INFO - Running post-action listener: _resource_record_post_action 03:22:31 INFO - Running post-action listener: _start_resource_monitoring 03:22:31 INFO - Starting resource monitoring. 03:22:31 INFO - ##### 03:22:31 INFO - ##### Finished create-virtualenv step (success) 03:22:31 INFO - ##### 03:22:31 INFO - ##### 03:22:31 INFO - ##### Running install step. 03:22:31 INFO - ##### 03:22:31 INFO - Running pre-action listener: _resource_record_pre_action 03:22:31 INFO - Running main action method: install 03:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:31 INFO - Reading from file tmpfile_stdout 03:22:31 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:31 INFO - Reading from file tmpfile_stdout 03:22:31 INFO - Output received: 03:22:31 INFO - Usage: mozinstall [options] installer 03:22:31 INFO - Options: 03:22:31 INFO - -h, --help show this help message and exit 03:22:31 INFO - -d DEST, --destination=DEST 03:22:31 INFO - Directory to install application into. [default: 03:22:31 INFO - "/builds/slave/test"] 03:22:31 INFO - --app=APP Application being installed. [default: firefox] 03:22:31 INFO - mkdir: /builds/slave/test/build/application 03:22:31 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:22:31 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:22:47 INFO - Reading from file tmpfile_stdout 03:22:47 INFO - Output received: 03:22:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:22:47 INFO - Running post-action listener: _resource_record_post_action 03:22:47 INFO - ##### 03:22:47 INFO - ##### Finished install step (success) 03:22:47 INFO - ##### 03:22:47 INFO - ##### 03:22:47 INFO - ##### Running run-tests step. 03:22:47 INFO - ##### 03:22:47 INFO - Running pre-action listener: _resource_record_pre_action 03:22:47 INFO - Running main action method: run_tests 03:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:47 INFO - Python 2.7.3 03:22:47 INFO - Return code: 0 03:22:47 INFO - grabbing minidump binary from tooltool 03:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:47 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 0x252e990>, '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 0x249a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:47 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:22:47 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:22:47 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:22:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:48 INFO - Return code: 0 03:22:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:22:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:22:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:22:48 INFO - Return code: 0 03:22:49 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:22:49 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:22:49 INFO - Using env: {'DISPLAY': ':0', 03:22:49 INFO - 'HOME': '/home/cltbld', 03:22:49 INFO - 'LANG': 'en_US.UTF-8', 03:22:49 INFO - 'LANGUAGE': 'en_US:en', 03:22:49 INFO - 'LOGNAME': 'cltbld', 03:22:49 INFO - 'MAIL': '/var/mail/cltbld', 03:22:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:49 INFO - 'MOZ_NO_REMOTE': '1', 03:22:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:49 INFO - 'NO_EM_RESTART': '1', 03:22:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:49 INFO - 'PWD': '/builds/slave/test', 03:22:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:49 INFO - 'SHELL': '/bin/bash', 03:22:49 INFO - 'SHLVL': '1', 03:22:49 INFO - 'TERM': 'linux', 03:22:49 INFO - 'TMOUT': '86400', 03:22:49 INFO - 'USER': 'cltbld', 03:22:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465892094.12891-370948961', 03:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:49 INFO - '_': '/tools/buildbot/bin/python'} 03:22:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:22:49 INFO - mozversion application_buildid: 20160614004007 03:22:49 INFO - mozversion application_changeset: 1a585c67e88e31e89aa165f6b706600a2ef92386 03:22:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:22:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:49 INFO - mozversion application_name: Firefox 03:22:49 INFO - mozversion application_remotingname: firefox-dev 03:22:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:49 INFO - mozversion application_vendor: Mozilla 03:22:49 INFO - mozversion application_version: 49.0a2 03:22:49 INFO - mozversion platform_buildid: 20160614004007 03:22:49 INFO - mozversion platform_changeset: 1a585c67e88e31e89aa165f6b706600a2ef92386 03:22:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:49 INFO - mozversion platform_version: 49.0a2 03:22:49 INFO - using testdate: 1465899769 03:22:49 INFO - actual date: 1465899769 03:22:49 INFO - starting webserver on 'localhost:45999' 03:22:49 INFO - SUITE-START | Running 2 tests 03:22:49 INFO - TEST-START | dromaeo_css 03:22:49 INFO - operating with platform_type : linux_ 03:22:49 INFO - Initialising browser for dromaeo_css test... 03:22:50 INFO - TEST-INFO | started process 3392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCemVzR/profile http://localhost:45999/getInfo.html) 03:22:57 INFO - PROCESS | 3392 | __metrics Screen width/height:1600/1200 03:22:57 INFO - PROCESS | 3392 | colorDepth:24 03:22:57 INFO - PROCESS | 3392 | Browser inner width/height: 1024/697 03:22:57 INFO - PROCESS | 3392 | __metrics 03:22:58 ERROR - PROCESS | 3392 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:22:59 INFO - TEST-INFO | 3392: exit 0 03:22:59 INFO - Browser initialized. 03:22:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:59 INFO - TEST-INFO | started process 3525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCemVzR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:11 INFO - PROCESS | 3525 | RSS: Main: 155860992 03:23:11 INFO - PROCESS | 3525 | 03:24:01 INFO - PROCESS | 3525 | 1465899841173 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:26:09 INFO - PROCESS | 3525 | Cycle 1(1): loaded http://localhost:45999/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45999/tests/dromaeo/cssquery-ext.html) 03:26:10 INFO - PROCESS | 3525 | RSS: Main: 160829440 03:26:10 INFO - PROCESS | 3525 | 03:29:12 INFO - PROCESS | 3525 | Cycle 1(1): loaded http://localhost:45999/tests/dromaeo/cssquery-ext.html (next: http://localhost:45999/tests/dromaeo/cssquery-jquery.html) 03:29:12 INFO - PROCESS | 3525 | RSS: Main: 157622272 03:29:12 INFO - PROCESS | 3525 | 03:32:14 INFO - PROCESS | 3525 | Cycle 1(1): loaded http://localhost:45999/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45999/tests/dromaeo/cssquery-mootools.html) 03:32:15 INFO - PROCESS | 3525 | RSS: Main: 157175808 03:32:15 INFO - PROCESS | 3525 | 03:35:16 INFO - PROCESS | 3525 | Cycle 1(1): loaded http://localhost:45999/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45999/tests/dromaeo/cssquery-prototype.html) 03:35:17 INFO - PROCESS | 3525 | RSS: Main: 157048832 03:35:17 INFO - PROCESS | 3525 | 03:38:19 INFO - PROCESS | 3525 | Cycle 1(1): loaded http://localhost:45999/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45999/tests/dromaeo/cssquery-yui.html) 03:38:20 INFO - PROCESS | 3525 | RSS: Main: 158756864 03:38:20 INFO - PROCESS | 3525 | 03:41:22 INFO - PROCESS | 3525 | Cycle 1(1): loaded http://localhost:45999/tests/dromaeo/cssquery-yui.html (next: http://localhost:45999/tests/dromaeo/cssquery-dojo.html) 03:41:23 INFO - PROCESS | 3525 | RSS: Main: 159297536 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | __start_tp_report 03:41:23 INFO - PROCESS | 3525 | _x_x_mozilla_page_load 03:41:23 INFO - PROCESS | 3525 | _x_x_mozilla_page_load_details 03:41:23 INFO - PROCESS | 3525 | |i|pagename|runs| 03:41:23 INFO - PROCESS | 3525 | |0;dojo.html;3399.6600339966003;3402.387570237356;3415.999999999999;3432.0561845492502;3432.9357899051297;5626.859328516789;5650.180723795047;5665.980123577754;5686.118651609002;5705.572082093839;5656.717164141797;5716.571257155709;5750.453706897849;5752.827415177551;5766.279215098113;5124.6925184488955;5156.767945442464;5218.556422704075;5251.684898906059;5258.237555554442;5095.464976177504;5113.411957624865;5251.291075704788;5253.238280449333;5261.8947621047555;5149.176131818891;5195.40252870919;5196.688198708071;5235.397929238129;5248.8687782805355;5222.660527065747;5250.9737451312885;5302.655327403706;5307.495787900182;5308.150695888678;5158;5208;5267.631265811395;5272.789088436496;5288.312519372495;5439.700816455093;5538.667679939176;5542.362628297717;5592.356878958931;5639.125935480007;6128.417800308964;6140.662263575501;6155.72299246535;6176.1353410522115;6184.474319682832;5996.010658241385;6154.83058218937;6213.192285002966;6220.87558248837;6233.532485063638;5736.913946290809;5768.3654797972185;5806.709664516758;5840.328362238397;5866.1494083357675;6365.713542890581;6401.135846660734;6406.455451286693;6407.743690252338;6438.742450301936;5864.091065884794;5927.881442371128;6120.112583675342;6132.6933653317155;6144.8771024580155;6041.607295525777;6057.818265452043;6107.114468402056;6127.938720612826;6136.17161683176;6064.878702425926;6083.391660833881;6093.482054025369;6097.878042439126;6102.481289090389;5914.378990206053;6008.729607167688;6017.037274036134;6082.270127584629;6089.269287685417;4655.348251244761;4680.555347242007;4686.297055441711;4690;4707.741074240949;4183.414321994923;4184.372344148402;4193.035601811601;4200.537940826506;4213.620774130343;5847.8245652630485;5908.409159084057;5927.051671732502;5935.376785437553;5964.463198312173;5964.671943043088;6007.098935159761;6023.186869772612;6122.295935967331;6129.695011270001;5885.176075349455;5927.703614819242;6026.638401695912;6031.396860314021;6031.487323577458;5103.668261562986;5259.079661059376;5319.1223448131395;5347.518723314843;5358.785648574013;6368.586041907354;6477.481801455872;6512.153420055362;6516.609003459807;6535.542512024208;6273.309935907047;6285.842853928689;6290.370962903856;6291.370862913672;6297.496200304056;6184.8763024738355;6355.7457701693265;6418.326075761977;6478.093066970534;6504.642244676588;6148.815535533941;6152.876942461216;6158.076288556752;6164.506839452743;6174.691265436621;6209.844753881189;6241.157443745036;6246.812595622138;6256.31180570146;6261.279952805486;5759.65442073477;5884.0585506318785;5958.76164953397;5972.223610930551;6070.969645151746;5952.494038006818;6007.429294217042;6009.639421634716;6011.368806275453;6023.5783495156675;5855.677937713466;5856.648601083778;5916.201312822714;5916.911246331222;5928.79249226275;5875.911861321998;5901.852453688521;5963.194968679173;6025.156478092983;6048.969755151196;5922;5927.733252003756;5932.317783454958;5998.7300571473515;6005.87988240224 03:41:23 INFO - PROCESS | 3525 | |1;ext.html;598.4165438697271;648.1638686094938;657.5627207906742;666.4701562258005;675.3145557259379;45968.540314596845;46881;46936.53063469364;47364.763176184155;47414.2887856682;48193.277100843516;49128.75435622826;49205.261921071215;49224;49283.75358123204;8866.955665221665;9088.091190880925;9103.998560158378;9130.589123489459;9136;8987.730368088967;9100.499472529009;9123.224525915306;9148.085191480865;9153.221976132038;9147;9151.67969121081;9203.723888283363;9213.03263157369;9215.447073175597;8994.415363001417;9007.054259302777;9018.594163262636;9061.818763624691;9071.410358326688;8995.730128096167;9035.728928132166;9070.727878163665;9089.63641454341;9118.224950879183;44690;45065;45153;45294.773526132485;45367;4094.81900362393;4177.811998460046;4579.381783459257;4601.723896566184;4714.151452738506;34964.47553286703;35434.822825885705;36008.81995590031;36253.818730906176;36608;4531.68749658082;4581.9541804582195;4614.861554153381;4615.423072115986;4694.929576056362;371070;372236.13881930686;372965;373060;373188;38123.80938095347;67879;67884.6605766968;68269.65865170742;68657;38937;40903.590964090574;41088.589114109076;41150.588494115276;41186.58813411887;17177.828221717624;17238.482845514405;17382.65234695299;17389.826101739072;17480.737788933176;14123.858761412459;14148.717025659635;14159.221242831743;14195.858041419453;14236.644083897985;9274.30442716799;9364.438133711863;9371.859422108673;9403.623855045722;9449.102335278138;3505.964940350615;3588.69496092835;3597.4671913389316;3618.7466877318334;3628.7822730636244;1110.539126262608;1137.8748337682848;1141.4406940599213;1200.033972652006;1214.878512148778;34411.82794086064;34501.827490862386;34886.82556587201;34923.4761478578;35020.47469287963;1218.226426219357;1224.4367590908282;1264.5570816688955;1289.2006955687534;1347.5957212836306;18085.36701215451;18157.63684726298;18162.273509059753;18222.453326400228;18263.17815698297;568599;585867;589750;595125;600060;56746.71626641841;62414.68792656098;62415.6879215601;62654.686726566986;62671.6866415665;1487.4645127754;1511.894167408271;1517.9772303415457;1519.3163076615567;1524.9313780879886;32965.34069318648;33478.83260583682;33670.32659346848;34058.65941340555;34251.828740857134;54931.176032360345;55347.44652553584;55443.72278138583;55604;55637.721811390686;412568;413671;416022;419001;421480;30821.22946926345;31059.534106988864;31214.37571248517;31408.842955785076;31446.842765786023;50583.241251381995;51395.48604514057;51428.48571514386;52622.47377526176;52903.47096528985;42389.36415953701;43267.78366108149;43350.34974475322;44326;45046.549534505546;42300.73097807071;42512.574874252095;43088.78455607702;43155;44330.55669443264;42443.7877810609;43554.56445435505;43614.56385436105;43631.78184109059;43761.124777504905;37390.439143413416;37433.20834018083;38224.617753823215;38627.420588691755;38662.613373865905;29701.257468563457;29711.25721856971;30138.3972320548;30274.09177724672;30495.695043050175 03:41:23 INFO - PROCESS | 3525 | |2;jquery.html;432.3903296352144;432.75141381853945;436.0820472904538;437.06032031133043;437.687053756564;18132;19650.90174549129;20131.99340032998;21163.57672846542;21187.894060529678;12613.306268155247;13177.209367437936;13217.537386191485;13569.18584884905;19993.300234491795;5391.757370918308;5459.808906688267;5469.972650136744;5564.4713752193475;5574.303212098488;5486.177073438977;5502.58730595205;5504;5511.669299842002;5531.032069387861;5414.10667239905;5483.698396588186;5493.697846618435;5523.6409633373905;5585.966596179699;5474.91787623186;5513;5520.558355331564;5522.171674248854;5532.889342213153;5278.049951008817;5364;5367.1680889462195;5377.569794416438;5386.461353864622;22929.31212063641;23369.298921032398;23812.761872381227;23820.523589528286;23938.28185154448;2404.0624156578947;2534.0750626021554;2566.1916496303793;2661.4810112028163;2794.1198522465356;11180.27328223671;11202.94398528002;11285.661430157108;11359.659210223706;14552.981291309612;2031.7054027165977;2070.3892351756267;2122.6073176462405;2129.318618042227;2168.0785666092006;48986.26520602194;59466;75755;77161.22838771596;86512.13487865104;11392.430378481044;11771.117166212569;12094.697632559257;12164.14850960442;12203.572874949334;16936.322547098225;17010.82989170117;17075.573110672085;17108.57228569271;17135.57161070983;8666.436681615674;8742.125787421333;8807.955960220286;8818.162274583905;8914.73255802327;8336.416450848383;8388;8479.236868681848;8489.915100849035;8509;4927.704337739747;4965.8013679452415;5069.619778516626;5131.127708289525;5151.7681704323395;2160.2223199648115;2167.6531754919138;2172.837037222215;2195.637719776219;2202.9449263768215;1000.2548101664162;1042.7393151712072;1051.2273478993086;1075.8009768192753;1142.6800495861173;18549.35077272289;18948.81051189498;19374.70937935932;19491.22035118608;19589.706154407697;1031.7059638003284;1072.324435605579;1097.6213206443765;1103.7406209540752;1127.6786115956913;10724.14206863449;10814.513346899408;10975.176861735243;10982.231243812856;11076.612318568972;427596;458523;460052;478602;479306;80018.79971800427;90863.54568227117;92662;93015.53492232495;95438;1062.8512008318842;1078.8867168947304;1110.7945030169444;1136.170595465315;1142.817149256115;17143.65712685764;17394.73907891408;17408.912955435142;17580.64838703193;17760.200790964696;41388.70792076669;41858;42184.156316874105;42885.1422971545;43035;55492;56701.43298566961;57814.42185578091;58289;58312.4168758307;8600.913990860012;8645.783855403664;8812;9049.954750226207;9301.348905576544;9659.951700241734;12461.813072804096;13264.80102798478;13458.461661533429;13554;8066.959665201636;11281.379524126252;11374.545018199511;11566.248193867372;11989.76020479603;6015.639061656315;10062.943390943845;11362.772744545227;11536.423178841193;11741.29552226835;11760.35318057515;11787.646370608896;11829.112816538622;11887.465064071965;12026.15816892809;8784.51685157297;9087.909120908971;9099.772505687146;9146.588403521724;9243.352965292364;11569.19015668895;11653;11872.465739041936;11887.762244754884;11910.106741994558 03:41:23 INFO - PROCESS | 3525 | |3;mootools.html;1566.8668163206128;1606.0363781730962;1834.834864862163;1939.3503176435884;1955.0713411129707;8454.196851299132;9052.90947090529;9267;9897.50512474376;9898.802023959526;9126.817463650723;9410.435373877555;9431.528423578811;9447.574859131339;9527.333086683935;2560.3215147985798;2584.2505673354704;2596.3379338268714;2605.596132599441;2606.478704259146;2522.495500899818;2569.717331093578;2574.8197626166175;2580.458103798205;2581.638570600108;2570;2601.765841074303;2620.2532278300687;2620.737926207383;2621;2490.4645501217233;2494.463690306584;2500.524900268943;2527.317624241463;2529.304441278663;2219.700340454034;2242.7757224277443;2464.5933420985516;2471.0486462711806;2490.3649569359877;9478.052194780466;9525.19035881951;9538.427694338361;9548.570314335871;9573.952130239373;5692.573057020699;5847.327557330919;5849.473547380756;5859.44335288147;5863.677497737623;3767.6420740029926;3858.8649397271242;3879.12719638082;3890.455336252927;3947.0921688011917;1294.8964082873347;1305.3538498443236;1328.7940369242783;1330.8336457942758;1343.1605246720799;13202.603921882359;13317.067805253637;13342.599722008355;13346.466141354334;13438.731225375437;5161.2516185152945;5178.197379406198;5234.42421333653;5280.20796880471;5283.181106928432;11185;11203.99164075237;11221.326720396803;11229.494672739746;11262.7184320391;5641.548676105902;5694.088945768657;5720;5754.108113242454;5763.193152958589;4687.835925742583;5238.973805131026;5372.758225879845;5512.5589952803675;5525.640833345819;4476.552344765562;4480.081583275421;4483.30508771141;4548.681592288508;4606.286025666027;1425.6578421178842;1485.9331330090172;1491.261825396414;1493.357856121878;1493.4399600149943;970.335320305593;975.7121649113528;1092.8797832238447;1113.3598181045932;1123.1576317761678;6604.933950660528;6664.133662623828;6750.257471678112;6754.3245675433045;6757.797266082025;1013.4831236069657;1018.9657497639902;1084.1760262200785;1099.8900109988938;1107.2747350485445;4573.131105090022;4745.240761478147;4751.168545504523;4757.762111894392;4769.76151192439;12099.75800484003;12175;12407.131500795038;12415.068869834799;12457.875421245853;12364.56724014655;12474.002079833774;12531.561395351302;12542.686432839251;12559.93720031394;8964.641414343354;9074.092590740873;9153.725388238363;9167.541622918827;9303.209227215628;6449.742010319723;6488.805335839932;6566.671666416564;6670.7665231716655;6721.495887808336;11234.921539515215;11399.08807295431;11424.771504569695;11443.485043173243;11599.188056836278;11335.149863760085;11529.250598711056;11693.356865372487;11730.941345293219;11774.882251177722;7155.749548765768;8063.072746634212;8251.051129120227;8891.555422228992;9220.44677319363;9102.863457048017;9485.525723713648;9500.809983800147;9549.9045009549;9572.32993690435;8295.585220738818;8532.914670853212;8562.357823163164;8620.913790862262;8624.52565108925;8184.263416292562;8300.87548686758;8323.292520135856;8346;8382.088600976864;7797.7660670179985;7896.723614673689;7940.245676660708;7954.443188976716;7966.681332746625;5553.305836770403;5654.547636189177;5779.104238842986;5899.734511947058;5932.584719069624;5666.376698563237;5671.262735844314;5671.716414179357;5683.318001839806;5840.707964601838 03:41:23 INFO - PROCESS | 3525 | |4;prototype.html;364.51337464484914;368.99265006532164;371.7434969870789;372.3632588274052;372.7986887080978;5811.970940145298;5812.709364531767;5813.854653633662;5822.446867547586;5826.825195244144;5510.834674959758;5727.684977326246;5746.310442746876;5749.942500574993;5800.274965629296;4491.528389519102;4532.79602417892;4546.454425468948;4550.156152404747;4550.749708766017;4498.865034048984;4529.320601909707;4535.954640453586;4540.318952157187;4544.5682660147395;4420.646348292145;4438.223310920592;4503.864884053467;4523.683342166049;4529.524399938008;4464.464264288306;4473.105378924196;4476.239039363316;4482.39487669167;4484;3985.621365970228;4013.6588389986887;4013.7591744495426;4019.2363450944517;4031.6371526562457;5447.700376479292;5527.55779537636;5586.608937374385;5607.971960140214;5636.774529018834;5158.92261616076;5168.405633352175;5177.76700048495;5183.663061901002;5184.818531351422;6009.6394216346725;6034.487068599175;6039.909401358983;6082.996305609569;6105.755769769204;4279.1013887083745;4410.823567057314;4420.778961051935;4456.19788438081;4475.910481790378;5930.169776231331;6032.728527216286;6246.344133865924;6257.155284036642;6265.363630913137;4519.141363141059;4519.615832654261;4522.751248681354;4524.34397012438;4545.499995000548;4558.247889098262;4560.498345182027;4579.748113853703;4587.49981260214;4597.42532183477;4897.951020489821;5126.948730512647;5188.11801993662;5198.506141916588;5229.529342359206;5953.8566116198135;6030.457258846637;6052.182955300978;6068.544859135583;6070.848228794227;1532.9080255184724;1541.5837723814732;1553.2156261088078;1558.2286768049887;1578.2582186372388;958.9952050239843;984.960601575929;992.4243938515643;997.042838874674;998.4308943902051;5165.9483405165465;5185.792568297301;5206.167013277857;5217.895642087137;5239.240310155083;5544.390117087117;5555.666660000332;5569.888602228014;5578.442155784389;5600;4996.925046124311;5207.776172599436;5250.553702935294;5288.36539615241;5322.695939494849;2941.1617688958545;2950.3066779306846;2979.61265035544;2979.9851000744857;2988.2678743707497;5629.958457685341;5754.338251101177;5763.049096899049;5780.5953583248765;5788.565857560699;5917.751254523339;6300.653464059429;6392.8492871283615;6402.519811014099;6425.871482570323;6476.5466417350335;6522.804315870531;6536.346365363521;6542.672866356758;6553.377429144223;6062.787802426894;6221.471174949999;6252.687365631791;6287.1512345832725;6309.400606942333;6054.273487181566;6102.786402475892;6161.353057929032;6182.526989204174;6204.162438070803;6506.512011599244;6509.381608747161;6514.348565143448;6543.247526534509;6559.573627714183;4441.777911104367;4505;4518.6611004175475;4526.207913615039;4531.886702832324;6219;6281.497480201481;6322.557420980487;6327.557071004985;6397.4562162216735;6001.939980600138;6104.175936248727;6121.418465245794;6165.5375846810775;6172.98145805937;5889.64662120257;6123.387661233841;6133.049377346519;6168.845778855564;6210.223722034746;6007.909881351696;6026.186464827192;6071.39286071407;6092.147099406176;6102.809952059306;6052.852516691384;6087.847803804941;6120.081987701702;6131.509479241561;6134.171886795226;5760.481556659921;5968.731407086779;5970.537218381524;5996.910046349221;6005.609635373687 03:41:23 INFO - PROCESS | 3525 | |5;yui.html;804;806.5200357344273;823.2960818500183;823.5964377455045;856.1780690537084;15156.166410847412;15511.146886921215;15965.92017039916;16032.999999999985;16071.437499687514;15892.443764468246;16013.599660008505;16075;16104.83895161048;16212.189390530455;863.4646519158131;870.6778491957984;878.319302540533;881.0440671870996;890.6749036601659;889.8264838356523;890.812929284851;895.2569367425054;895.5835536475538;896.8834051573286;915.1809130827905;922.7739203895055;925.6482536636069;929.586334081334;933.5705575435308;923.1783712495817;924.7965447601517;927.0590350793949;928.9349745517817;929.9116583924516;678.7217240931194;682.6757290287123;684.0423407229918;687.2646268492715;687.4431710314611;15532.378704851792;15537.14545699986;15557.377704891791;15568.299426525833;15628.374865005386;15750.527484175493;15986;16126.838731612652;16155.273012714457;16156.27296771648;13065.216087034712;13087.345632718327;13145.539906103337;13158.802617960739;13197.802032969514;4052.615001574846;4088.7342322748927;4103.173424426934;4132.938005929914;4169.207850508394;78562.60718696428;78585.21414785837;79165;79924.20075799225;82128;11501.482433290523;11581.478833452515;11777.764444711058;12022.338771367484;12162.635120946386;22377.888110559343;22552.66171007436;22625.88687056554;22627.66058509124;22651.093956241897;8783.34124940632;8869.649060898699;9044.095590440904;9166.67916622915;9245.167934885892;5163.096458119814;5230.08473517133;5254.238135470336;5319.095753721799;5437.238786569884;3779.9433008504893;3855.5373355197557;3871.438641397038;3889.4943657324366;3900.804959752001;624.3693869192149;624.3849807939176;636.3477435628517;639.398964972924;643.8776632439822;708.5252880570031;740.5667684404576;845.9830803383898;849.1932663969254;851.5614458553849;10610.363378197178;10973.451327433597;11051.392173430539;11292.096632269398;11427.542898283975;831.8887361268811;837.7235512280932;838.7609531283555;840.8360369727844;851.5359129274436;4842.322074909515;4860.441049279308;4873.707577545359;5224.582033437316;5337.572994160458;72051.63974180096;112634;116600;118757;119218.40390797991;84395.15604843873;99322;100815.49592251991;101049;104541;63188;90371;90882;91156.54421727848;91719.08280917238;9576.856347154659;9693.951530242304;9725.4650994196;9746.610135594497;9933.801323973625;53169.202461962326;53560.46439535711;53756.731216343665;54892.45107549033;55424;73394;77641.61179194068;77948.61025694835;79154.6042269785;79380.60309698415;12253.326067066397;12380.62858114222;12384.62846114618;12408.875911240772;12609.621711348675;13965.650858728613;14696.55910322692;14844.257787110386;15443.301236864161;15885.523434296989;14106.29468526549;14259.215743134228;15412.614684632974;15528.611784705472;15675.294611742727;14974.625634359229;15128.167950762814;15349.539513814603;15386.461473848361;15996.20018999022;12849.743005140032;13389.397477113358;13648.454061837416;14443.638909026939;14476.276186190438;12167.634970950885;12285.140040197459;12507.124501284823;12936.611901642966;12955.157914735511;12650.873491264969;12712.491500339884;13014.674633134247;13167.934160329138;13293.20240785556 03:41:23 INFO - PROCESS | 3525 | __end_tp_report 03:41:23 INFO - PROCESS | 3525 | __start_cc_report 03:41:23 INFO - PROCESS | 3525 | _x_x_mozilla_cycle_collect,334 03:41:23 INFO - PROCESS | 3525 | __end_cc_report 03:41:23 INFO - PROCESS | 3525 | __startTimestamp1465900883024__endTimestamp 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | ------- Summary: start ------- 03:41:23 INFO - PROCESS | 3525 | Number of tests: 6 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | [#0] dojo.html Cycles:165 Average:5717.05 Median:5927.88 stddev:651.05 (11.0%) stddev-sans-first:627.15 03:41:23 INFO - PROCESS | 3525 | Values: 3399.7 3402.4 3416.0 3432.1 3432.9 5626.9 5650.2 5666.0 5686.1 5705.6 5656.7 5716.6 5750.5 5752.8 5766.3 5124.7 5156.8 5218.6 5251.7 5258.2 5095.5 5113.4 5251.3 5253.2 5261.9 5149.2 5195.4 5196.7 5235.4 5248.9 5222.7 5251.0 5302.7 5307.5 5308.2 5158.0 5208.0 5267.6 5272.8 5288.3 5439.7 5538.7 5542.4 5592.4 5639.1 6128.4 6140.7 6155.7 6176.1 6184.5 5996.0 6154.8 6213.2 6220.9 6233.5 5736.9 5768.4 5806.7 5840.3 5866.1 6365.7 6401.1 6406.5 6407.7 6438.7 5864.1 5927.9 6120.1 6132.7 6144.9 6041.6 6057.8 6107.1 6127.9 6136.2 6064.9 6083.4 6093.5 6097.9 6102.5 5914.4 6008.7 6017.0 6082.3 6089.3 4655.3 4680.6 4686.3 4690.0 4707.7 4183.4 4184.4 4193.0 4200.5 4213.6 5847.8 5908.4 5927.1 5935.4 5964.5 5964.7 6007.1 6023.2 6122.3 6129.7 5885.2 5927.7 6026.6 6031.4 6031.5 5103.7 5259.1 5319.1 5347.5 5358.8 6368.6 6477.5 6512.2 6516.6 6535.5 6273.3 6285.8 6290.4 6291.4 6297.5 6184.9 6355.7 6418.3 6478.1 6504.6 6148.8 6152.9 6158.1 6164.5 6174.7 6209.8 6241.2 6246.8 6256.3 6261.3 5759.7 5884.1 5958.8 5972.2 6071.0 5952.5 6007.4 6009.6 6011.4 6023.6 5855.7 5856.6 5916.2 5916.9 5928.8 5875.9 5901.9 5963.2 6025.2 6049.0 5922.0 5927.7 5932.3 5998.7 6005.9 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | [#1] ext.html Cycles:180 Average:62356.44 Median:43452.46 stddev:124380.31 (286.2%) stddev-sans-first:124642.79 03:41:23 INFO - PROCESS | 3525 | Values: 598.4 648.2 657.6 666.5 675.3 45968.5 46881.0 46936.5 47364.8 47414.3 48193.3 49128.8 49205.3 49224.0 49283.8 8867.0 9088.1 9104.0 9130.6 9136.0 8987.7 9100.5 9123.2 9148.1 9153.2 9147.0 9151.7 9203.7 9213.0 9215.4 8994.4 9007.1 9018.6 9061.8 9071.4 8995.7 9035.7 9070.7 9089.6 9118.2 44690.0 45065.0 45153.0 45294.8 45367.0 4094.8 4177.8 4579.4 4601.7 4714.2 34964.5 35434.8 36008.8 36253.8 36608.0 4531.7 4582.0 4614.9 4615.4 4694.9 371070.0 372236.1 372965.0 373060.0 373188.0 38123.8 67879.0 67884.7 68269.7 68657.0 38937.0 40903.6 41088.6 41150.6 41186.6 17177.8 17238.5 17382.7 17389.8 17480.7 14123.9 14148.7 14159.2 14195.9 14236.6 9274.3 9364.4 9371.9 9403.6 9449.1 3506.0 3588.7 3597.5 3618.7 3628.8 1110.5 1137.9 1141.4 1200.0 1214.9 34411.8 34501.8 34886.8 34923.5 35020.5 1218.2 1224.4 1264.6 1289.2 1347.6 18085.4 18157.6 18162.3 18222.5 18263.2 568599.0 585867.0 589750.0 595125.0 600060.0 56746.7 62414.7 62415.7 62654.7 62671.7 1487.5 1511.9 1518.0 1519.3 1524.9 32965.3 33478.8 33670.3 34058.7 34251.8 54931.2 55347.4 55443.7 55604.0 55637.7 412568.0 413671.0 416022.0 419001.0 421480.0 30821.2 31059.5 31214.4 31408.8 31446.8 50583.2 51395.5 51428.5 52622.5 52903.5 42389.4 43267.8 43350.3 44326.0 45046.5 42300.7 42512.6 43088.8 43155.0 44330.6 42443.8 43554.6 43614.6 43631.8 43761.1 37390.4 37433.2 38224.6 38627.4 38662.6 29701.3 29711.3 30138.4 30274.1 30495.7 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | [#2] jquery.html Cycles:180 Average:27840.74 Median:23879.40 stddev:76006.27 (318.3%) stddev-sans-first:76191.63 03:41:23 INFO - PROCESS | 3525 | Values: 432.4 432.8 436.1 437.1 437.7 18132.0 19650.9 20132.0 21163.6 21187.9 12613.3 13177.2 13217.5 13569.2 19993.3 5391.8 5459.8 5470.0 5564.5 5574.3 5486.2 5502.6 5504.0 5511.7 5531.0 5414.1 5483.7 5493.7 5523.6 5586.0 5474.9 5513.0 5520.6 5522.2 5532.9 5278.0 5364.0 5367.2 5377.6 5386.5 22929.3 23369.3 23812.8 23820.5 23938.3 2404.1 2534.1 2566.2 2661.5 2794.1 11180.3 11202.9 11285.7 11359.7 14553.0 2031.7 2070.4 2122.6 2129.3 2168.1 48986.3 59466.0 75755.0 77161.2 86512.1 11392.4 11771.1 12094.7 12164.1 12203.6 16936.3 17010.8 17075.6 17108.6 17135.6 8666.4 8742.1 8808.0 8818.2 8914.7 8336.4 8388.0 8479.2 8489.9 8509.0 4927.7 4965.8 5069.6 5131.1 5151.8 2160.2 2167.7 2172.8 2195.6 2202.9 1000.3 1042.7 1051.2 1075.8 1142.7 18549.4 18948.8 19374.7 19491.2 19589.7 1031.7 1072.3 1097.6 1103.7 1127.7 10724.1 10814.5 10975.2 10982.2 11076.6 427596.0 458523.0 460052.0 478602.0 479306.0 80018.8 90863.5 92662.0 93015.5 95438.0 1062.9 1078.9 1110.8 1136.2 1142.8 17143.7 17394.7 17408.9 17580.6 17760.2 41388.7 41858.0 42184.2 42885.1 43035.0 55492.0 56701.4 57814.4 58289.0 58312.4 8600.9 8645.8 8812.0 9050.0 9301.3 9660.0 12461.8 13264.8 13458.5 13554.0 8067.0 11281.4 11374.5 11566.2 11989.8 6015.6 10062.9 11362.8 11536.4 11741.3 11760.4 11787.6 11829.1 11887.5 12026.2 8784.5 9087.9 9099.8 9146.6 9243.4 11569.2 11653.0 11872.5 11887.8 11910.1 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | [#3] mootools.html Cycles:180 Average:6430.69 Median:4748.20 stddev:3644.47 (76.8%) stddev-sans-first:3636.36 03:41:23 INFO - PROCESS | 3525 | Values: 1566.9 1606.0 1834.8 1939.4 1955.1 8454.2 9052.9 9267.0 9897.5 9898.8 9126.8 9410.4 9431.5 9447.6 9527.3 2560.3 2584.3 2596.3 2605.6 2606.5 2522.5 2569.7 2574.8 2580.5 2581.6 2570.0 2601.8 2620.3 2620.7 2621.0 2490.5 2494.5 2500.5 2527.3 2529.3 2219.7 2242.8 2464.6 2471.0 2490.4 9478.1 9525.2 9538.4 9548.6 9574.0 5692.6 5847.3 5849.5 5859.4 5863.7 3767.6 3858.9 3879.1 3890.5 3947.1 1294.9 1305.4 1328.8 1330.8 1343.2 13202.6 13317.1 13342.6 13346.5 13438.7 5161.3 5178.2 5234.4 5280.2 5283.2 11185.0 11204.0 11221.3 11229.5 11262.7 5641.5 5694.1 5720.0 5754.1 5763.2 4687.8 5239.0 5372.8 5512.6 5525.6 4476.6 4480.1 4483.3 4548.7 4606.3 1425.7 1485.9 1491.3 1493.4 1493.4 970.3 975.7 1092.9 1113.4 1123.2 6604.9 6664.1 6750.3 6754.3 6757.8 1013.5 1019.0 1084.2 1099.9 1107.3 4573.1 4745.2 4751.2 4757.8 4769.8 12099.8 12175.0 12407.1 12415.1 12457.9 12364.6 12474.0 12531.6 12542.7 12559.9 8964.6 9074.1 9153.7 9167.5 9303.2 6449.7 6488.8 6566.7 6670.8 6721.5 11234.9 11399.1 11424.8 11443.5 11599.2 11335.1 11529.3 11693.4 11730.9 11774.9 7155.7 8063.1 8251.1 8891.6 9220.4 9102.9 9485.5 9500.8 9549.9 9572.3 8295.6 8532.9 8562.4 8620.9 8624.5 8184.3 8300.9 8323.3 8346.0 8382.1 7797.8 7896.7 7940.2 7954.4 7966.7 5553.3 5654.5 5779.1 5899.7 5932.6 5666.4 5671.3 5671.7 5683.3 5840.7 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | [#4] prototype.html Cycles:180 Average:5045.17 Median:5633.37 stddev:1486.60 (26.4%) stddev-sans-first:1448.67 03:41:23 INFO - PROCESS | 3525 | Values: 364.5 369.0 371.7 372.4 372.8 5812.0 5812.7 5813.9 5822.4 5826.8 5510.8 5727.7 5746.3 5749.9 5800.3 4491.5 4532.8 4546.5 4550.2 4550.7 4498.9 4529.3 4536.0 4540.3 4544.6 4420.6 4438.2 4503.9 4523.7 4529.5 4464.5 4473.1 4476.2 4482.4 4484.0 3985.6 4013.7 4013.8 4019.2 4031.6 5447.7 5527.6 5586.6 5608.0 5636.8 5158.9 5168.4 5177.8 5183.7 5184.8 6009.6 6034.5 6039.9 6083.0 6105.8 4279.1 4410.8 4420.8 4456.2 4475.9 5930.2 6032.7 6246.3 6257.2 6265.4 4519.1 4519.6 4522.8 4524.3 4545.5 4558.2 4560.5 4579.7 4587.5 4597.4 4898.0 5126.9 5188.1 5198.5 5229.5 5953.9 6030.5 6052.2 6068.5 6070.8 1532.9 1541.6 1553.2 1558.2 1578.3 959.0 985.0 992.4 997.0 998.4 5165.9 5185.8 5206.2 5217.9 5239.2 5544.4 5555.7 5569.9 5578.4 5600.0 4996.9 5207.8 5250.6 5288.4 5322.7 2941.2 2950.3 2979.6 2980.0 2988.3 5630.0 5754.3 5763.0 5780.6 5788.6 5917.8 6300.7 6392.8 6402.5 6425.9 6476.5 6522.8 6536.3 6542.7 6553.4 6062.8 6221.5 6252.7 6287.2 6309.4 6054.3 6102.8 6161.4 6182.5 6204.2 6506.5 6509.4 6514.3 6543.2 6559.6 4441.8 4505.0 4518.7 4526.2 4531.9 6219.0 6281.5 6322.6 6327.6 6397.5 6001.9 6104.2 6121.4 6165.5 6173.0 5889.6 6123.4 6133.0 6168.8 6210.2 6007.9 6026.2 6071.4 6092.1 6102.8 6052.9 6087.8 6120.1 6131.5 6134.2 5760.5 5968.7 5970.5 5996.9 6005.6 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - PROCESS | 3525 | [#5] yui.html Cycles:180 Average:21281.58 Median:4151.07 stddev:29713.59 (715.8%) stddev-sans-first:29757.16 03:41:23 INFO - PROCESS | 3525 | Values: 804.0 806.5 823.3 823.6 856.2 15156.2 15511.1 15965.9 16033.0 16071.4 15892.4 16013.6 16075.0 16104.8 16212.2 863.5 870.7 878.3 881.0 890.7 889.8 890.8 895.3 895.6 896.9 915.2 922.8 925.6 929.6 933.6 923.2 924.8 927.1 928.9 929.9 678.7 682.7 684.0 687.3 687.4 15532.4 15537.1 15557.4 15568.3 15628.4 15750.5 15986.0 16126.8 16155.3 16156.3 13065.2 13087.3 13145.5 13158.8 13197.8 4052.6 4088.7 4103.2 4132.9 4169.2 78562.6 78585.2 79165.0 79924.2 82128.0 11501.5 11581.5 11777.8 12022.3 12162.6 22377.9 22552.7 22625.9 22627.7 22651.1 8783.3 8869.6 9044.1 9166.7 9245.2 5163.1 5230.1 5254.2 5319.1 5437.2 3779.9 3855.5 3871.4 3889.5 3900.8 624.4 624.4 636.3 639.4 643.9 708.5 740.6 846.0 849.2 851.6 10610.4 10973.5 11051.4 11292.1 11427.5 831.9 837.7 838.8 840.8 851.5 4842.3 4860.4 4873.7 5224.6 5337.6 72051.6 112634.0 116600.0 118757.0 119218.4 84395.2 99322.0 100815.5 101049.0 104541.0 63188.0 90371.0 90882.0 91156.5 91719.1 9576.9 9694.0 9725.5 9746.6 9933.8 53169.2 53560.5 53756.7 54892.5 55424.0 73394.0 77641.6 77948.6 79154.6 79380.6 12253.3 12380.6 12384.6 12408.9 12609.6 13965.7 14696.6 14844.3 15443.3 15885.5 14106.3 14259.2 15412.6 15528.6 15675.3 14974.6 15128.2 15349.5 15386.5 15996.2 12849.7 13389.4 13648.5 14443.6 14476.3 12167.6 12285.1 12507.1 12936.6 12955.2 12650.9 12712.5 13014.7 13167.9 13293.2 03:41:23 INFO - PROCESS | 3525 | -------- Summary: end -------- 03:41:23 INFO - PROCESS | 3525 | 03:41:23 INFO - TEST-INFO | 3525: exit 0 03:41:23 INFO - TEST-OK | dromaeo_css | took 1113795ms 03:41:23 INFO - TEST-START | kraken 03:41:23 INFO - operating with platform_type : linux_ 03:41:23 INFO - Initialising browser for kraken test... 03:41:23 INFO - TEST-INFO | started process 3768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplJRjXM/profile http://localhost:45999/getInfo.html) 03:41:29 INFO - PROCESS | 3768 | __metrics Screen width/height:1600/1200 03:41:29 INFO - PROCESS | 3768 | colorDepth:24 03:41:29 INFO - PROCESS | 3768 | Browser inner width/height: 1024/697 03:41:29 INFO - PROCESS | 3768 | __metrics 03:41:30 ERROR - PROCESS | 3768 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:41:30 INFO - TEST-INFO | 3768: exit 0 03:41:30 INFO - Browser initialized. 03:41:30 INFO - Running cycle 1/1 for kraken test... 03:41:30 INFO - TEST-INFO | started process 3903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplJRjXM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:42 INFO - PROCESS | 3903 | RSS: Main: 155987968 03:41:42 INFO - PROCESS | 3903 | 03:41:45 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45999/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:46 INFO - PROCESS | 3903 | RSS: Main: 160440320 03:41:46 INFO - PROCESS | 3903 | 03:41:48 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45999/tests/kraken/driver.html?testName=audio-dft) 03:41:49 INFO - PROCESS | 3903 | RSS: Main: 160108544 03:41:49 INFO - PROCESS | 3903 | 03:41:52 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45999/tests/kraken/driver.html?testName=audio-fft) 03:41:52 INFO - PROCESS | 3903 | RSS: Main: 160772096 03:41:52 INFO - PROCESS | 3903 | 03:41:54 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45999/tests/kraken/driver.html?testName=audio-oscillator) 03:41:55 INFO - PROCESS | 3903 | RSS: Main: 160268288 03:41:55 INFO - PROCESS | 3903 | 03:41:57 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45999/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:58 INFO - PROCESS | 3903 | RSS: Main: 160272384 03:41:58 INFO - PROCESS | 3903 | 03:42:01 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45999/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:01 INFO - PROCESS | 3903 | RSS: Main: 160374784 03:42:01 INFO - PROCESS | 3903 | 03:42:05 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45999/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:05 INFO - PROCESS | 3903 | RSS: Main: 160964608 03:42:05 INFO - PROCESS | 3903 | 03:42:08 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45999/tests/kraken/driver.html?testName=json-parse-financial) 03:42:09 INFO - PROCESS | 3903 | RSS: Main: 160542720 03:42:09 INFO - PROCESS | 3903 | 03:42:10 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45999/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:11 INFO - PROCESS | 3903 | RSS: Main: 160751616 03:42:11 INFO - PROCESS | 3903 | 03:42:13 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:13 INFO - PROCESS | 3903 | RSS: Main: 160632832 03:42:13 INFO - PROCESS | 3903 | 03:42:16 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:16 INFO - PROCESS | 3903 | RSS: Main: 161566720 03:42:16 INFO - PROCESS | 3903 | 03:42:19 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:19 INFO - PROCESS | 3903 | RSS: Main: 160780288 03:42:19 INFO - PROCESS | 3903 | 03:42:22 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:23 INFO - PROCESS | 3903 | RSS: Main: 160956416 03:42:23 INFO - PROCESS | 3903 | 03:42:24 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:45999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45999/tests/kraken/driver.html?testName=ai-astar) 03:42:25 INFO - PROCESS | 3903 | RSS: Main: 162070528 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | __start_tp_report 03:42:25 INFO - PROCESS | 3903 | _x_x_mozilla_page_load 03:42:25 INFO - PROCESS | 3903 | _x_x_mozilla_page_load_details 03:42:25 INFO - PROCESS | 3903 | |i|pagename|runs| 03:42:25 INFO - PROCESS | 3903 | |0;ai-astar;114;106;110;111;110;114;111;111;111;109 03:42:25 INFO - PROCESS | 3903 | |1;audio-beat-detection;154;131;151;169;129;144;156;127;177;125 03:42:25 INFO - PROCESS | 3903 | |2;audio-dft;163;161;161;162;162;162;161;163;160;162 03:42:25 INFO - PROCESS | 3903 | |3;audio-fft;74;77;75;180;75;77;76;77;163;79 03:42:25 INFO - PROCESS | 3903 | |4;audio-oscillator;84;84;145;87;85;84;139;85;86;148 03:42:25 INFO - PROCESS | 3903 | |5;imaging-gaussian-blur;118;118;117;118;118;118;118;117;117;118 03:42:25 INFO - PROCESS | 3903 | |6;imaging-darkroom;147;147;149;147;147;149;148;147;147;147 03:42:25 INFO - PROCESS | 3903 | |7;imaging-desaturate;95;96;96;95;97;96;96;96;95;95 03:42:25 INFO - PROCESS | 3903 | |8;json-parse-financial;56;54;54;54;54;54;55;53;53;55 03:42:25 INFO - PROCESS | 3903 | |9;json-stringify-tinderbox;60;60;61;62;60;59;58;60;62;61 03:42:25 INFO - PROCESS | 3903 | |10;stanford-crypto-aes;76;76;75;76;79;77;87;79;106;77 03:42:25 INFO - PROCESS | 3903 | |11;stanford-crypto-ccm;129;138;135;122;138;121;127;122;132;140 03:42:25 INFO - PROCESS | 3903 | |12;stanford-crypto-pbkdf2;153;154;154;154;161;155;155;154;152;158 03:42:25 INFO - PROCESS | 3903 | |13;stanford-crypto-sha256-iterative;67;63;62;61;62;60;71;62;60;60 03:42:25 INFO - PROCESS | 3903 | __end_tp_report 03:42:25 INFO - PROCESS | 3903 | __start_cc_report 03:42:25 INFO - PROCESS | 3903 | _x_x_mozilla_cycle_collect,899 03:42:25 INFO - PROCESS | 3903 | __end_cc_report 03:42:25 INFO - PROCESS | 3903 | __startTimestamp1465900945120__endTimestamp 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | ------- Summary: start ------- 03:42:25 INFO - PROCESS | 3903 | Number of tests: 14 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.31 (2.1%) stddev-sans-first:2.12 03:42:25 INFO - PROCESS | 3903 | Values: 114.0 106.0 110.0 111.0 110.0 114.0 111.0 111.0 111.0 109.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:18.25 (12.0%) stddev-sans-first:19.14 03:42:25 INFO - PROCESS | 3903 | Values: 154.0 131.0 151.0 169.0 129.0 144.0 156.0 127.0 177.0 125.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 03:42:25 INFO - PROCESS | 3903 | Values: 163.0 161.0 161.0 162.0 162.0 162.0 161.0 163.0 160.0 162.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.50 stddev:40.38 (52.8%) stddev-sans-first:42.09 03:42:25 INFO - PROCESS | 3903 | Values: 74.0 77.0 75.0 180.0 75.0 77.0 76.0 77.0 163.0 79.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.50 stddev:28.60 (33.8%) stddev-sans-first:29.52 03:42:25 INFO - PROCESS | 3903 | Values: 84.0 84.0 145.0 87.0 85.0 84.0 139.0 85.0 86.0 148.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:42:25 INFO - PROCESS | 3903 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 03:42:25 INFO - PROCESS | 3903 | Values: 147.0 147.0 149.0 147.0 147.0 149.0 148.0 147.0 147.0 147.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:42:25 INFO - PROCESS | 3903 | Values: 95.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 95.0 95.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.71 03:42:25 INFO - PROCESS | 3903 | Values: 56.0 54.0 54.0 54.0 54.0 54.0 55.0 53.0 53.0 55.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:1.25 (2.1%) stddev-sans-first:1.32 03:42:25 INFO - PROCESS | 3903 | Values: 60.0 60.0 61.0 62.0 60.0 59.0 58.0 60.0 62.0 61.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:77.00 stddev:9.50 (12.3%) stddev-sans-first:9.91 03:42:25 INFO - PROCESS | 3903 | Values: 76.0 76.0 75.0 76.0 79.0 77.0 87.0 79.0 106.0 77.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:133.50 stddev:7.26 (5.4%) stddev-sans-first:7.68 03:42:25 INFO - PROCESS | 3903 | Values: 129.0 138.0 135.0 122.0 138.0 121.0 127.0 122.0 132.0 140.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:154.50 stddev:2.62 (1.7%) stddev-sans-first:2.68 03:42:25 INFO - PROCESS | 3903 | Values: 153.0 154.0 154.0 154.0 161.0 155.0 155.0 154.0 152.0 158.0 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - PROCESS | 3903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:3.55 (5.7%) stddev-sans-first:3.43 03:42:25 INFO - PROCESS | 3903 | Values: 67.0 63.0 62.0 61.0 62.0 60.0 71.0 62.0 60.0 60.0 03:42:25 INFO - PROCESS | 3903 | -------- Summary: end -------- 03:42:25 INFO - PROCESS | 3903 | 03:42:25 INFO - TEST-INFO | 3903: exit 0 03:42:26 INFO - TEST-OK | kraken | took 62320ms 03:42:26 INFO - SUITE-END | took 1176s 03:42:26 INFO - Completed test suite (00:19:36) 03:42:26 INFO - javascript benchmark 03:42:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7681.067856680257, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.6600339966003, 3402.387570237356, 3415.999999999999, 3432.0561845492502, 3432.9357899051297, 5626.859328516789, 5650.180723795047, 5665.980123577754, 5686.118651609002, 5705.572082093839, 5656.717164141797, 5716.571257155709, 5750.453706897849, 5752.827415177551, 5766.279215098113, 5124.6925184488955, 5156.767945442464, 5218.556422704075, 5251.684898906059, 5258.237555554442, 5095.464976177504, 5113.411957624865, 5251.291075704788, 5253.238280449333, 5261.8947621047555, 5149.176131818891, 5195.40252870919, 5196.688198708071, 5235.397929238129, 5248.8687782805355, 5222.660527065747, 5250.9737451312885, 5302.655327403706, 5307.495787900182, 5308.150695888678, 5158.0, 5208.0, 5267.631265811395, 5272.789088436496, 5288.312519372495, 5439.700816455093, 5538.667679939176, 5542.362628297717, 5592.356878958931, 5639.125935480007, 6128.417800308964, 6140.662263575501, 6155.72299246535, 6176.1353410522115, 6184.474319682832, 5996.010658241385, 6154.83058218937, 6213.192285002966, 6220.87558248837, 6233.532485063638, 5736.913946290809, 5768.3654797972185, 5806.709664516758, 5840.328362238397, 5866.1494083357675, 6365.713542890581, 6401.135846660734, 6406.455451286693, 6407.743690252338, 6438.742450301936, 5864.091065884794, 5927.881442371128, 6120.112583675342, 6132.6933653317155, 6144.8771024580155, 6041.607295525777, 6057.818265452043, 6107.114468402056, 6127.938720612826, 6136.17161683176, 6064.878702425926, 6083.391660833881, 6093.482054025369, 6097.878042439126, 6102.481289090389, 5914.378990206053, 6008.729607167688, 6017.037274036134, 6082.270127584629, 6089.269287685417, 4655.348251244761, 4680.555347242007, 4686.297055441711, 4690.0, 4707.741074240949, 4183.414321994923, 4184.372344148402, 4193.035601811601, 4200.537940826506, 4213.620774130343, 5847.8245652630485, 5908.409159084057, 5927.051671732502, 5935.376785437553, 5964.463198312173, 5964.671943043088, 6007.098935159761, 6023.186869772612, 6122.295935967331, 6129.695011270001, 5885.176075349455, 5927.703614819242, 6026.638401695912, 6031.396860314021, 6031.487323577458, 5103.668261562986, 5259.079661059376, 5319.1223448131395, 5347.518723314843, 5358.785648574013, 6368.586041907354, 6477.481801455872, 6512.153420055362, 6516.609003459807, 6535.542512024208, 6273.309935907047, 6285.842853928689, 6290.370962903856, 6291.370862913672, 6297.496200304056, 6184.8763024738355, 6355.7457701693265, 6418.326075761977, 6478.093066970534, 6504.642244676588, 6148.815535533941, 6152.876942461216, 6158.076288556752, 6164.506839452743, 6174.691265436621, 6209.844753881189, 6241.157443745036, 6246.812595622138, 6256.31180570146, 6261.279952805486, 5759.65442073477, 5884.0585506318785, 5958.76164953397, 5972.223610930551, 6070.969645151746, 5952.494038006818, 6007.429294217042, 6009.639421634716, 6011.368806275453, 6023.5783495156675, 5855.677937713466, 5856.648601083778, 5916.201312822714, 5916.911246331222, 5928.79249226275, 5875.911861321998, 5901.852453688521, 5963.194968679173, 6025.156478092983, 6048.969755151196, 5922.0, 5927.733252003756, 5932.317783454958, 5998.7300571473515, 6005.87988240224], "value": 5673.774338813558, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4165438697271, 648.1638686094938, 657.5627207906742, 666.4701562258005, 675.3145557259379, 45968.540314596845, 46881.0, 46936.53063469364, 47364.763176184155, 47414.2887856682, 48193.277100843516, 49128.75435622826, 49205.261921071215, 49224.0, 49283.75358123204, 8866.955665221665, 9088.091190880925, 9103.998560158378, 9130.589123489459, 9136.0, 8987.730368088967, 9100.499472529009, 9123.224525915306, 9148.085191480865, 9153.221976132038, 9147.0, 9151.67969121081, 9203.723888283363, 9213.03263157369, 9215.447073175597, 8994.415363001417, 9007.054259302777, 9018.594163262636, 9061.818763624691, 9071.410358326688, 8995.730128096167, 9035.728928132166, 9070.727878163665, 9089.63641454341, 9118.224950879183, 44690.0, 45065.0, 45153.0, 45294.773526132485, 45367.0, 4094.81900362393, 4177.811998460046, 4579.381783459257, 4601.723896566184, 4714.151452738506, 34964.47553286703, 35434.822825885705, 36008.81995590031, 36253.818730906176, 36608.0, 4531.68749658082, 4581.9541804582195, 4614.861554153381, 4615.423072115986, 4694.929576056362, 371070.0, 372236.13881930686, 372965.0, 373060.0, 373188.0, 38123.80938095347, 67879.0, 67884.6605766968, 68269.65865170742, 68657.0, 38937.0, 40903.590964090574, 41088.589114109076, 41150.588494115276, 41186.58813411887, 17177.828221717624, 17238.482845514405, 17382.65234695299, 17389.826101739072, 17480.737788933176, 14123.858761412459, 14148.717025659635, 14159.221242831743, 14195.858041419453, 14236.644083897985, 9274.30442716799, 9364.438133711863, 9371.859422108673, 9403.623855045722, 9449.102335278138, 3505.964940350615, 3588.69496092835, 3597.4671913389316, 3618.7466877318334, 3628.7822730636244, 1110.539126262608, 1137.8748337682848, 1141.4406940599213, 1200.033972652006, 1214.878512148778, 34411.82794086064, 34501.827490862386, 34886.82556587201, 34923.4761478578, 35020.47469287963, 1218.226426219357, 1224.4367590908282, 1264.5570816688955, 1289.2006955687534, 1347.5957212836306, 18085.36701215451, 18157.63684726298, 18162.273509059753, 18222.453326400228, 18263.17815698297, 568599.0, 585867.0, 589750.0, 595125.0, 600060.0, 56746.71626641841, 62414.68792656098, 62415.6879215601, 62654.686726566986, 62671.6866415665, 1487.4645127754, 1511.894167408271, 1517.9772303415457, 1519.3163076615567, 1524.9313780879886, 32965.34069318648, 33478.83260583682, 33670.32659346848, 34058.65941340555, 34251.828740857134, 54931.176032360345, 55347.44652553584, 55443.72278138583, 55604.0, 55637.721811390686, 412568.0, 413671.0, 416022.0, 419001.0, 421480.0, 30821.22946926345, 31059.534106988864, 31214.37571248517, 31408.842955785076, 31446.842765786023, 50583.241251381995, 51395.48604514057, 51428.48571514386, 52622.47377526176, 52903.47096528985, 42389.36415953701, 43267.78366108149, 43350.34974475322, 44326.0, 45046.549534505546, 42300.73097807071, 42512.574874252095, 43088.78455607702, 43155.0, 44330.55669443264, 42443.7877810609, 43554.56445435505, 43614.56385436105, 43631.78184109059, 43761.124777504905, 37390.439143413416, 37433.20834018083, 38224.617753823215, 38627.420588691755, 38662.613373865905, 29701.257468563457, 29711.25721856971, 30138.3972320548, 30274.09177724672, 30495.695043050175], "value": 20408.586345612446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.3903296352144, 432.75141381853945, 436.0820472904538, 437.06032031133043, 437.687053756564, 18132.0, 19650.90174549129, 20131.99340032998, 21163.57672846542, 21187.894060529678, 12613.306268155247, 13177.209367437936, 13217.537386191485, 13569.18584884905, 19993.300234491795, 5391.757370918308, 5459.808906688267, 5469.972650136744, 5564.4713752193475, 5574.303212098488, 5486.177073438977, 5502.58730595205, 5504.0, 5511.669299842002, 5531.032069387861, 5414.10667239905, 5483.698396588186, 5493.697846618435, 5523.6409633373905, 5585.966596179699, 5474.91787623186, 5513.0, 5520.558355331564, 5522.171674248854, 5532.889342213153, 5278.049951008817, 5364.0, 5367.1680889462195, 5377.569794416438, 5386.461353864622, 22929.31212063641, 23369.298921032398, 23812.761872381227, 23820.523589528286, 23938.28185154448, 2404.0624156578947, 2534.0750626021554, 2566.1916496303793, 2661.4810112028163, 2794.1198522465356, 11180.27328223671, 11202.94398528002, 11285.661430157108, 11359.659210223706, 14552.981291309612, 2031.7054027165977, 2070.3892351756267, 2122.6073176462405, 2129.318618042227, 2168.0785666092006, 48986.26520602194, 59466.0, 75755.0, 77161.22838771596, 86512.13487865104, 11392.430378481044, 11771.117166212569, 12094.697632559257, 12164.14850960442, 12203.572874949334, 16936.322547098225, 17010.82989170117, 17075.573110672085, 17108.57228569271, 17135.57161070983, 8666.436681615674, 8742.125787421333, 8807.955960220286, 8818.162274583905, 8914.73255802327, 8336.416450848383, 8388.0, 8479.236868681848, 8489.915100849035, 8509.0, 4927.704337739747, 4965.8013679452415, 5069.619778516626, 5131.127708289525, 5151.7681704323395, 2160.2223199648115, 2167.6531754919138, 2172.837037222215, 2195.637719776219, 2202.9449263768215, 1000.2548101664162, 1042.7393151712072, 1051.2273478993086, 1075.8009768192753, 1142.6800495861173, 18549.35077272289, 18948.81051189498, 19374.70937935932, 19491.22035118608, 19589.706154407697, 1031.7059638003284, 1072.324435605579, 1097.6213206443765, 1103.7406209540752, 1127.6786115956913, 10724.14206863449, 10814.513346899408, 10975.176861735243, 10982.231243812856, 11076.612318568972, 427596.0, 458523.0, 460052.0, 478602.0, 479306.0, 80018.79971800427, 90863.54568227117, 92662.0, 93015.53492232495, 95438.0, 1062.8512008318842, 1078.8867168947304, 1110.7945030169444, 1136.170595465315, 1142.817149256115, 17143.65712685764, 17394.73907891408, 17408.912955435142, 17580.64838703193, 17760.200790964696, 41388.70792076669, 41858.0, 42184.156316874105, 42885.1422971545, 43035.0, 55492.0, 56701.43298566961, 57814.42185578091, 58289.0, 58312.4168758307, 8600.913990860012, 8645.783855403664, 8812.0, 9049.954750226207, 9301.348905576544, 9659.951700241734, 12461.813072804096, 13264.80102798478, 13458.461661533429, 13554.0, 8066.959665201636, 11281.379524126252, 11374.545018199511, 11566.248193867372, 11989.76020479603, 6015.639061656315, 10062.943390943845, 11362.772744545227, 11536.423178841193, 11741.29552226835, 11760.35318057515, 11787.646370608896, 11829.112816538622, 11887.465064071965, 12026.15816892809, 8784.51685157297, 9087.909120908971, 9099.772505687146, 9146.588403521724, 9243.352965292364, 11569.19015668895, 11653.0, 11872.465739041936, 11887.762244754884, 11910.106741994558], "value": 9324.76314504659, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.8668163206128, 1606.0363781730962, 1834.834864862163, 1939.3503176435884, 1955.0713411129707, 8454.196851299132, 9052.90947090529, 9267.0, 9897.50512474376, 9898.802023959526, 9126.817463650723, 9410.435373877555, 9431.528423578811, 9447.574859131339, 9527.333086683935, 2560.3215147985798, 2584.2505673354704, 2596.3379338268714, 2605.596132599441, 2606.478704259146, 2522.495500899818, 2569.717331093578, 2574.8197626166175, 2580.458103798205, 2581.638570600108, 2570.0, 2601.765841074303, 2620.2532278300687, 2620.737926207383, 2621.0, 2490.4645501217233, 2494.463690306584, 2500.524900268943, 2527.317624241463, 2529.304441278663, 2219.700340454034, 2242.7757224277443, 2464.5933420985516, 2471.0486462711806, 2490.3649569359877, 9478.052194780466, 9525.19035881951, 9538.427694338361, 9548.570314335871, 9573.952130239373, 5692.573057020699, 5847.327557330919, 5849.473547380756, 5859.44335288147, 5863.677497737623, 3767.6420740029926, 3858.8649397271242, 3879.12719638082, 3890.455336252927, 3947.0921688011917, 1294.8964082873347, 1305.3538498443236, 1328.7940369242783, 1330.8336457942758, 1343.1605246720799, 13202.603921882359, 13317.067805253637, 13342.599722008355, 13346.466141354334, 13438.731225375437, 5161.2516185152945, 5178.197379406198, 5234.42421333653, 5280.20796880471, 5283.181106928432, 11185.0, 11203.99164075237, 11221.326720396803, 11229.494672739746, 11262.7184320391, 5641.548676105902, 5694.088945768657, 5720.0, 5754.108113242454, 5763.193152958589, 4687.835925742583, 5238.973805131026, 5372.758225879845, 5512.5589952803675, 5525.640833345819, 4476.552344765562, 4480.081583275421, 4483.30508771141, 4548.681592288508, 4606.286025666027, 1425.6578421178842, 1485.9331330090172, 1491.261825396414, 1493.357856121878, 1493.4399600149943, 970.335320305593, 975.7121649113528, 1092.8797832238447, 1113.3598181045932, 1123.1576317761678, 6604.933950660528, 6664.133662623828, 6750.257471678112, 6754.3245675433045, 6757.797266082025, 1013.4831236069657, 1018.9657497639902, 1084.1760262200785, 1099.8900109988938, 1107.2747350485445, 4573.131105090022, 4745.240761478147, 4751.168545504523, 4757.762111894392, 4769.76151192439, 12099.75800484003, 12175.0, 12407.131500795038, 12415.068869834799, 12457.875421245853, 12364.56724014655, 12474.002079833774, 12531.561395351302, 12542.686432839251, 12559.93720031394, 8964.641414343354, 9074.092590740873, 9153.725388238363, 9167.541622918827, 9303.209227215628, 6449.742010319723, 6488.805335839932, 6566.671666416564, 6670.7665231716655, 6721.495887808336, 11234.921539515215, 11399.08807295431, 11424.771504569695, 11443.485043173243, 11599.188056836278, 11335.149863760085, 11529.250598711056, 11693.356865372487, 11730.941345293219, 11774.882251177722, 7155.749548765768, 8063.072746634212, 8251.051129120227, 8891.555422228992, 9220.44677319363, 9102.863457048017, 9485.525723713648, 9500.809983800147, 9549.9045009549, 9572.32993690435, 8295.585220738818, 8532.914670853212, 8562.357823163164, 8620.913790862262, 8624.52565108925, 8184.263416292562, 8300.87548686758, 8323.292520135856, 8346.0, 8382.088600976864, 7797.7660670179985, 7896.723614673689, 7940.245676660708, 7954.443188976716, 7966.681332746625, 5553.305836770403, 5654.547636189177, 5779.104238842986, 5899.734511947058, 5932.584719069624, 5666.376698563237, 5671.262735844314, 5671.716414179357, 5683.318001839806, 5840.707964601838], "value": 5160.41180017686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.51337464484914, 368.99265006532164, 371.7434969870789, 372.3632588274052, 372.7986887080978, 5811.970940145298, 5812.709364531767, 5813.854653633662, 5822.446867547586, 5826.825195244144, 5510.834674959758, 5727.684977326246, 5746.310442746876, 5749.942500574993, 5800.274965629296, 4491.528389519102, 4532.79602417892, 4546.454425468948, 4550.156152404747, 4550.749708766017, 4498.865034048984, 4529.320601909707, 4535.954640453586, 4540.318952157187, 4544.5682660147395, 4420.646348292145, 4438.223310920592, 4503.864884053467, 4523.683342166049, 4529.524399938008, 4464.464264288306, 4473.105378924196, 4476.239039363316, 4482.39487669167, 4484.0, 3985.621365970228, 4013.6588389986887, 4013.7591744495426, 4019.2363450944517, 4031.6371526562457, 5447.700376479292, 5527.55779537636, 5586.608937374385, 5607.971960140214, 5636.774529018834, 5158.92261616076, 5168.405633352175, 5177.76700048495, 5183.663061901002, 5184.818531351422, 6009.6394216346725, 6034.487068599175, 6039.909401358983, 6082.996305609569, 6105.755769769204, 4279.1013887083745, 4410.823567057314, 4420.778961051935, 4456.19788438081, 4475.910481790378, 5930.169776231331, 6032.728527216286, 6246.344133865924, 6257.155284036642, 6265.363630913137, 4519.141363141059, 4519.615832654261, 4522.751248681354, 4524.34397012438, 4545.499995000548, 4558.247889098262, 4560.498345182027, 4579.748113853703, 4587.49981260214, 4597.42532183477, 4897.951020489821, 5126.948730512647, 5188.11801993662, 5198.506141916588, 5229.529342359206, 5953.8566116198135, 6030.457258846637, 6052.182955300978, 6068.544859135583, 6070.848228794227, 1532.9080255184724, 1541.5837723814732, 1553.2156261088078, 1558.2286768049887, 1578.2582186372388, 958.9952050239843, 984.960601575929, 992.4243938515643, 997.042838874674, 998.4308943902051, 5165.9483405165465, 5185.792568297301, 5206.167013277857, 5217.895642087137, 5239.240310155083, 5544.390117087117, 5555.666660000332, 5569.888602228014, 5578.442155784389, 5600.0, 4996.925046124311, 5207.776172599436, 5250.553702935294, 5288.36539615241, 5322.695939494849, 2941.1617688958545, 2950.3066779306846, 2979.61265035544, 2979.9851000744857, 2988.2678743707497, 5629.958457685341, 5754.338251101177, 5763.049096899049, 5780.5953583248765, 5788.565857560699, 5917.751254523339, 6300.653464059429, 6392.8492871283615, 6402.519811014099, 6425.871482570323, 6476.5466417350335, 6522.804315870531, 6536.346365363521, 6542.672866356758, 6553.377429144223, 6062.787802426894, 6221.471174949999, 6252.687365631791, 6287.1512345832725, 6309.400606942333, 6054.273487181566, 6102.786402475892, 6161.353057929032, 6182.526989204174, 6204.162438070803, 6506.512011599244, 6509.381608747161, 6514.348565143448, 6543.247526534509, 6559.573627714183, 4441.777911104367, 4505.0, 4518.6611004175475, 4526.207913615039, 4531.886702832324, 6219.0, 6281.497480201481, 6322.557420980487, 6327.557071004985, 6397.4562162216735, 6001.939980600138, 6104.175936248727, 6121.418465245794, 6165.5375846810775, 6172.98145805937, 5889.64662120257, 6123.387661233841, 6133.049377346519, 6168.845778855564, 6210.223722034746, 6007.909881351696, 6026.186464827192, 6071.39286071407, 6092.147099406176, 6102.809952059306, 6052.852516691384, 6087.847803804941, 6120.081987701702, 6131.509479241561, 6134.171886795226, 5760.481556659921, 5968.731407086779, 5970.537218381524, 5996.910046349221, 6005.609635373687], "value": 4572.092164577415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.0, 806.5200357344273, 823.2960818500183, 823.5964377455045, 856.1780690537084, 15156.166410847412, 15511.146886921215, 15965.92017039916, 16032.999999999985, 16071.437499687514, 15892.443764468246, 16013.599660008505, 16075.0, 16104.83895161048, 16212.189390530455, 863.4646519158131, 870.6778491957984, 878.319302540533, 881.0440671870996, 890.6749036601659, 889.8264838356523, 890.812929284851, 895.2569367425054, 895.5835536475538, 896.8834051573286, 915.1809130827905, 922.7739203895055, 925.6482536636069, 929.586334081334, 933.5705575435308, 923.1783712495817, 924.7965447601517, 927.0590350793949, 928.9349745517817, 929.9116583924516, 678.7217240931194, 682.6757290287123, 684.0423407229918, 687.2646268492715, 687.4431710314611, 15532.378704851792, 15537.14545699986, 15557.377704891791, 15568.299426525833, 15628.374865005386, 15750.527484175493, 15986.0, 16126.838731612652, 16155.273012714457, 16156.27296771648, 13065.216087034712, 13087.345632718327, 13145.539906103337, 13158.802617960739, 13197.802032969514, 4052.615001574846, 4088.7342322748927, 4103.173424426934, 4132.938005929914, 4169.207850508394, 78562.60718696428, 78585.21414785837, 79165.0, 79924.20075799225, 82128.0, 11501.482433290523, 11581.478833452515, 11777.764444711058, 12022.338771367484, 12162.635120946386, 22377.888110559343, 22552.66171007436, 22625.88687056554, 22627.66058509124, 22651.093956241897, 8783.34124940632, 8869.649060898699, 9044.095590440904, 9166.67916622915, 9245.167934885892, 5163.096458119814, 5230.08473517133, 5254.238135470336, 5319.095753721799, 5437.238786569884, 3779.9433008504893, 3855.5373355197557, 3871.438641397038, 3889.4943657324366, 3900.804959752001, 624.3693869192149, 624.3849807939176, 636.3477435628517, 639.398964972924, 643.8776632439822, 708.5252880570031, 740.5667684404576, 845.9830803383898, 849.1932663969254, 851.5614458553849, 10610.363378197178, 10973.451327433597, 11051.392173430539, 11292.096632269398, 11427.542898283975, 831.8887361268811, 837.7235512280932, 838.7609531283555, 840.8360369727844, 851.5359129274436, 4842.322074909515, 4860.441049279308, 4873.707577545359, 5224.582033437316, 5337.572994160458, 72051.63974180096, 112634.0, 116600.0, 118757.0, 119218.40390797991, 84395.15604843873, 99322.0, 100815.49592251991, 101049.0, 104541.0, 63188.0, 90371.0, 90882.0, 91156.54421727848, 91719.08280917238, 9576.856347154659, 9693.951530242304, 9725.4650994196, 9746.610135594497, 9933.801323973625, 53169.202461962326, 53560.46439535711, 53756.731216343665, 54892.45107549033, 55424.0, 73394.0, 77641.61179194068, 77948.61025694835, 79154.6042269785, 79380.60309698415, 12253.326067066397, 12380.62858114222, 12384.62846114618, 12408.875911240772, 12609.621711348675, 13965.650858728613, 14696.55910322692, 14844.257787110386, 15443.301236864161, 15885.523434296989, 14106.29468526549, 14259.215743134228, 15412.614684632974, 15528.611784705472, 15675.294611742727, 14974.625634359229, 15128.167950762814, 15349.539513814603, 15386.461473848361, 15996.20018999022, 12849.743005140032, 13389.397477113358, 13648.454061837416, 14443.638909026939, 14476.276186190438, 12167.634970950885, 12285.140040197459, 12507.124501284823, 12936.611901642966, 12955.157914735511, 12650.873491264969, 12712.491500339884, 13014.674633134247, 13167.934160329138, 13293.20240785556], "value": 8060.636088581514, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 110.0, 111.0, 110.0, 114.0, 111.0, 111.0, 111.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 151.0, 169.0, 129.0, 144.0, 156.0, 127.0, 177.0, 125.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 160.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 180.0, 75.0, 77.0, 76.0, 77.0, 163.0, 79.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 145.0, 87.0, 85.0, 84.0, 139.0, 85.0, 86.0, 148.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 62.0, 60.0, 59.0, 58.0, 60.0, 62.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 79.0, 77.0, 87.0, 79.0, 106.0, 77.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 138.0, 135.0, 122.0, 138.0, 121.0, 127.0, 122.0, 132.0, 140.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 154.0, 154.0, 161.0, 155.0, 155.0, 154.0, 152.0, 158.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 62.0, 61.0, 62.0, 60.0, 71.0, 62.0, 60.0, 60.0], "value": 62.8, "unit": "score"}]}]} 03:42:26 INFO - Return code: 0 03:42:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:42:26 ERROR - # TBPL SUCCESS # 03:42:26 INFO - Running post-action listener: _resource_record_post_action 03:42:26 INFO - ##### 03:42:26 INFO - ##### Finished run-tests step (success) 03:42:26 INFO - ##### 03:42:26 INFO - Running post-run listener: _resource_record_post_run 03:42:26 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 362033152; Read time: 4000; Write time: 759656 03:42:26 INFO - TinderboxPrint: CPU usage
13.4% 03:42:26 INFO - TinderboxPrint: I/O read bytes / time
7,913,472 / 4,000 03:42:26 INFO - TinderboxPrint: I/O write bytes / time
362,033,152 / 759,656 03:42:26 INFO - TinderboxPrint: CPU idle
8,247.8 (86.6%) 03:42:26 INFO - TinderboxPrint: CPU user
1,213.0 (12.7%) 03:42:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:42:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 2899968; Read time: 0; Write time: 3192 03:42:26 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 6152192; Write bytes: 352522240; Read time: 3696; Write time: 754116 03:42:27 INFO - Running post-run listener: _upload_blobber_files 03:42:27 INFO - Blob upload gear active. 03:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:27 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:42:27 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:42:27 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:42:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:31 INFO - (blobuploader) - INFO - Done attempting. 03:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:42:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:32 INFO - (blobuploader) - INFO - Done attempting. 03:42:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:42:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:42:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:33 INFO - (blobuploader) - INFO - Done attempting. 03:42:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:33 INFO - Return code: 0 03:42:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da773dd4216ca98276b8ce738bd7188979f211cefed99636d18400a890313a1109a5b34c08e04305c17de55318784f88b4cd5b4168b92528e9345f20473e272d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/decb2010e5c703a8fa33915013208ce06e365b0e7a383bc9070e2dd9998be3f0dc6d3b430b7f98bbb66661d5dbc83f5ab44939a618d3171dc891daeba9238891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/703d8e60278b843e626c625b7750010dffed9659d56813c1fbb9c038ded84d8b655e03e7e4ef1a2125f4e695454818104781587a8be5cd8f086ed33848e7cbde"} 03:42:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:33 INFO - Contents: 03:42:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da773dd4216ca98276b8ce738bd7188979f211cefed99636d18400a890313a1109a5b34c08e04305c17de55318784f88b4cd5b4168b92528e9345f20473e272d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/decb2010e5c703a8fa33915013208ce06e365b0e7a383bc9070e2dd9998be3f0dc6d3b430b7f98bbb66661d5dbc83f5ab44939a618d3171dc891daeba9238891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/703d8e60278b843e626c625b7750010dffed9659d56813c1fbb9c038ded84d8b655e03e7e4ef1a2125f4e695454818104781587a8be5cd8f086ed33848e7cbde"} 03:42:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:33 INFO - Copying logs to upload dir... 03:42:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.961153 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-14 03:42:33.154033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 03:42:33.157948) ========= 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=745a4373a2a16df560f216e000000264-1465892094.12891-370948961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da773dd4216ca98276b8ce738bd7188979f211cefed99636d18400a890313a1109a5b34c08e04305c17de55318784f88b4cd5b4168b92528e9345f20473e272d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/decb2010e5c703a8fa33915013208ce06e365b0e7a383bc9070e2dd9998be3f0dc6d3b430b7f98bbb66661d5dbc83f5ab44939a618d3171dc891daeba9238891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/703d8e60278b843e626c625b7750010dffed9659d56813c1fbb9c038ded84d8b655e03e7e4ef1a2125f4e695454818104781587a8be5cd8f086ed33848e7cbde"} build_url:https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/S6_KfU2qRGmTLayIqER-Jw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da773dd4216ca98276b8ce738bd7188979f211cefed99636d18400a890313a1109a5b34c08e04305c17de55318784f88b4cd5b4168b92528e9345f20473e272d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/decb2010e5c703a8fa33915013208ce06e365b0e7a383bc9070e2dd9998be3f0dc6d3b430b7f98bbb66661d5dbc83f5ab44939a618d3171dc891daeba9238891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/703d8e60278b843e626c625b7750010dffed9659d56813c1fbb9c038ded84d8b655e03e7e4ef1a2125f4e695454818104781587a8be5cd8f086ed33848e7cbde"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 03:42:33.183599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:42:33.183974) ========= 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=745a4373a2a16df560f216e000000264-1465892094.12891-370948961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 03:42:33.266714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 03:42:33.267068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 03:42:33.267418) ========= ========= Total master_lag: 0.20 =========